-- Logs begin at Thu 2025-12-25 14:54:35 CET, end at Thu 2025-12-25 14:55:23 CET. -- Dec 25 14:54:35 music kernel: Booting Linux on physical CPU 0x0000000000 [0x414fd0b1] Dec 25 14:54:35 music kernel: Linux version 6.6.62-v8+ (dom@buildbot) (aarch64-linux-gnu-gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #1816 SMP PREEMPT Mon Nov 18 15:35:52 GMT 2024 Dec 25 14:54:35 music kernel: KASLR enabled Dec 25 14:54:35 music kernel: random: crng init done Dec 25 14:54:35 music kernel: Machine model: Raspberry Pi 5 Model B Rev 1.0 Dec 25 14:54:35 music kernel: efi: UEFI not found. Dec 25 14:54:35 music kernel: Reserved memory: created CMA memory pool at 0x0000000001c00000, size 64 MiB Dec 25 14:54:35 music kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Dec 25 14:54:35 music kernel: OF: reserved mem: 0x0000000001c00000..0x0000000005bfffff (65536 KiB) map reusable linux,cma Dec 25 14:54:35 music kernel: OF: reserved mem: 0x0000000000000000..0x000000000007ffff (512 KiB) nomap non-reusable atf@0 Dec 25 14:54:35 music kernel: OF: reserved mem: 0x000000003fd16240..0x000000003fd16277 (0 KiB) nomap non-reusable nvram@0 Dec 25 14:54:35 music kernel: NUMA: No NUMA configuration found Dec 25 14:54:35 music kernel: Faking a node at [mem 0x0000000000000000-0x000000001fffffff] Dec 25 14:54:35 music kernel: Faking a node at [mem 0x0000000020000000-0x000000003fffffff] Dec 25 14:54:35 music kernel: Faking a node at [mem 0x0000000040000000-0x000000005fffffff] Dec 25 14:54:35 music kernel: Faking a node at [mem 0x0000000060000000-0x000000007fffffff] Dec 25 14:54:35 music kernel: Faking a node at [mem 0x0000000080000000-0x000000009fffffff] Dec 25 14:54:35 music kernel: Faking a node at [mem 0x00000000a0000000-0x00000000bfffffff] Dec 25 14:54:35 music kernel: Faking a node at [mem 0x00000000c0000000-0x00000000dfffffff] Dec 25 14:54:35 music kernel: Faking a node at [mem 0x00000000e0000000-0x00000000ffffffff] Dec 25 14:54:35 music kernel: NUMA: NODE_DATA [mem 0x1fffd3c0-0x1fffffff] Dec 25 14:54:35 music kernel: NUMA: NODE_DATA [mem 0x3f7fd3c0-0x3f7fffff] Dec 25 14:54:35 music kernel: NUMA: NODE_DATA [mem 0x5fffd3c0-0x5fffffff] Dec 25 14:54:35 music kernel: NUMA: NODE_DATA [mem 0x7fffd3c0-0x7fffffff] Dec 25 14:54:35 music kernel: NUMA: NODE_DATA [mem 0x9fffd3c0-0x9fffffff] Dec 25 14:54:35 music kernel: NUMA: NODE_DATA [mem 0xbfffd3c0-0xbfffffff] Dec 25 14:54:35 music kernel: NUMA: NODE_DATA [mem 0xdfffd3c0-0xdfffffff] Dec 25 14:54:35 music kernel: NUMA: NODE_DATA [mem 0xff79b3c0-0xff79dfff] Dec 25 14:54:35 music kernel: Zone ranges: Dec 25 14:54:35 music kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Dec 25 14:54:35 music kernel: DMA32 empty Dec 25 14:54:35 music kernel: Normal empty Dec 25 14:54:35 music kernel: Movable zone start for each node Dec 25 14:54:35 music kernel: Early memory node ranges Dec 25 14:54:35 music kernel: node 0: [mem 0x0000000000000000-0x000000000007ffff] Dec 25 14:54:35 music kernel: node 0: [mem 0x0000000000080000-0x000000001fffffff] Dec 25 14:54:35 music kernel: node 1: [mem 0x0000000020000000-0x000000003f7fffff] Dec 25 14:54:35 music kernel: node 2: [mem 0x0000000040000000-0x000000005fffffff] Dec 25 14:54:35 music kernel: node 3: [mem 0x0000000060000000-0x000000007fffffff] Dec 25 14:54:35 music kernel: node 4: [mem 0x0000000080000000-0x000000009fffffff] Dec 25 14:54:35 music kernel: node 5: [mem 0x00000000a0000000-0x00000000bfffffff] Dec 25 14:54:35 music kernel: node 6: [mem 0x00000000c0000000-0x00000000dfffffff] Dec 25 14:54:35 music kernel: node 7: [mem 0x00000000e0000000-0x00000000ffffffff] Dec 25 14:54:35 music kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000001fffffff] Dec 25 14:54:35 music kernel: Initmem setup node 1 [mem 0x0000000020000000-0x000000003f7fffff] Dec 25 14:54:35 music kernel: Initmem setup node 2 [mem 0x0000000040000000-0x000000005fffffff] Dec 25 14:54:35 music kernel: Initmem setup node 3 [mem 0x0000000060000000-0x000000007fffffff] Dec 25 14:54:35 music kernel: Initmem setup node 4 [mem 0x0000000080000000-0x000000009fffffff] Dec 25 14:54:35 music kernel: Initmem setup node 5 [mem 0x00000000a0000000-0x00000000bfffffff] Dec 25 14:54:35 music kernel: Initmem setup node 6 [mem 0x00000000c0000000-0x00000000dfffffff] Dec 25 14:54:35 music kernel: Initmem setup node 7 [mem 0x00000000e0000000-0x00000000ffffffff] Dec 25 14:54:35 music kernel: On node 2, zone DMA: 2048 pages in unavailable ranges Dec 25 14:54:35 music kernel: psci: probing for conduit method from DT. Dec 25 14:54:35 music kernel: psci: PSCIv1.1 detected in firmware. Dec 25 14:54:35 music kernel: psci: Using standard PSCI v0.2 function IDs Dec 25 14:54:35 music kernel: psci: MIGRATE_INFO_TYPE not supported. Dec 25 14:54:35 music kernel: psci: SMC Calling Convention v1.2 Dec 25 14:54:35 music kernel: percpu: Embedded 30 pages/cpu s85928 r8192 d28760 u122880 Dec 25 14:54:35 music kernel: pcpu-alloc: s85928 r8192 d28760 u122880 alloc=30*4096 Dec 25 14:54:35 music kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 25 14:54:35 music kernel: Detected PIPT I-cache on CPU0 Dec 25 14:54:35 music kernel: CPU features: detected: Virtualization Host Extensions Dec 25 14:54:35 music kernel: CPU features: detected: Hardware dirty bit management Dec 25 14:54:35 music kernel: CPU features: detected: Spectre-v4 Dec 25 14:54:35 music kernel: CPU features: detected: Spectre-BHB Dec 25 14:54:35 music kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 25 14:54:35 music kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 25 14:54:35 music kernel: CPU features: detected: SSBS not fully self-synchronizing Dec 25 14:54:35 music kernel: alternatives: applying boot alternatives Dec 25 14:54:35 music kernel: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe cgroup_disable=memory numa_policy=interleave numa=fake=8 system_heap.max_order=0 smsc95xx.macaddr=2C:CF:67:23:67:D9 vc_mem.mem_base=0x3fc00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyAMA10,115200 console=tty1 imgpart=UUID=ea4305a4-d90d-47fc-afb2-715854f091ba imgfile=/volumio_current.sqsh bootpart=UUID=ABA1-7067 datapart=UUID=f7b616b7-de12-485f-aa0b-647e37a9b4ff uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Dec 25 14:54:35 music kernel: cgroup: Disabling memory control group subsystem Dec 25 14:54:35 music kernel: mempolicy: NUMA default policy overridden to 'interleave:0-7' Dec 25 14:54:35 music kernel: PCIe ASPM is disabled Dec 25 14:54:35 music kernel: Unknown kernel command line parameters "splash nodebug imgpart=UUID=ea4305a4-d90d-47fc-afb2-715854f091ba imgfile=/volumio_current.sqsh bootpart=UUID=ABA1-7067 datapart=UUID=f7b616b7-de12-485f-aa0b-647e37a9b4ff uuidconfig=cmdline.txt bootdelay=7 use_kmsg=no", will be passed to user space. Dec 25 14:54:35 music kernel: Fallback order for Node 0: 0 1 2 3 4 5 6 7 Dec 25 14:54:35 music kernel: Fallback order for Node 1: 1 2 3 4 5 6 7 0 Dec 25 14:54:35 music kernel: Fallback order for Node 2: 2 3 4 5 6 7 0 1 Dec 25 14:54:35 music kernel: Fallback order for Node 3: 3 4 5 6 7 0 1 2 Dec 25 14:54:35 music kernel: Fallback order for Node 4: 4 5 6 7 0 1 2 3 Dec 25 14:54:35 music kernel: Fallback order for Node 5: 5 6 7 0 1 2 3 4 Dec 25 14:54:35 music kernel: Fallback order for Node 6: 6 7 0 1 2 3 4 5 Dec 25 14:54:35 music kernel: Fallback order for Node 7: 7 0 1 2 3 4 5 6 Dec 25 14:54:35 music kernel: Built 8 zonelists, mobility grouping on. Total pages: 1030176 Dec 25 14:54:35 music kernel: Policy zone: DMA Dec 25 14:54:35 music kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 25 14:54:35 music kernel: Memory: 3991100K/4186112K available (13440K kernel code, 2208K rwdata, 4284K rodata, 4864K init, 1086K bss, 129476K reserved, 65536K cma-reserved) Dec 25 14:54:35 music kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=8 Dec 25 14:54:35 music kernel: ftrace: allocating 43555 entries in 171 pages Dec 25 14:54:35 music kernel: ftrace: allocated 171 pages with 5 groups Dec 25 14:54:35 music kernel: trace event string verifier disabled Dec 25 14:54:35 music kernel: rcu: Preemptible hierarchical RCU implementation. Dec 25 14:54:35 music kernel: rcu: RCU event tracing is enabled. Dec 25 14:54:35 music kernel: rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. Dec 25 14:54:35 music kernel: Trampoline variant of Tasks RCU enabled. Dec 25 14:54:35 music kernel: Rude variant of Tasks RCU enabled. Dec 25 14:54:35 music kernel: Tracing variant of Tasks RCU enabled. Dec 25 14:54:35 music kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Dec 25 14:54:35 music kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 25 14:54:35 music kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 25 14:54:35 music kernel: Root IRQ handler: gic_handle_irq Dec 25 14:54:35 music kernel: GIC: Using split EOI/Deactivate mode Dec 25 14:54:35 music kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Dec 25 14:54:35 music kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Dec 25 14:54:35 music kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Dec 25 14:54:35 music kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Dec 25 14:54:35 music kernel: Console: colour dummy device 80x25 Dec 25 14:54:35 music kernel: printk: console [tty1] enabled Dec 25 14:54:35 music kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000) Dec 25 14:54:35 music kernel: pid_max: default: 32768 minimum: 301 Dec 25 14:54:35 music kernel: LSM: initializing lsm=capability,integrity Dec 25 14:54:35 music kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) Dec 25 14:54:35 music kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, vmalloc) Dec 25 14:54:35 music kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, vmalloc) Dec 25 14:54:35 music kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, vmalloc) Dec 25 14:54:35 music kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 25 14:54:35 music kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 25 14:54:35 music kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 25 14:54:35 music kernel: rcu: Hierarchical SRCU implementation. Dec 25 14:54:35 music kernel: rcu: Max phase no-delay instances is 1000. Dec 25 14:54:35 music kernel: EFI services will not be available. Dec 25 14:54:35 music kernel: smp: Bringing up secondary CPUs ... Dec 25 14:54:35 music kernel: Detected PIPT I-cache on CPU1 Dec 25 14:54:35 music kernel: CPU1: Booted secondary processor 0x0000000100 [0x414fd0b1] Dec 25 14:54:35 music kernel: Detected PIPT I-cache on CPU2 Dec 25 14:54:35 music kernel: CPU2: Booted secondary processor 0x0000000200 [0x414fd0b1] Dec 25 14:54:35 music kernel: Detected PIPT I-cache on CPU3 Dec 25 14:54:35 music kernel: CPU3: Booted secondary processor 0x0000000300 [0x414fd0b1] Dec 25 14:54:35 music kernel: smp: Brought up 8 nodes, 4 CPUs Dec 25 14:54:35 music kernel: SMP: Total of 4 processors activated. Dec 25 14:54:35 music kernel: CPU features: detected: 32-bit EL0 Support Dec 25 14:54:35 music kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 25 14:54:35 music kernel: CPU features: detected: Common not Private translations Dec 25 14:54:35 music kernel: CPU features: detected: CRC32 instructions Dec 25 14:54:35 music kernel: CPU features: detected: RCpc load-acquire (LDAPR) Dec 25 14:54:35 music kernel: CPU features: detected: LSE atomic instructions Dec 25 14:54:35 music kernel: CPU features: detected: Privileged Access Never Dec 25 14:54:35 music kernel: CPU features: detected: RAS Extension Support Dec 25 14:54:35 music kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 25 14:54:35 music kernel: CPU: All CPU(s) started at EL2 Dec 25 14:54:35 music kernel: alternatives: applying system-wide alternatives Dec 25 14:54:35 music kernel: devtmpfs: initialized Dec 25 14:54:35 music kernel: Enabled cp15_barrier support Dec 25 14:54:35 music kernel: Enabled setend support Dec 25 14:54:35 music kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Dec 25 14:54:35 music kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) Dec 25 14:54:35 music kernel: pinctrl core: initialized pinctrl subsystem Dec 25 14:54:35 music kernel: DMI not present or invalid. Dec 25 14:54:35 music kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 25 14:54:35 music kernel: DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations Dec 25 14:54:35 music kernel: DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 25 14:54:35 music kernel: DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 25 14:54:35 music kernel: audit: initializing netlink subsys (disabled) Dec 25 14:54:35 music kernel: audit: type=2000 audit(0.004:1): state=initialized audit_enabled=0 res=1 Dec 25 14:54:35 music kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 25 14:54:35 music kernel: cpuidle: using governor menu Dec 25 14:54:35 music kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 25 14:54:35 music kernel: ASID allocator initialised with 32768 entries Dec 25 14:54:35 music kernel: Serial: AMBA PL011 UART driver Dec 25 14:54:35 music kernel: bcm2835-mbox 107c013880.mailbox: mailbox enabled Dec 25 14:54:35 music kernel: 107d001000.serial: ttyAMA10 at MMIO 0x107d001000 (irq = 15, base_baud = 0) is a PL011 rev2 Dec 25 14:54:35 music kernel: printk: console [ttyAMA10] enabled Dec 25 14:54:35 music kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2025-01-22T00:16:51, variant start_cd Dec 25 14:54:35 music kernel: raspberrypi-firmware soc:firmware: Firmware hash is a775306300000000000000000000000000000000 Dec 25 14:54:35 music kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Dec 25 14:54:35 music kernel: Modules: 0 pages in range for non-PLT usage Dec 25 14:54:35 music kernel: Modules: 517776 pages in range for PLT usage Dec 25 14:54:35 music kernel: bcm2835-dma 1000010000.dma: DMA legacy API manager, dmachans=0x1 Dec 25 14:54:35 music kernel: iommu: Default domain type: Translated Dec 25 14:54:35 music kernel: iommu: DMA domain TLB invalidation policy: strict mode Dec 25 14:54:35 music kernel: SCSI subsystem initialized Dec 25 14:54:35 music kernel: usbcore: registered new interface driver usbfs Dec 25 14:54:35 music kernel: usbcore: registered new interface driver hub Dec 25 14:54:35 music kernel: usbcore: registered new device driver usb Dec 25 14:54:35 music kernel: pps_core: LinuxPPS API ver. 1 registered Dec 25 14:54:35 music kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Dec 25 14:54:35 music kernel: PTP clock support registered Dec 25 14:54:35 music kernel: vgaarb: loaded Dec 25 14:54:35 music kernel: clocksource: Switched to clocksource arch_sys_counter Dec 25 14:54:35 music kernel: VFS: Disk quotas dquot_6.6.0 Dec 25 14:54:35 music kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 25 14:54:35 music kernel: FS-Cache: Loaded Dec 25 14:54:35 music kernel: CacheFiles: Loaded Dec 25 14:54:35 music kernel: NET: Registered PF_INET protocol family Dec 25 14:54:35 music kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) Dec 25 14:54:35 music kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, vmalloc) Dec 25 14:54:35 music kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, vmalloc) Dec 25 14:54:35 music kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, vmalloc) Dec 25 14:54:35 music kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, vmalloc) Dec 25 14:54:35 music kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 25 14:54:35 music kernel: MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, vmalloc) Dec 25 14:54:35 music kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, vmalloc) Dec 25 14:54:35 music kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, vmalloc) Dec 25 14:54:35 music kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 25 14:54:35 music kernel: RPC: Registered named UNIX socket transport module. Dec 25 14:54:35 music kernel: RPC: Registered udp transport module. Dec 25 14:54:35 music kernel: RPC: Registered tcp transport module. Dec 25 14:54:35 music kernel: RPC: Registered tcp-with-tls transport module. Dec 25 14:54:35 music kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Dec 25 14:54:35 music kernel: PCI: CLS 0 bytes, default 64 Dec 25 14:54:35 music kernel: kvm [1]: IPA Size Limit: 40 bits Dec 25 14:54:35 music kernel: kvm [1]: vgic interrupt IRQ9 Dec 25 14:54:35 music kernel: kvm [1]: VHE mode initialized successfully Dec 25 14:54:35 music kernel: Trying to unpack rootfs image as initramfs... Dec 25 14:54:35 music kernel: Initialise system trusted keyrings Dec 25 14:54:35 music kernel: workingset: timestamp_bits=42 max_order=20 bucket_order=0 Dec 25 14:54:35 music kernel: zbud: loaded Dec 25 14:54:35 music kernel: NFS: Registering the id_resolver key type Dec 25 14:54:35 music kernel: Key type id_resolver registered Dec 25 14:54:35 music kernel: Key type id_legacy registered Dec 25 14:54:35 music kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Dec 25 14:54:35 music kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Dec 25 14:54:35 music kernel: Key type asymmetric registered Dec 25 14:54:35 music kernel: Asymmetric key parser 'x509' registered Dec 25 14:54:35 music kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Dec 25 14:54:35 music kernel: io scheduler mq-deadline registered Dec 25 14:54:35 music kernel: io scheduler kyber registered Dec 25 14:54:35 music kernel: io scheduler bfq registered Dec 25 14:54:35 music kernel: irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7c502000, parent irq: 26) Dec 25 14:54:35 music kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d503000, parent irq: 27) Dec 25 14:54:35 music kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d508380, parent irq: 28) Dec 25 14:54:35 music kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d508400, parent irq: 29) Dec 25 14:54:35 music kernel: irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7d510600, parent irq: 30) Dec 25 14:54:35 music kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d517b00, parent irq: 31) Dec 25 14:54:35 music kernel: simple-framebuffer 3f800000.framebuffer: framebuffer at 0x3f800000, 0x3f4800 bytes Dec 25 14:54:35 music kernel: simple-framebuffer 3f800000.framebuffer: format=r5g6b5, mode=1920x1080x16, linelength=3840 Dec 25 14:54:35 music kernel: Console: switching to colour frame buffer device 240x67 Dec 25 14:54:35 music kernel: simple-framebuffer 3f800000.framebuffer: fb0: simplefb registered! Dec 25 14:54:35 music kernel: Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled Dec 25 14:54:35 music kernel: 107d50c000.serial: ttyS0 at MMIO 0x107d50c000 (irq = 33, base_baud = 6000000) is a Broadcom BCM7271 UART Dec 25 14:54:35 music kernel: serial serial0: tty port ttyS0 registered Dec 25 14:54:35 music kernel: iproc-rng200 107d208000.rng: hwrng registered Dec 25 14:54:35 music kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3fc00000 mem_size:0x40000000(1024 MiB) Dec 25 14:54:35 music kernel: bcm2712-iommu-cache 1000005b00.iommuc: bcm2712_iommu_cache_probe Dec 25 14:54:35 music kernel: brd: module loaded Dec 25 14:54:35 music kernel: loop: module loaded Dec 25 14:54:35 music kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Dec 25 14:54:35 music kernel: Loading iSCSI transport class v2.0-870. Dec 25 14:54:35 music kernel: usbcore: registered new device driver r8152-cfgselector Dec 25 14:54:35 music kernel: usbcore: registered new interface driver r8152 Dec 25 14:54:35 music kernel: usbcore: registered new interface driver lan78xx Dec 25 14:54:35 music kernel: usbcore: registered new interface driver smsc95xx Dec 25 14:54:35 music kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Dec 25 14:54:35 music kernel: dwc_otg: FIQ enabled Dec 25 14:54:35 music kernel: dwc_otg: NAK holdoff enabled Dec 25 14:54:35 music kernel: dwc_otg: FIQ split-transaction FSM enabled Dec 25 14:54:35 music kernel: Module dwc_common_port init Dec 25 14:54:35 music kernel: usbcore: registered new interface driver uas Dec 25 14:54:35 music kernel: usbcore: registered new interface driver usb-storage Dec 25 14:54:35 music kernel: mousedev: PS/2 mouse device common for all mice Dec 25 14:54:35 music kernel: rpi-rtc soc:rpi_rtc: registered as rtc0 Dec 25 14:54:35 music kernel: rpi-rtc soc:rpi_rtc: setting system clock to 2025-12-25T13:54:24 UTC (1766670864) Dec 25 14:54:35 music kernel: bcm2835-wdt bcm2835-wdt: Poweroff handler already present! Dec 25 14:54:35 music kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Dec 25 14:54:35 music kernel: sdhci: Secure Digital Host Controller Interface driver Dec 25 14:54:35 music kernel: sdhci: Copyright(c) Pierre Ossman Dec 25 14:54:35 music kernel: sdhci-pltfm: SDHCI platform and OF driver helper Dec 25 14:54:35 music kernel: ledtrig-cpu: registered to indicate activity on CPUs Dec 25 14:54:35 music kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Dec 25 14:54:35 music kernel: hid: raw HID events driver (C) Jiri Kosina Dec 25 14:54:35 music kernel: usbcore: registered new interface driver usbhid Dec 25 14:54:35 music kernel: usbhid: USB HID core driver Dec 25 14:54:35 music kernel: hw perfevents: enabled with armv8_cortex_a76 PMU driver, 7 counters available Dec 25 14:54:35 music kernel: NET: Registered PF_PACKET protocol family Dec 25 14:54:35 music kernel: Key type dns_resolver registered Dec 25 14:54:35 music kernel: registered taskstats version 1 Dec 25 14:54:35 music kernel: Loading compiled-in X.509 certificates Dec 25 14:54:35 music kernel: Key type .fscrypt registered Dec 25 14:54:35 music kernel: Key type fscrypt-provisioning registered Dec 25 14:54:35 music kernel: brcm-pcie 1000110000.pcie: host bridge /axi/pcie@110000 ranges: Dec 25 14:54:35 music kernel: brcm-pcie 1000110000.pcie: No bus range found for /axi/pcie@110000, using [bus 00-ff] Dec 25 14:54:35 music kernel: brcm-pcie 1000110000.pcie: MEM 0x1b80000000..0x1bffffffff -> 0x0080000000 Dec 25 14:54:35 music kernel: brcm-pcie 1000110000.pcie: MEM 0x1800000000..0x1b7fffffff -> 0x0400000000 Dec 25 14:54:35 music kernel: brcm-pcie 1000110000.pcie: IB MEM 0x0000000000..0x0fffffffff -> 0x1000000000 Dec 25 14:54:35 music kernel: brcm-pcie 1000110000.pcie: Forcing gen 2 Dec 25 14:54:35 music kernel: brcm-pcie 1000110000.pcie: PCI host bridge to bus 0000:00 Dec 25 14:54:35 music kernel: pci_bus 0000:00: Unknown NUMA node; performance will be reduced Dec 25 14:54:35 music kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 25 14:54:35 music kernel: pci_bus 0000:00: root bus resource [mem 0x1b80000000-0x1bffffffff] (bus address [0x80000000-0xffffffff]) Dec 25 14:54:35 music kernel: pci_bus 0000:00: root bus resource [mem 0x1800000000-0x1b7fffffff pref] (bus address [0x400000000-0x77fffffff]) Dec 25 14:54:35 music kernel: pci 0000:00:00.0: [14e4:2712] type 01 class 0x060400 Dec 25 14:54:35 music kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Dec 25 14:54:35 music kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Dec 25 14:54:35 music kernel: Freeing initrd memory: 28128K Dec 25 14:54:35 music kernel: brcm-pcie 1000110000.pcie: link down Dec 25 14:54:35 music kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 Dec 25 14:54:35 music kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Dec 25 14:54:35 music kernel: pci 0000:00:00.0: Max Payload Size set to 512/ 512 (was 128), Max Read Rq 512 Dec 25 14:54:35 music kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 38 Dec 25 14:54:35 music kernel: pcieport 0000:00:00.0: AER: enabled with IRQ 38 Dec 25 14:54:35 music kernel: pci_bus 0000:01: busn_res: [bus 01] is released Dec 25 14:54:35 music kernel: pci_bus 0000:00: busn_res: [bus 00-ff] is released Dec 25 14:54:35 music kernel: brcm-pcie 1000120000.pcie: host bridge /axi/pcie@120000 ranges: Dec 25 14:54:35 music kernel: brcm-pcie 1000120000.pcie: No bus range found for /axi/pcie@120000, using [bus 00-ff] Dec 25 14:54:35 music kernel: brcm-pcie 1000120000.pcie: MEM 0x1f00000000..0x1ffffffffb -> 0x0000000000 Dec 25 14:54:35 music kernel: brcm-pcie 1000120000.pcie: MEM 0x1c00000000..0x1effffffff -> 0x0400000000 Dec 25 14:54:35 music kernel: brcm-pcie 1000120000.pcie: IB MEM 0x1f00000000..0x1f003fffff -> 0x0000000000 Dec 25 14:54:35 music kernel: brcm-pcie 1000120000.pcie: IB MEM 0x0000000000..0x0fffffffff -> 0x1000000000 Dec 25 14:54:35 music kernel: brcm-pcie 1000120000.pcie: Forcing gen 2 Dec 25 14:54:35 music kernel: brcm-pcie 1000120000.pcie: PCI host bridge to bus 0000:00 Dec 25 14:54:35 music kernel: pci_bus 0000:00: Unknown NUMA node; performance will be reduced Dec 25 14:54:35 music kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 25 14:54:35 music kernel: pci_bus 0000:00: root bus resource [mem 0x1f00000000-0x1ffffffffb] (bus address [0x00000000-0xfffffffb]) Dec 25 14:54:35 music kernel: pci_bus 0000:00: root bus resource [mem 0x1c00000000-0x1effffffff pref] (bus address [0x400000000-0x6ffffffff]) Dec 25 14:54:35 music kernel: pci 0000:00:00.0: [14e4:2712] type 01 class 0x060400 Dec 25 14:54:35 music kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Dec 25 14:54:35 music kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Dec 25 14:54:35 music kernel: brcm-pcie 1000120000.pcie: link up, 5.0 GT/s PCIe x4 (!SSC) Dec 25 14:54:35 music kernel: pci 0000:01:00.0: [1de4:0001] type 00 class 0x020000 Dec 25 14:54:35 music kernel: pci 0000:01:00.0: reg 0x10: [mem 0xffffc000-0xffffffff] Dec 25 14:54:35 music kernel: pci 0000:01:00.0: reg 0x14: [mem 0xffc00000-0xffffffff] Dec 25 14:54:35 music kernel: pci 0000:01:00.0: reg 0x18: [mem 0xffff0000-0xffffffff] Dec 25 14:54:35 music kernel: pci 0000:01:00.0: supports D1 Dec 25 14:54:35 music kernel: pci 0000:01:00.0: PME# supported from D0 D1 D3hot D3cold Dec 25 14:54:35 music kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 Dec 25 14:54:35 music kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x1f00000000-0x1f005fffff] Dec 25 14:54:35 music kernel: pci 0000:01:00.0: BAR 1: assigned [mem 0x1f00000000-0x1f003fffff] Dec 25 14:54:35 music kernel: pci 0000:01:00.0: BAR 2: assigned [mem 0x1f00400000-0x1f0040ffff] Dec 25 14:54:35 music kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x1f00410000-0x1f00413fff] Dec 25 14:54:35 music kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Dec 25 14:54:35 music kernel: pci 0000:00:00.0: bridge window [mem 0x1f00000000-0x1f005fffff] Dec 25 14:54:35 music kernel: pci 0000:00:00.0: Max Payload Size set to 256/ 512 (was 128), Max Read Rq 512 Dec 25 14:54:35 music kernel: pci 0000:01:00.0: Max Payload Size set to 256/ 256 (was 128), Max Read Rq 512 Dec 25 14:54:35 music kernel: pcieport 0000:00:00.0: enabling device (0000 -> 0002) Dec 25 14:54:35 music kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 39 Dec 25 14:54:35 music kernel: pcieport 0000:00:00.0: AER: enabled with IRQ 39 Dec 25 14:54:35 music kernel: rp1 0000:01:00.0: bar0 len 0x4000, start 0x1f00410000, end 0x1f00413fff, flags, 0x40200 Dec 25 14:54:35 music kernel: rp1 0000:01:00.0: bar1 len 0x400000, start 0x1f00000000, end 0x1f003fffff, flags, 0x40200 Dec 25 14:54:35 music kernel: rp1 0000:01:00.0: enabling device (0000 -> 0002) Dec 25 14:54:35 music kernel: rp1 0000:01:00.0: chip_id 0x20001927 Dec 25 14:54:35 music kernel: genirq: irq_chip rp1_irq_chip did not update eff. affinity mask of irq 101 Dec 25 14:54:35 music kernel: macb 1f00100000.ethernet eth0: Cadence GEM rev 0x00070109 at 0x1f00100000 irq 107 (2c:cf:67:23:67:d9) Dec 25 14:54:35 music kernel: dw_axi_dmac_platform 1f00188000.dma: DesignWare AXI DMA Controller, 8 channels Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.0: xHCI Host Controller Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.0: new USB bus registered, assigned bus number 1 Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.0: hcc params 0x0240fe6d hci version 0x110 quirks 0x0000008000000810 Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.0: irq 132, io mem 0x1f00200000 Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.0: xHCI Host Controller Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.0: new USB bus registered, assigned bus number 2 Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.0: Host supports USB 3.0 SuperSpeed Dec 25 14:54:35 music kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Dec 25 14:54:35 music kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 25 14:54:35 music kernel: usb usb1: Product: xHCI Host Controller Dec 25 14:54:35 music kernel: usb usb1: Manufacturer: Linux 6.6.62-v8+ xhci-hcd Dec 25 14:54:35 music kernel: usb usb1: SerialNumber: xhci-hcd.0 Dec 25 14:54:35 music kernel: hub 1-0:1.0: USB hub found Dec 25 14:54:35 music kernel: hub 1-0:1.0: 2 ports detected Dec 25 14:54:35 music kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Dec 25 14:54:35 music kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 25 14:54:35 music kernel: usb usb2: Product: xHCI Host Controller Dec 25 14:54:35 music kernel: usb usb2: Manufacturer: Linux 6.6.62-v8+ xhci-hcd Dec 25 14:54:35 music kernel: usb usb2: SerialNumber: xhci-hcd.0 Dec 25 14:54:35 music kernel: hub 2-0:1.0: USB hub found Dec 25 14:54:35 music kernel: hub 2-0:1.0: 1 port detected Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.1: xHCI Host Controller Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.1: new USB bus registered, assigned bus number 3 Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.1: hcc params 0x0240fe6d hci version 0x110 quirks 0x0000008000000810 Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.1: irq 137, io mem 0x1f00300000 Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.1: xHCI Host Controller Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.1: new USB bus registered, assigned bus number 4 Dec 25 14:54:35 music kernel: xhci-hcd xhci-hcd.1: Host supports USB 3.0 SuperSpeed Dec 25 14:54:35 music kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Dec 25 14:54:35 music kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 25 14:54:35 music kernel: usb usb3: Product: xHCI Host Controller Dec 25 14:54:35 music kernel: usb usb3: Manufacturer: Linux 6.6.62-v8+ xhci-hcd Dec 25 14:54:35 music kernel: usb usb3: SerialNumber: xhci-hcd.1 Dec 25 14:54:35 music kernel: hub 3-0:1.0: USB hub found Dec 25 14:54:35 music kernel: hub 3-0:1.0: 2 ports detected Dec 25 14:54:35 music kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Dec 25 14:54:35 music kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 25 14:54:35 music kernel: usb usb4: Product: xHCI Host Controller Dec 25 14:54:35 music kernel: usb usb4: Manufacturer: Linux 6.6.62-v8+ xhci-hcd Dec 25 14:54:35 music kernel: usb usb4: SerialNumber: xhci-hcd.1 Dec 25 14:54:35 music kernel: hub 4-0:1.0: USB hub found Dec 25 14:54:35 music kernel: hub 4-0:1.0: 1 port detected Dec 25 14:54:35 music kernel: bcm2712-iommu 1000005100.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Dec 25 14:54:35 music kernel: platform 1000800000.codec: bcm2712_iommu_probe_device: MMU 1000005100.iommu Dec 25 14:54:35 music kernel: platform 1000800000.codec: bcm2712_iommu_device_group: MMU 1000005100.iommu Dec 25 14:54:35 music kernel: platform 1000800000.codec: Adding to iommu group 0 Dec 25 14:54:35 music kernel: platform 1000880000.pisp_be: bcm2712_iommu_probe_device: MMU 1000005100.iommu Dec 25 14:54:35 music kernel: platform 1000880000.pisp_be: bcm2712_iommu_device_group: MMU 1000005100.iommu Dec 25 14:54:35 music kernel: platform 1000880000.pisp_be: Adding to iommu group 0 Dec 25 14:54:35 music kernel: platform 1000800000.codec: bcm2712_iommu_attach_dev: MMU 1000005100.iommu Dec 25 14:54:35 music kernel: platform 1000880000.pisp_be: bcm2712_iommu_attach_dev: MMU 1000005100.iommu Dec 25 14:54:35 music kernel: bcm2712-iommu 1000005100.iommu: bcm2712_iommu_probe: Success Dec 25 14:54:35 music kernel: bcm2712-iommu 1000005200.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Dec 25 14:54:35 music kernel: platform axi:gpu: bcm2712_iommu_probe_device: MMU 1000005200.iommu Dec 25 14:54:35 music kernel: platform axi:gpu: bcm2712_iommu_device_group: MMU 1000005200.iommu Dec 25 14:54:35 music kernel: platform axi:gpu: Adding to iommu group 1 Dec 25 14:54:35 music kernel: platform axi:gpu: bcm2712_iommu_attach_dev: MMU 1000005200.iommu Dec 25 14:54:35 music kernel: bcm2712-iommu 1000005200.iommu: bcm2712_iommu_probe: Success Dec 25 14:54:35 music kernel: bcm2712-iommu 1000005280.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Dec 25 14:54:35 music kernel: bcm2712-iommu 1000005280.iommu: bcm2712_iommu_probe: Success Dec 25 14:54:35 music kernel: sdhci-brcmstb 1000fff000.mmc: Got CD GPIO Dec 25 14:54:35 music kernel: mmc0: CQHCI version 5.10 Dec 25 14:54:35 music kernel: mmc1: CQHCI version 5.10 Dec 25 14:54:35 music kernel: of_cfs_init Dec 25 14:54:35 music kernel: of_cfs_init: OK Dec 25 14:54:35 music kernel: clk: Disabling unused clocks Dec 25 14:54:35 music kernel: mmc0: SDHCI controller on 1000fff000.mmc [1000fff000.mmc] using ADMA 64-bit Dec 25 14:54:35 music kernel: mmc0: new ultra high speed SDR104 SDXC card at address aaaa Dec 25 14:54:35 music kernel: mmcblk0: mmc0:aaaa SL128 119 GiB Dec 25 14:54:35 music kernel: mmcblk0: p1 p2 p3 Dec 25 14:54:35 music kernel: mmcblk0: mmc0:aaaa SL128 119 GiB (quirks 0x00004000) Dec 25 14:54:35 music kernel: mmc1: SDHCI controller on 1001100000.mmc [1001100000.mmc] using ADMA 64-bit Dec 25 14:54:35 music kernel: Freeing unused kernel memory: 4864K Dec 25 14:54:35 music kernel: Run /init as init process Dec 25 14:54:35 music kernel: with arguments: Dec 25 14:54:35 music kernel: /init Dec 25 14:54:35 music kernel: splash Dec 25 14:54:35 music kernel: nodebug Dec 25 14:54:35 music kernel: with environment: Dec 25 14:54:35 music kernel: HOME=/ Dec 25 14:54:35 music kernel: TERM=linux Dec 25 14:54:35 music kernel: imgpart=UUID=ea4305a4-d90d-47fc-afb2-715854f091ba Dec 25 14:54:35 music kernel: imgfile=/volumio_current.sqsh Dec 25 14:54:35 music kernel: bootpart=UUID=ABA1-7067 Dec 25 14:54:35 music kernel: datapart=UUID=f7b616b7-de12-485f-aa0b-647e37a9b4ff Dec 25 14:54:35 music kernel: uuidconfig=cmdline.txt Dec 25 14:54:35 music kernel: bootdelay=7 Dec 25 14:54:35 music kernel: use_kmsg=no Dec 25 14:54:35 music kernel: mmc1: new ultra high speed DDR50 SDIO card at address 0001 Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_info_register (err -2) Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_info_create_module_entry (err -2) Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_info_free_entry (err -2) Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_fasync_helper (err -2) Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_ecards_limit (err -2) Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_oss_info_register (err -2) Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_unregister_device (err -2) Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_device_alloc (err -2) Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_device_new (err -2) Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_fasync_free (err -2) Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_kill_fasync (err -2) Dec 25 14:54:35 music kernel: snd_timer: Unknown symbol snd_register_device (err -2) Dec 25 14:54:35 music kernel: input: pwr_button as /devices/platform/pwr_button/input/input0 Dec 25 14:54:35 music kernel: brcmstb-i2c 107d508200.i2c: @97500hz registered in interrupt mode Dec 25 14:54:35 music kernel: brcmstb-i2c 107d508280.i2c: @97500hz registered in interrupt mode Dec 25 14:54:35 music kernel: [drm] Initialized v3d 1.0.0 20180419 for 1002000000.v3d on minor 0 Dec 25 14:54:35 music kernel: fuse: init (API version 7.39) Dec 25 14:54:35 music kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 25 14:54:35 music kernel: EXT4-fs (mmcblk0p2): recovery complete Dec 25 14:54:35 music kernel: EXT4-fs (mmcblk0p2): mounted filesystem ea4305a4-d90d-47fc-afb2-715854f091ba r/w with ordered data mode. Quota mode: none. Dec 25 14:54:35 music kernel: loop0: detected capacity change from 0 to 1005568 Dec 25 14:54:35 music kernel: EXT4-fs (mmcblk0p3): recovery complete Dec 25 14:54:35 music kernel: EXT4-fs (mmcblk0p3): mounted filesystem f7b616b7-de12-485f-aa0b-647e37a9b4ff r/w with ordered data mode. Quota mode: none. Dec 25 14:54:35 music kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038-01-19 (0x7fffffff) Dec 25 14:54:35 music kernel: NET: Registered PF_INET6 protocol family Dec 25 14:54:35 music kernel: Segment Routing with IPv6 Dec 25 14:54:35 music kernel: In-situ OAM (IOAM) with IPv6 Dec 25 14:54:35 music systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Dec 25 14:54:35 music systemd[1]: Detected architecture arm64. Dec 25 14:54:35 music systemd[1]: Set hostname to . Dec 25 14:54:35 music kernel: uart-pl011 107d001000.serial: no DMA platform data Dec 25 14:54:35 music systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Dec 25 14:54:35 music systemd[1]: Created slice system-getty.slice. Dec 25 14:54:35 music systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Dec 25 14:54:35 music systemd[1]: Listening on Journal Audit Socket. Dec 25 14:54:35 music systemd[1]: Listening on fsck to fsckd communication Socket. Dec 25 14:54:35 music systemd[1]: Created slice system-serial\x2dgetty.slice. Dec 25 14:54:35 music systemd[1]: Listening on udev Kernel Socket. Dec 25 14:54:35 music systemd-journald[401]: Journal started Dec 25 14:54:35 music systemd-journald[401]: Runtime journal (/run/log/journal/6b13c6b458a393459eab7e726914ca26) is 3.7M, max 30.0M, 26.2M free. Dec 25 14:54:35 music fake-hwclock[392]: Current system time: 2025-12-25 13:54:35 Dec 25 14:54:35 music fake-hwclock[392]: fake-hwclock saved clock information is in the past: 2025-12-25 13:54:13 Dec 25 14:54:35 music fake-hwclock[392]: To set system time to this saved clock anyway, use "force" Dec 25 14:54:35 music systemd-modules-load[403]: Inserted module 'i2c_dev' Dec 25 14:54:35 music kernel: i2c_dev: i2c /dev entries driver Dec 25 14:54:35 music systemd[1]: Started Restore / save the current clock. Dec 25 14:54:35 music systemd[1]: Started Load Kernel Modules. Dec 25 14:54:35 music systemd[1]: Mounting FUSE Control File System... Dec 25 14:54:35 music systemd[1]: Starting Apply Kernel Variables... Dec 25 14:54:35 music systemd[1]: Mounting Kernel Configuration File System... Dec 25 14:54:35 music systemd[1]: dynamicswap.service: Succeeded. Dec 25 14:54:35 music systemd[1]: Mounted FUSE Control File System. Dec 25 14:54:35 music systemd[1]: Started Load/Save Random Seed. Dec 25 14:54:35 music systemd[1]: Started Create System Users. Dec 25 14:54:35 music systemd[1]: Mounted Kernel Configuration File System. Dec 25 14:54:35 music systemd[1]: Starting Create Static Device Nodes in /dev... Dec 25 14:54:35 music systemd[1]: Started Apply Kernel Variables. Dec 25 14:54:35 music systemd[1]: Started Create Static Device Nodes in /dev. Dec 25 14:54:35 music systemd[1]: Reached target Local File Systems (Pre). Dec 25 14:54:35 music systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Dec 25 14:54:35 music systemd[1]: Mounting /tmp... Dec 25 14:54:35 music systemd[1]: Mounting /var/spool/cups... Dec 25 14:54:35 music systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Dec 25 14:54:35 music systemd[1]: Mounting /var/log... Dec 25 14:54:35 music systemd[1]: Starting udev Kernel Device Manager... Dec 25 14:54:35 music systemd[1]: Started udev Coldplug all Devices. Dec 25 14:54:35 music systemd[1]: Mounted /tmp. Dec 25 14:54:35 music systemd[1]: Mounted /var/spool/cups. Dec 25 14:54:35 music systemd[1]: Mounted /var/log. Dec 25 14:54:35 music systemd[1]: Starting Flush Journal to Persistent Storage... Dec 25 14:54:35 music systemd[1]: Mounting /var/spool/cups/tmp... Dec 25 14:54:35 music systemd[1]: Starting Helper to synchronize boot up for ifupdown... Dec 25 14:54:35 music systemd[1]: Mounted /var/spool/cups/tmp. Dec 25 14:54:35 music systemd-journald[401]: Runtime journal (/run/log/journal/6b13c6b458a393459eab7e726914ca26) is 3.7M, max 30.0M, 26.2M free. Dec 25 14:54:35 music systemd-udevd[423]: Network interface NamePolicy= disabled on kernel command line, ignoring. Dec 25 14:54:35 music systemd[1]: Started Helper to synchronize boot up for ifupdown. Dec 25 14:54:35 music systemd[1]: Started udev Kernel Device Manager. Dec 25 14:54:35 music systemd[1]: Starting Show Plymouth Boot Screen... Dec 25 14:54:35 music systemd[1]: Started Flush Journal to Persistent Storage. Dec 25 14:54:35 music systemd[1]: plymouth-start.service: Succeeded. Dec 25 14:54:35 music systemd[1]: Started Show Plymouth Boot Screen. Dec 25 14:54:35 music systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Dec 25 14:54:35 music systemd[1]: Reached target Local Encrypted Volumes. Dec 25 14:54:35 music systemd[1]: Reached target Paths. Dec 25 14:54:35 music systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Dec 25 14:54:35 music systemd-udevd[435]: Using default interface naming scheme 'v240'. Dec 25 14:54:35 music kernel: mc: Linux media interface: v0.10 Dec 25 14:54:35 music kernel: videodev: Linux video capture interface: v2.00 Dec 25 14:54:35 music kernel: rpi-gpiomem 107d508500.gpiomem: window base 0x107d508500 size 0x00000040 Dec 25 14:54:35 music kernel: rpi-gpiomem 107d508500.gpiomem: initialised 1 regions as /dev/gpiomem1 Dec 25 14:54:35 music kernel: rpi-gpiomem 107d517c00.gpiomem: window base 0x107d517c00 size 0x00000040 Dec 25 14:54:35 music kernel: rpi-gpiomem 107d517c00.gpiomem: initialised 1 regions as /dev/gpiomem2 Dec 25 14:54:35 music kernel: rpi-gpiomem 107d504100.gpiomem: window base 0x107d504100 size 0x00000020 Dec 25 14:54:35 music kernel: rpi-gpiomem 107d504100.gpiomem: initialised 1 regions as /dev/gpiomem3 Dec 25 14:54:35 music kernel: rpi-gpiomem 107d510700.gpiomem: window base 0x107d510700 size 0x00000020 Dec 25 14:54:35 music kernel: rpi-gpiomem 107d510700.gpiomem: initialised 1 regions as /dev/gpiomem4 Dec 25 14:54:35 music kernel: rpi-gpiomem 1f000d0000.gpiomem: window base 0x1f000d0000 size 0x00030000 Dec 25 14:54:35 music kernel: rpi-gpiomem 1f000d0000.gpiomem: initialised 1 regions as /dev/gpiomem0 Dec 25 14:54:35 music systemd-udevd[435]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Dec 25 14:54:36 music kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Dec 25 14:54:36 music kernel: pispbe 1000880000.pisp_be: Runtime PM usage count underflow! Dec 25 14:54:36 music kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Dec 25 14:54:36 music kernel: rpivid 1000800000.codec: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Dec 25 14:54:36 music kernel: rpivid 1000800000.codec: Device registered as /dev/video19 Dec 25 14:54:36 music kernel: rp1_pio: Unknown symbol rp1_firmware_message (err -2) Dec 25 14:54:36 music kernel: rp1_pio: Unknown symbol devm_rp1_firmware_get (err -2) Dec 25 14:54:36 music kernel: rp1_pio: Unknown symbol rp1_firmware_get_feature (err -2) Dec 25 14:54:36 music systemd[1]: Found device /dev/ttyAMA10. Dec 25 14:54:36 music systemd-udevd[440]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Dec 25 14:54:36 music systemd-udevd[459]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Dec 25 14:54:36 music kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Dec 25 14:54:36 music kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Dec 25 14:54:36 music kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Dec 25 14:54:36 music kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Dec 25 14:54:36 music kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Dec 25 14:54:36 music kernel: Bluetooth: Core ver 2.22 Dec 25 14:54:36 music kernel: NET: Registered PF_BLUETOOTH protocol family Dec 25 14:54:36 music kernel: Bluetooth: HCI device and connection manager initialized Dec 25 14:54:36 music kernel: Bluetooth: HCI socket layer initialized Dec 25 14:54:36 music kernel: Bluetooth: L2CAP socket layer initialized Dec 25 14:54:36 music kernel: Bluetooth: SCO socket layer initialized Dec 25 14:54:36 music systemd[1]: Found device /dev/disk/by-uuid/ABA1-7067. Dec 25 14:54:36 music kernel: Bluetooth: HCI UART driver ver 2.3 Dec 25 14:54:36 music kernel: Bluetooth: HCI UART protocol H4 registered Dec 25 14:54:36 music kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Dec 25 14:54:36 music kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Dec 25 14:54:36 music kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Dec 25 14:54:36 music kernel: Bluetooth: HCI UART protocol Broadcom registered Dec 25 14:54:36 music kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Dec 25 14:54:36 music kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Dec 25 14:54:36 music kernel: usbcore: registered new interface driver brcmfmac Dec 25 14:54:36 music kernel: brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43455-sdio.raspberrypi,5-model-b.bin failed with error -2 Dec 25 14:54:36 music systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Dec 25 14:54:36 music systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Dec 25 14:54:36 music systemd-fsck[655]: fsck.fat 4.1 (2017-01-24) Dec 25 14:54:36 music systemd-fsck[655]: /dev/mmcblk0p1: 401 files, 166417/184582 clusters Dec 25 14:54:36 music systemd[1]: Starting File System Check on /dev/disk/by-uuid/ABA1-7067... Dec 25 14:54:36 music systemd[1]: Started File System Check Daemon to report status. Dec 25 14:54:36 music systemd[1]: Started File System Check on /dev/disk/by-uuid/ABA1-7067. Dec 25 14:54:36 music systemd[1]: Mounting /boot... Dec 25 14:54:36 music kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Dec 25 14:54:36 music kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 Dec 25 14:54:36 music kernel: wm8804 1-003b: revision E Dec 25 14:54:36 music systemd[1]: Mounted /boot. Dec 25 14:54:36 music systemd[1]: Created slice system-bthelper.slice. Dec 25 14:54:36 music systemd[1]: Condition check resulted in Huge Pages File System being skipped. Dec 25 14:54:36 music systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Dec 25 14:54:36 music systemd[1]: Reached target Local File Systems. Dec 25 14:54:36 music systemd[1]: Started ifup for eth0. Dec 25 14:54:36 music systemd[1]: Starting Raise network interfaces... Dec 25 14:54:36 music systemd[1]: Starting Preprocess NFS configuration... Dec 25 14:54:36 music systemd[1]: Starting Create Volatile Files and Directories... Dec 25 14:54:36 music systemd[1]: Starting Show Plymouth Boot Screen... Dec 25 14:54:36 music systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Dec 25 14:54:36 music systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Dec 25 14:54:36 music systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Dec 25 14:54:36 music systemd[1]: Starting Load/Save RF Kill Switch Status... Dec 25 14:54:36 music systemd-udevd[432]: Using default interface naming scheme 'v240'. Dec 25 14:54:36 music systemd-udevd[432]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Dec 25 14:54:36 music systemd[1]: Received SIGRTMIN+20 from PID 281 (plymouthd). Dec 25 14:54:36 music systemd[1]: plymouth-read-write.service: Succeeded. Dec 25 14:54:36 music systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Dec 25 14:54:36 music systemd[1]: plymouth-start.service: Succeeded. Dec 25 14:54:36 music systemd[1]: Started Show Plymouth Boot Screen. Dec 25 14:54:36 music systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Dec 25 14:54:36 music systemd[1]: Started Load/Save RF Kill Switch Status. Dec 25 14:54:36 music systemd[1]: nfs-config.service: Succeeded. Dec 25 14:54:36 music systemd[1]: Started Preprocess NFS configuration. Dec 25 14:54:36 music systemd[1]: Started Create Volatile Files and Directories. Dec 25 14:54:36 music kernel: vc4-drm axi:gpu: bcm2712_iommu_of_xlate: MMU 1000005200.iommu Dec 25 14:54:36 music kernel: Console: switching to colour dummy device 80x25 Dec 25 14:54:36 music kernel: vc4-drm axi:gpu: bound 107c580000.hvs (ops vc4_hvs_ops [vc4]) Dec 25 14:54:36 music kernel: Registered IR keymap rc-cec Dec 25 14:54:36 music kernel: rc rc0: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0 Dec 25 14:54:36 music kernel: input: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0/input1 Dec 25 14:54:36 music kernel: input: vc4-hdmi-0 HDMI Jack as /devices/platform/soc/107c701400.hdmi/sound/card1/input2 Dec 25 14:54:36 music kernel: vc4-drm axi:gpu: bound 107c701400.hdmi (ops vc4_hdmi_ops [vc4]) Dec 25 14:54:36 music kernel: Registered IR keymap rc-cec Dec 25 14:54:36 music kernel: rc rc1: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1 Dec 25 14:54:36 music kernel: input: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1/input3 Dec 25 14:54:36 music kernel: input: vc4-hdmi-1 HDMI Jack as /devices/platform/soc/107c706400.hdmi/sound/card2/input4 Dec 25 14:54:36 music kernel: Bluetooth: hci0: BCM: chip id 107 Dec 25 14:54:36 music kernel: Bluetooth: hci0: BCM: features 0x2f Dec 25 14:54:36 music kernel: Bluetooth: hci0: BCM4345C0 Dec 25 14:54:36 music kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Dec 25 14:54:36 music kernel: vc4-drm axi:gpu: bound 107c706400.hdmi (ops vc4_hdmi_ops [vc4]) Dec 25 14:54:36 music kernel: vc4-drm axi:gpu: bound 107c500000.mop (ops vc4_txp_ops [vc4]) Dec 25 14:54:36 music kernel: vc4-drm axi:gpu: bound 107c501000.moplet (ops vc4_txp_ops [vc4]) Dec 25 14:54:36 music kernel: vc4-drm axi:gpu: bound 107c410000.pixelvalve (ops vc4_crtc_ops [vc4]) Dec 25 14:54:36 music kernel: vc4-drm axi:gpu: bound 107c411000.pixelvalve (ops vc4_crtc_ops [vc4]) Dec 25 14:54:36 music kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Dec 25 14:54:36 music kernel: [drm] Initialized vc4 0.0.0 20140616 for axi:gpu on minor 1 Dec 25 14:54:36 music kernel: Console: switching to colour frame buffer device 240x67 Dec 25 14:54:36 music kernel: vc4-drm axi:gpu: [drm] fb0: vc4drmfb frame buffer device Dec 25 14:54:36 music systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Dec 25 14:54:36 music systemd[1]: Starting Update UTMP about System Boot/Shutdown... Dec 25 14:54:36 music systemd[1]: Starting RPC bind portmap service... Dec 25 14:54:36 music systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Dec 25 14:54:36 music systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Dec 25 14:54:36 music systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Dec 25 14:54:36 music systemd[1]: Reached target NFS client services. Dec 25 14:54:36 music systemd-udevd[459]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Dec 25 14:54:36 music systemd-udevd[439]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Dec 25 14:54:36 music systemd-udevd[449]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Dec 25 14:54:36 music systemd-udevd[456]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Dec 25 14:54:36 music kernel: 8021q: 802.1Q VLAN Support v1.8 Dec 25 14:54:36 music systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Dec 25 14:54:36 music systemd[1]: Started RPC bind portmap service. Dec 25 14:54:36 music systemd[1]: Reached target RPC Port Mapper. Dec 25 14:54:36 music systemd[1]: Reached target Remote File Systems (Pre). Dec 25 14:54:36 music systemd[1]: Reached target Remote File Systems. Dec 25 14:54:36 music kernel: alsactl[721]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Dec 25 14:54:36 music systemd[1]: Started ifup for wlan0. Dec 25 14:54:36 music systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Dec 25 14:54:36 music systemd[1]: Starting Show Plymouth Boot Screen... Dec 25 14:54:36 music systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Dec 25 14:54:36 music systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Dec 25 14:54:36 music systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Dec 25 14:54:36 music systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Dec 25 14:54:36 music systemd[1]: Condition check resulted in Huge Pages File System being skipped. Dec 25 14:54:36 music systemd[1]: Started Update UTMP about System Boot/Shutdown. Dec 25 14:54:36 music kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Dec 25 14:54:36 music kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 25 14:54:36 music sh[674]: eth0: waiting for carrier Dec 25 14:54:36 music kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:01] driver [Broadcom BCM54213PE] (irq=POLL) Dec 25 14:54:36 music kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode Dec 25 14:54:36 music kernel: pps pps0: new PPS source ptp0 Dec 25 14:54:36 music kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. Dec 25 14:54:36 music dhcpcd[754]: eth0: waiting for carrier Dec 25 14:54:36 music systemd[1]: Started Raise network interfaces. Dec 25 14:54:36 music sh[772]: wlan0=wlan0 Dec 25 14:54:37 music systemd[1]: plymouth-read-write.service: Succeeded. Dec 25 14:54:37 music systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Dec 25 14:54:37 music systemd[1]: plymouth-start.service: Succeeded. Dec 25 14:54:37 music systemd[1]: Started Show Plymouth Boot Screen. Dec 25 14:54:37 music systemd[1]: Received SIGRTMIN+20 from PID 281 (plymouthd). Dec 25 14:54:37 music systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Dec 25 14:54:37 music systemd[1]: Reached target System Initialization. Dec 25 14:54:37 music systemd[1]: Listening on triggerhappy.socket. Dec 25 14:54:37 music systemd[1]: Started Daily apt download activities. Dec 25 14:54:37 music systemd[1]: Listening on D-Bus System Message Bus Socket. Dec 25 14:54:37 music systemd[1]: Started Daily Cleanup of Temporary Directories. Dec 25 14:54:37 music systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Dec 25 14:54:37 music systemd[1]: Reached target Sockets. Dec 25 14:54:37 music systemd[1]: Reached target Basic System. Dec 25 14:54:37 music systemd[1]: Started Volumio Iptables Module. Dec 25 14:54:37 music systemd[1]: Starting triggerhappy global hotkey daemon... Dec 25 14:54:37 music systemd[1]: Started UPnP Renderer front-end to MPD. Dec 25 14:54:37 music systemd[1]: Started Volumio Log Rotation Service. Dec 25 14:54:37 music systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Dec 25 14:54:37 music systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Dec 25 14:54:37 music systemd[1]: Starting Volumio Time Update Utility... Dec 25 14:54:37 music systemd[1]: Started Manage Sound Card State (restore and store). Dec 25 14:54:37 music systemd[1]: Started volumio-remote-updater.service. Dec 25 14:54:37 music alsactl[858]: alsactl 1.1.8 daemon started Dec 25 14:54:37 music systemd[1]: Starting Wireless Services... Dec 25 14:54:37 music systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Dec 25 14:54:37 music systemd[1]: Starting Login Service... Dec 25 14:54:37 music systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped. Dec 25 14:54:37 music systemd[1]: Starting Raspberry Pi bluetooth helper... Dec 25 14:54:37 music systemd[1]: Started D-Bus System Message Bus. Dec 25 14:54:37 music systemd[1]: Starting WPA supplicant... Dec 25 14:54:37 music systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Dec 25 14:54:37 music systemd[1]: Started Daily apt upgrade and clean activities. Dec 25 14:54:37 music systemd[1]: Reached target Timers. Dec 25 14:54:37 music systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Dec 25 14:54:37 music systemd[1]: Starting dhcpcd on all interfaces... Dec 25 14:54:37 music systemd[1]: Starting Save/Restore Sound Card State... Dec 25 14:54:37 music volumio-time-update[857]: volumio-time-update-util: Fetching time from Volumio... Dec 25 14:54:37 music dhcpcd[868]: Not running dhcpcd because /etc/network/interfaces Dec 25 14:54:37 music dhcpcd[868]: defines some interfaces that will use a Dec 25 14:54:37 music dhcpcd[868]: DHCP client or static address Dec 25 14:54:37 music thd[854]: Unable to parse trigger line: Dec 25 14:54:37 music thd[854]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Dec 25 14:54:37 music thd[854]: Unable to parse trigger line: Dec 25 14:54:37 music thd[854]: Found socket passed from systemd Dec 25 14:54:37 music systemd-logind[862]: New seat seat0. Dec 25 14:54:37 music systemd-logind[862]: Watching system buttons on /dev/input/event0 (pwr_button) Dec 25 14:54:37 music systemd-logind[862]: Watching system buttons on /dev/input/event1 (vc4-hdmi-0) Dec 25 14:54:37 music systemd-logind[862]: Watching system buttons on /dev/input/event3 (vc4-hdmi-1) Dec 25 14:54:37 music avahi-daemon[867]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Dec 25 14:54:37 music avahi-daemon[867]: Successfully dropped root privileges. Dec 25 14:54:37 music avahi-daemon[867]: avahi-daemon 0.7 starting up. Dec 25 14:54:37 music kernel: Bluetooth: hci0: BCM: features 0x2f Dec 25 14:54:37 music kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Dec 25 14:54:37 music kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Dec 25 14:54:37 music kernel: Bluetooth: hci0: BCM: Using default device address (43:45:c0:00:1f:ac) Dec 25 14:54:37 music bthelper[863]: Raspberry Pi BDADDR already set Dec 25 14:54:37 music haveged[728]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Dec 25 14:54:37 music haveged[728]: haveged: cpu: (VC); data: 64K (V); inst: 64K (V); idx: 39/40; sz: 63488/63488 Dec 25 14:54:37 music haveged[728]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00386 Dec 25 14:54:37 music haveged[728]: haveged: fills: 0, generated: 0 Dec 25 14:54:37 music dbus-daemon[865]: [system] Successfully activated service 'org.freedesktop.systemd1' Dec 25 14:54:37 music wpa_supplicant[866]: Successfully initialized wpa_supplicant Dec 25 14:54:37 music systemd[1]: Started Login Service. Dec 25 14:54:37 music systemd[1]: Started WPA supplicant. Dec 25 14:54:37 music systemd[1]: Started triggerhappy global hotkey daemon. Dec 25 14:54:37 music avahi-daemon[867]: Successfully called chroot(). Dec 25 14:54:37 music avahi-daemon[867]: Successfully dropped remaining capabilities. Dec 25 14:54:37 music systemd[1]: Started Raspberry Pi bluetooth helper. Dec 25 14:54:37 music systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Dec 25 14:54:37 music systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Dec 25 14:54:37 music systemd[1]: Failed to start dhcpcd on all interfaces. Dec 25 14:54:37 music systemd[1]: Started Save/Restore Sound Card State. Dec 25 14:54:37 music avahi-daemon[867]: Loading service file /services/volumio.service. Dec 25 14:54:37 music volumio-remote-updater[859]: Error: No active session Dec 25 14:54:37 music volumio-remote-updater[859]: [2025-12-25 14:54:37] [info] asio async_connect error: system:111 (Connection refused) Dec 25 14:54:37 music volumio-remote-updater[859]: [2025-12-25 14:54:37] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 25 14:54:37 music volumio-remote-updater[859]: [2025-12-25 14:54:37] [error] handle_connect error: Underlying Transport Error Dec 25 14:54:37 music avahi-daemon[867]: Network interface enumeration completed. Dec 25 14:54:37 music systemd[1]: Started Avahi mDNS/DNS-SD Stack. Dec 25 14:54:37 music systemd[1]: Reached target Sound Card. Dec 25 14:54:37 music avahi-daemon[867]: Server startup complete. Host name is music.local. Local service cookie is 505223555. Dec 25 14:54:37 music avahi-daemon[867]: Service "music" (/services/volumio.service) successfully established. Dec 25 14:54:37 music systemd[1]: Starting Bluetooth service... Dec 25 14:54:37 music systemd[1]: Reached target Network. Dec 25 14:54:37 music systemd[1]: Starting Permit User Sessions... Dec 25 14:54:37 music systemd[1]: Reached target Network is Online. Dec 25 14:54:37 music systemd[1]: Starting LSB: Brings up/down network automatically... Dec 25 14:54:37 music systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 25 14:54:37 music systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Dec 25 14:54:37 music volumio[855]: Could not open config: /tmp/upmpdcli.conf Dec 25 14:54:37 music systemd[1]: Starting Network Time Service... Dec 25 14:54:37 music systemd[1]: Starting /etc/rc.local Compatibility... Dec 25 14:54:37 music systemd[1]: Starting Samba NMB Daemon... Dec 25 14:54:37 music systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 25 14:54:37 music systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 25 14:54:37 music systemd[1]: Started Permit User Sessions. Dec 25 14:54:37 music systemd[1]: Started /etc/rc.local Compatibility. Dec 25 14:54:37 music systemd[1]: Starting Terminate Plymouth Boot Screen... Dec 25 14:54:37 music systemd[1]: Starting Hold until boot process finishes up... Dec 25 14:54:37 music systemd[1]: Received SIGRTMIN+21 from PID 281 (plymouthd). Dec 25 14:54:37 music systemd[1]: iptables.service: Succeeded. Dec 25 14:54:38 music volumio-time-update[857]: volumio-time-update-util: Date not found in response Dec 25 14:54:38 music volumio-time-update[857]: volumio-time-update-util: Retrying in 5 seconds... Dec 25 14:54:38 music systemd[1]: Received SIGRTMIN+21 from PID 281 (plymouthd). Dec 25 14:54:38 music systemd[1]: plymouth-quit.service: Succeeded. Dec 25 14:54:38 music systemd[1]: Started Terminate Plymouth Boot Screen. Dec 25 14:54:38 music systemd[1]: plymouth-quit-wait.service: Succeeded. Dec 25 14:54:38 music systemd[1]: Started Hold until boot process finishes up. Dec 25 14:54:38 music loadcpufreq[861]: Loading cpufreq kernel modules...done (none). Dec 25 14:54:38 music kernel: hwmon hwmon3: Undervoltage detected! Dec 25 14:54:38 music ifplugd(eth0)[963]: ifplugd 0.28 initializing. Dec 25 14:54:38 music systemd[1]: Started Getty on tty1. Dec 25 14:54:38 music ifplugd(eth0)[963]: Using interface eth0/2C:CF:67:23:67:D9 with driver (version: 6.6.62-v8+) Dec 25 14:54:38 music ifplugd(eth0)[963]: Using detection mode: SIOCETHTOOL Dec 25 14:54:38 music ifplugd(eth0)[963]: Initialization complete, link beat not detected. Dec 25 14:54:38 music systemd[1]: Started Serial Getty on ttyAMA10. Dec 25 14:54:38 music systemd[1]: Reached target Login Prompts. Dec 25 14:54:38 music systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Dec 25 14:54:38 music systemd[1]: Starting LSB: set CPUFreq kernel parameters... Dec 25 14:54:38 music bluetoothd[908]: Bluetooth daemon 5.83 Dec 25 14:54:38 music bluetoothd[908]: src/main.c:check_options() Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Dec 25 14:54:38 music systemd[1]: Started Bluetooth service. Dec 25 14:54:38 music systemd[1]: Reached target Bluetooth. Dec 25 14:54:38 music bluetoothd[908]: Starting SDP server Dec 25 14:54:38 music bluetoothd[908]: Excluding (cli) hostname Dec 25 14:54:38 music bluetoothd[908]: Excluding (cli) scanparam Dec 25 14:54:38 music bluetoothd[908]: Excluding (cli) battery Dec 25 14:54:38 music ntpd[918]: ntpd 4.2.8p12@1.3728-o (1): Starting Dec 25 14:54:38 music ntpd[918]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Dec 25 14:54:38 music systemd[1]: Started Network Time Service. Dec 25 14:54:38 music ntpd[978]: proto: precision = 0.352 usec (-21) Dec 25 14:54:38 music kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Dec 25 14:54:38 music kernel: Bluetooth: BNEP filters: protocol multicast Dec 25 14:54:38 music kernel: Bluetooth: BNEP socket layer initialized Dec 25 14:54:38 music kernel: Bluetooth: MGMT ver 1.22 Dec 25 14:54:38 music bluetoothd[908]: Bluetooth management interface 1.22 initialized Dec 25 14:54:38 music bluetoothd[908]: Battery Provider Manager created Dec 25 14:54:38 music cpufrequtils[965]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Dec 25 14:54:38 music ifplugd[911]: Network Interface Plugging Daemon...start eth0...done. Dec 25 14:54:38 music systemd[1]: Started LSB: set CPUFreq kernel parameters. Dec 25 14:54:38 music systemd[1]: Started LSB: Brings up/down network automatically. Dec 25 14:54:38 music ntpd[978]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Dec 25 14:54:38 music ntpd[978]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Dec 25 14:54:38 music ntpd[978]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 363 days ago Dec 25 14:54:38 music ntpd[978]: Listen and drop on 0 v6wildcard [::]:123 Dec 25 14:54:38 music ntpd[978]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Dec 25 14:54:38 music ntpd[978]: Listen normally on 2 lo 127.0.0.1:123 Dec 25 14:54:38 music ntpd[978]: Listening on routing socket on fd #19 for interface updates Dec 25 14:54:38 music ntpd[978]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 25 14:54:38 music ntpd[978]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 25 14:54:38 music kernel: NET: Registered PF_ALG protocol family Dec 25 14:54:38 music bluetoothd[908]: src/adapter.c:convert_config() Unable set contents for /usr/var/lib/bluetooth/2C:CF:67:23:67:DB/settings: (Failed to create file “/usr/var/lib/bluetooth/2C:CF:67:23:67:DB/settings.NNK6H3”: No such file or directory) Dec 25 14:54:38 music bluetoothd[908]: src/adapter.c:load_config() Unable to load key file from /usr/var/lib/bluetooth/2C:CF:67:23:67:DB/settings: (No such file or directory) Dec 25 14:54:38 music bluetoothd[908]: Unable to open adapter storage directory: /usr/var/lib/bluetooth/2C:CF:67:23:67:DB Dec 25 14:54:38 music bluetoothd[908]: Failed to set privacy: Rejected (0x0b) Dec 25 14:54:38 music nmbd[922]: [2025/12/25 14:54:38.443925, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Dec 25 14:54:38 music nmbd[922]: started asyncdns process 993 Dec 25 14:54:38 music nmbd[922]: [2025/12/25 14:54:38.444532, 0] ../lib/util/become_daemon.c:149(daemon_status) Dec 25 14:54:38 music nmbd[922]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Dec 25 14:54:38 music nmbd[922]: [2025/12/25 14:54:38.444574, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Dec 25 14:54:38 music nmbd[922]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Dec 25 14:54:38 music wireless.js[860]: Cleaning previous... Dec 25 14:54:38 music sudo[1001]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Dec 25 14:54:38 music sudo[1001]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:38 music sudo[1001]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:38 music sudo[1003]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Dec 25 14:54:38 music sudo[1003]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:39 music sudo[1003]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:39 music wireless.js[860]: Stopped aP Dec 25 14:54:39 music sudo[1010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 25 14:54:39 music sudo[1010]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:39 music sudo[1010]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:39 music kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 25 14:54:39 music sudo[1012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 25 14:54:39 music sudo[1012]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:39 music ntpd[978]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Dec 25 14:54:39 music sudo[1012]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:39 music sudo[1019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 25 14:54:39 music sudo[1019]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:39 music sudo[1019]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:39 music sudo[1021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 25 14:54:39 music sudo[1021]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:40 music ntpd[978]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Dec 25 14:54:41 music sh[674]: eth0: carrier acquired Dec 25 14:54:41 music dhcpcd[754]: eth0: carrier acquired Dec 25 14:54:41 music kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Dec 25 14:54:41 music sh[674]: DUID 00:01:00:01:30:a7:92:7b:2c:cf:67:23:67:d9 Dec 25 14:54:41 music sh[674]: eth0: IAID 67:23:67:d9 Dec 25 14:54:41 music dhcpcd[754]: DUID 00:01:00:01:30:a7:92:7b:2c:cf:67:23:67:d9 Dec 25 14:54:41 music dhcpcd[754]: eth0: IAID 67:23:67:d9 Dec 25 14:54:41 music sh[674]: eth0: adding address fe80::cbbb:728:40aa:a003 Dec 25 14:54:41 music sh[674]: ipv6_addaddr1: Permission denied Dec 25 14:54:41 music dhcpcd[754]: eth0: adding address fe80::cbbb:728:40aa:a003 Dec 25 14:54:41 music dhcpcd[754]: ipv6_addaddr1: Permission denied Dec 25 14:54:41 music ntpd[978]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Dec 25 14:54:41 music ifplugd(eth0)[963]: Link beat detected. Dec 25 14:54:41 music ifplugd(eth0)[963]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Dec 25 14:54:41 music ifplugd(eth0)[963]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Dec 25 14:54:41 music systemd[1]: systemd-rfkill.service: Succeeded. Dec 25 14:54:41 music sudo[1021]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:41 music wireless.js[860]: SETTING APPROPRIATE REG DOMAIN: DE Dec 25 14:54:41 music sudo[1032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 25 14:54:41 music sudo[1032]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:41 music sudo[1032]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:41 music sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Dec 25 14:54:41 music sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:41 music sudo[1034]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:41 music wireless.js[860]: SUCCESSFULLY SET NEW REGDOMAIN: DE Dec 25 14:54:41 music wireless.js[860]: Start wireless flow Dec 25 14:54:41 music wireless.js[860]: Stopped hotspot (if there).. Dec 25 14:54:41 music sudo[1039]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Dec 25 14:54:41 music sudo[1039]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:41 music sudo[1039]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:41 music sudo[1041]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Dec 25 14:54:41 music sudo[1041]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:41 music sh[674]: eth0: soliciting an IPv6 router Dec 25 14:54:41 music dhcpcd[754]: eth0: soliciting an IPv6 router Dec 25 14:54:41 music sh[674]: eth0: soliciting a DHCP lease Dec 25 14:54:41 music dhcpcd[754]: eth0: soliciting a DHCP lease Dec 25 14:54:42 music sh[674]: eth0: offered 192.168.44.105 from 192.168.44.254 Dec 25 14:54:42 music dhcpcd[754]: eth0: offered 192.168.44.105 from 192.168.44.254 Dec 25 14:54:42 music ntpd[978]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Dec 25 14:54:42 music sh[674]: eth0: probing address 192.168.44.105/24 Dec 25 14:54:42 music dhcpcd[754]: eth0: probing address 192.168.44.105/24 Dec 25 14:54:42 music sudo[1041]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:42 music wireless.js[860]: DHCP IP Dec 25 14:54:42 music wireless.js[860]: Start ap Dec 25 14:54:42 music wpa_supplicant[1043]: Successfully initialized wpa_supplicant Dec 25 14:54:42 music sudo[1044]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Dec 25 14:54:42 music sudo[1044]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:42 music dhcpcd[1045]: dev: loaded udev Dec 25 14:54:42 music kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 25 14:54:42 music dhcpcd-run-hooks[1054]: wlan0: starting wpa_supplicant Dec 25 14:54:42 music wpa_supplicant[1043]: ctrl_iface exists and seems to be in use - cannot override it Dec 25 14:54:42 music wpa_supplicant[1043]: Delete '/var/run/wpa_supplicant/wlan0' manually if it is not used anymore Dec 25 14:54:42 music wpa_supplicant[1043]: Failed to initialize control interface '/var/run/wpa_supplicant'. You may have another wpa_supplicant process already running or the file was left by an unclean termination of wpa_supplicant in which case you will need to manually remove this file before starting wpa_supplicant again. Dec 25 14:54:42 music dhcpcd[1045]: wlan0: connected to Access Point `' Dec 25 14:54:42 music dhcpcd[1045]: DUID 00:01:00:01:30:a7:92:7b:2c:cf:67:23:67:d9 Dec 25 14:54:42 music dhcpcd[1045]: eth0: IAID 67:23:67:d9 Dec 25 14:54:42 music dhcpcd[1045]: eth0: adding address fe80::cbbb:728:40aa:a003 Dec 25 14:54:42 music dhcpcd[1045]: ipv6_addaddr1: Permission denied Dec 25 14:54:42 music dhcpcd[1045]: wlan0: waiting for carrier Dec 25 14:54:42 music wpa_supplicant[1043]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Dec 25 14:54:42 music bluetoothd[908]: src/adv_monitor.c:btd_adv_monitor_power_down() Unexpected NULL btd_adv_monitor_manager object upon power down Dec 25 14:54:42 music bthelper[863]: [NEW] Media /org/bluez/hci0 Dec 25 14:54:42 music bthelper[863]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Dec 25 14:54:42 music bthelper[863]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Dec 25 14:54:42 music bthelper[863]: hci0 class of device changed: 0x000000 Dec 25 14:54:42 music bthelper[863]: hci0 new_settings: ssp br/edr le secure-conn Dec 25 14:54:42 music bthelper[863]: [CHG] Controller 2C:CF:67:23:67:DB PowerState: on-disabling Dec 25 14:54:42 music bthelper[863]: Changing power off succeeded Dec 25 14:54:42 music bthelper[863]: [NEW] Media /org/bluez/hci0 Dec 25 14:54:42 music bthelper[863]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Dec 25 14:54:42 music bthelper[863]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Dec 25 14:54:42 music bthelper[863]: [CHG] Controller 2C:CF:67:23:67:DB PowerState: off-enabling Dec 25 14:54:42 music dhcpcd[1045]: eth0: soliciting a DHCP lease Dec 25 14:54:42 music dhcpcd[1045]: eth0: offered 192.168.44.105 from 192.168.44.254 Dec 25 14:54:42 music bthelper[863]: hci0 class of device changed: 0x00041c Dec 25 14:54:42 music bthelper[863]: [CHG] Controller 2C:CF:67:23:67:DB Class: 0x0000041c (1052) Dec 25 14:54:42 music bthelper[863]: hci0 new_settings: powered ssp br/edr le secure-conn Dec 25 14:54:42 music bthelper[863]: Changing power on succeeded Dec 25 14:54:42 music bthelper[863]: [CHG] Controller 2C:CF:67:23:67:DB PowerState: on Dec 25 14:54:42 music bthelper[863]: [CHG] Controller 2C:CF:67:23:67:DB Powered: yes Dec 25 14:54:42 music dhcpcd[1045]: eth0: probing address 192.168.44.105/24 Dec 25 14:54:42 music volumio-remote-updater[859]: [2025-12-25 14:54:42] [info] asio async_connect error: system:111 (Connection refused) Dec 25 14:54:42 music volumio-remote-updater[859]: [2025-12-25 14:54:42] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 25 14:54:42 music volumio-remote-updater[859]: [2025-12-25 14:54:42] [error] handle_connect error: Underlying Transport Error Dec 25 14:54:43 music volumio-time-update[857]: volumio-time-update-util: Fetching time from Volumio... Dec 25 14:54:43 music volumio-time-update[857]: volumio-time-update-util: Date not found in response Dec 25 14:54:43 music volumio-time-update[857]: volumio-time-update-util: Retrying in 5 seconds... Dec 25 14:54:43 music dhcpcd[1045]: eth0: soliciting an IPv6 router Dec 25 14:54:43 music wireless.js[860]: trying... Dec 25 14:54:43 music sudo[1075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:43 music sudo[1075]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:43 music sudo[1075]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:44 music wireless.js[860]: trying... Dec 25 14:54:44 music sudo[1078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:44 music sudo[1078]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:44 music sudo[1078]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:45 music wireless.js[860]: trying... Dec 25 14:54:45 music sudo[1081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:45 music sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:45 music sudo[1081]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:45 music kernel: brcmfmac: brcmf_dump_obss: dump_obss error (-52) Dec 25 14:54:46 music kernel: hwmon hwmon3: Voltage normalised Dec 25 14:54:46 music wireless.js[860]: trying... Dec 25 14:54:46 music sudo[1085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:46 music sudo[1085]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:46 music sudo[1085]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:47 music sh[674]: eth0: leased 192.168.44.105 for 7200 seconds Dec 25 14:54:47 music sh[674]: eth0: adding route to 192.168.44.0/24 Dec 25 14:54:47 music dhcpcd[754]: eth0: leased 192.168.44.105 for 7200 seconds Dec 25 14:54:47 music sh[674]: eth0: adding default route via 192.168.44.254 Dec 25 14:54:47 music dhcpcd[754]: eth0: adding route to 192.168.44.0/24 Dec 25 14:54:47 music dhcpcd[754]: eth0: adding default route via 192.168.44.254 Dec 25 14:54:47 music avahi-daemon[867]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.44.105. Dec 25 14:54:47 music avahi-daemon[867]: New relevant interface eth0.IPv4 for mDNS. Dec 25 14:54:47 music avahi-daemon[867]: Registering new address record for 192.168.44.105 on eth0.IPv4. Dec 25 14:54:47 music sh[674]: forked to background, child pid 1107 Dec 25 14:54:47 music dhcpcd[754]: forked to background, child pid 1107 Dec 25 14:54:47 music dhcpcd[1045]: eth0: leased 192.168.44.105 for 7200 seconds Dec 25 14:54:47 music dhcpcd[1045]: eth0: adding route to 192.168.44.0/24 Dec 25 14:54:47 music dhcpcd[1045]: eth0: adding default route via 192.168.44.254 Dec 25 14:54:47 music ifplugd(eth0)[963]: client: ifup: interface eth0 already configured Dec 25 14:54:47 music sh[674]: eth0=eth0 Dec 25 14:54:47 music wireless.js[860]: trying... Dec 25 14:54:47 music dhcpcd[1045]: forked to background, child pid 1155 Dec 25 14:54:47 music sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:47 music sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:47 music sudo[1149]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:47 music sudo[1044]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:47 music ifplugd(eth0)[963]: Program executed successfully. Dec 25 14:54:48 music volumio-time-update[857]: volumio-time-update-util: Fetching time from Volumio... Dec 25 14:54:48 music volumio-time-update[857]: volumio-time-update-util: Setting system time to: 2025-12-25 14:54:48 Dec 25 14:54:48 music sudo[1162]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-12-25 14:54:48 Dec 25 14:54:48 music sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:48 music dbus-daemon[865]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.8' (uid=0 pid=1163 comm="timedatectl set-time 2025-12-25 14:54:48 ") Dec 25 14:54:48 music systemd[1]: Starting Time & Date Service... Dec 25 14:54:48 music dbus-daemon[865]: [system] Successfully activated service 'org.freedesktop.timedate1' Dec 25 14:54:48 music systemd[1]: Started Time & Date Service. Dec 25 14:54:48 music systemd-timedated[1164]: Changed local time to Thu Dec 25 14:54:48 2025 Dec 25 14:54:48 music sudo[1162]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:48 music volumio-time-update[857]: volumio-time-update-util: System time updated successfully. Dec 25 14:54:48 music systemd[1]: Started Volumio Time Update Utility. Dec 25 14:54:48 music kernel: hwmon hwmon3: Undervoltage detected! Dec 25 14:54:48 music wireless.js[860]: trying... Dec 25 14:54:48 music sudo[1167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:48 music sudo[1167]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:48 music sudo[1167]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:48 music nmbd[922]: [2025/12/25 14:54:48.309948, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 25 14:54:48 music systemd[1]: Started Samba NMB Daemon. Dec 25 14:54:48 music nmbd[922]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Dec 25 14:54:48 music systemd[1]: Starting Samba Winbind Daemon... Dec 25 14:54:48 music winbindd[1169]: [2025/12/25 14:54:48.425313, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Dec 25 14:54:48 music winbindd[1169]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 25 14:54:48 music winbindd[1169]: [2025/12/25 14:54:48.438367, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 25 14:54:48 music winbindd[1169]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Dec 25 14:54:48 music systemd[1]: Started Samba Winbind Daemon. Dec 25 14:54:48 music systemd[1]: Starting Samba SMB Daemon... Dec 25 14:54:48 music winbindd[1169]: [2025/12/25 14:54:48.565058, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Dec 25 14:54:48 music winbindd[1169]: res_names->count = 3, expected 4 Dec 25 14:54:48 music smbd[1174]: [2025/12/25 14:54:48.589049, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 25 14:54:48 music systemd[1]: Started Samba SMB Daemon. Dec 25 14:54:48 music smbd[1174]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Dec 25 14:54:49 music ntpd[978]: Listen normally on 3 eth0 192.168.44.105:123 Dec 25 14:54:49 music ntpd[978]: new interface(s) found: waking up resolver Dec 25 14:54:49 music wireless.js[860]: trying... Dec 25 14:54:49 music sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:49 music sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:49 music sudo[1183]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:50 music wireless.js[860]: trying... Dec 25 14:54:50 music sudo[1186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:50 music sudo[1186]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:50 music sudo[1186]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:50 music volumio-remote-updater[859]: [2025-12-25 14:54:50] [info] asio async_connect error: system:111 (Connection refused) Dec 25 14:54:50 music volumio-remote-updater[859]: [2025-12-25 14:54:50] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 25 14:54:50 music volumio-remote-updater[859]: [2025-12-25 14:54:50] [error] handle_connect error: Underlying Transport Error Dec 25 14:54:51 music wireless.js[860]: trying... Dec 25 14:54:51 music sudo[1189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:51 music sudo[1189]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:51 music sudo[1189]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:52 music kernel: hwmon hwmon3: Voltage normalised Dec 25 14:54:52 music wireless.js[860]: trying... Dec 25 14:54:52 music sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:52 music sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:52 music sudo[1193]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:53 music wireless.js[860]: trying... Dec 25 14:54:53 music sudo[1196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:53 music sudo[1196]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:53 music sudo[1196]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:54 music wireless.js[860]: trying... Dec 25 14:54:54 music sudo[1199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:54 music sudo[1199]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:54 music sudo[1199]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:55 music wireless.js[860]: trying... Dec 25 14:54:55 music sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:55 music sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:55 music sudo[1202]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:56 music wireless.js[860]: trying... Dec 25 14:54:56 music sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:56 music sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:56 music sudo[1205]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:57 music wireless.js[860]: trying... Dec 25 14:54:57 music sudo[1208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:57 music sudo[1208]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:57 music sudo[1208]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:58 music wireless.js[860]: trying... Dec 25 14:54:58 music sudo[1211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:58 music sudo[1211]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:58 music sudo[1211]: pam_unix(sudo:session): session closed for user root Dec 25 14:54:59 music wireless.js[860]: trying... Dec 25 14:54:59 music sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:54:59 music sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:54:59 music sudo[1214]: pam_unix(sudo:session): session closed for user root Dec 25 14:55:00 music wireless.js[860]: trying... Dec 25 14:55:00 music sudo[1217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:55:00 music sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:55:00 music sudo[1217]: pam_unix(sudo:session): session closed for user root Dec 25 14:55:00 music volumio-remote-updater[859]: [2025-12-25 14:55:00] [info] asio async_connect error: system:111 (Connection refused) Dec 25 14:55:00 music volumio-remote-updater[859]: [2025-12-25 14:55:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 25 14:55:00 music volumio-remote-updater[859]: [2025-12-25 14:55:00] [error] handle_connect error: Underlying Transport Error Dec 25 14:55:01 music wireless.js[860]: trying... Dec 25 14:55:01 music sudo[1220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:55:01 music sudo[1220]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:55:01 music sudo[1220]: pam_unix(sudo:session): session closed for user root Dec 25 14:55:02 music wireless.js[860]: trying... Dec 25 14:55:02 music sudo[1223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 25 14:55:02 music sudo[1223]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:55:02 music sudo[1223]: pam_unix(sudo:session): session closed for user root Dec 25 14:55:03 music wireless.js[860]: Overtime, starting plan B Dec 25 14:55:03 music wireless.js[860]: STARTING HOTSPOT Dec 25 14:55:06 music sudo[1232]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Dec 25 14:55:06 music sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:55:06 music sudo[1232]: pam_unix(sudo:session): session closed for user root Dec 25 14:55:06 music sudo[1234]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Dec 25 14:55:06 music sudo[1234]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:55:06 music sudo[1234]: pam_unix(sudo:session): session closed for user root Dec 25 14:55:06 music avahi-daemon[867]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Dec 25 14:55:06 music avahi-daemon[867]: New relevant interface wlan0.IPv4 for mDNS. Dec 25 14:55:06 music avahi-daemon[867]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Dec 25 14:55:06 music kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 25 14:55:06 music systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Dec 25 14:55:06 music systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Dec 25 14:55:06 music dnsmasq[1240]: dnsmasq: syntax check OK. Dec 25 14:55:06 music hostapd[1241]: Configuration file: /etc/hostapd/hostapd.conf Dec 25 14:55:06 music hostapd[1241]: wlan0: Could not connect to kernel driver Dec 25 14:55:06 music hostapd[1241]: Using interface wlan0 with hwaddr 2c:cf:67:23:67:da and ssid "Volumio-44446" Dec 25 14:55:06 music dnsmasq[1247]: started, version 2.80 cachesize 150 Dec 25 14:55:06 music dnsmasq[1247]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Dec 25 14:55:06 music dnsmasq-dhcp[1247]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Dec 25 14:55:06 music dnsmasq[1247]: reading /etc/resolv.conf Dec 25 14:55:06 music dnsmasq[1247]: using nameserver 192.168.44.250#53 Dec 25 14:55:06 music dnsmasq[1247]: using nameserver 9.9.9.9#53 Dec 25 14:55:06 music dnsmasq[1247]: using nameserver 208.67.222.222#53 Dec 25 14:55:06 music dnsmasq[1247]: using nameserver 208.67.220.220#53 Dec 25 14:55:06 music dnsmasq[1247]: read /etc/hosts - 1 addresses Dec 25 14:55:06 music systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Dec 25 14:55:06 music systemd[1]: Reached target Host and Network Name Lookups. Dec 25 14:55:06 music dhcpcd[1155]: wlan0: carrier acquired Dec 25 14:55:06 music hostapd[1241]: wlan0: interface state UNINITIALIZED->ENABLED Dec 25 14:55:06 music hostapd[1241]: wlan0: AP-ENABLED Dec 25 14:55:06 music systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Dec 25 14:55:06 music dhcpcd[1155]: wlan0: IAID 67:23:67:da Dec 25 14:55:06 music dhcpcd[1155]: wlan0: adding address fe80::702d:f97a:918b:723d Dec 25 14:55:06 music dhcpcd[1155]: ipv6_addaddr1: Permission denied Dec 25 14:55:06 music iwconfig[1256]: Error for wireless request "Set Power Management" (8B2C) : Dec 25 14:55:06 music iwconfig[1256]: SET failed on device wlan0 ; Invalid argument. Dec 25 14:55:06 music systemd[1]: Started Wireless Services. Dec 25 14:55:06 music dhcpcd[1155]: wlan0: soliciting an IPv6 router Dec 25 14:55:06 music systemd[1]: Started Volumio Backend Module. Dec 25 14:55:06 music systemd[1]: Started Volumio Cpu Tweaker. Dec 25 14:55:06 music systemd[1]: Reached target Multi-User System. Dec 25 14:55:06 music systemd[1]: Reached target Graphical Interface. Dec 25 14:55:06 music systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 25 14:55:06 music systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 25 14:55:06 music systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 25 14:55:06 music systemd[1]: Startup finished in 10.957s (kernel) + 31.341s (userspace) = 42.298s. Dec 25 14:55:06 music volumio-cpu-tweak[1258]: Setting RT Priority for mpd Dec 25 14:55:06 music systemd[1]: systemd-fsckd.service: Succeeded. Dec 25 14:55:06 music volumio-cpu-tweak[1258]: pid 35's current scheduling policy: SCHED_OTHER Dec 25 14:55:06 music volumio-cpu-tweak[1258]: pid 35's current scheduling priority: 0 Dec 25 14:55:06 music volumio-cpu-tweak[1258]: Setting MPD Affinity Dec 25 14:55:06 music volumio-cpu-tweak[1258]: pid 3's current affinity mask: f Dec 25 14:55:06 music volumio-cpu-tweak[1258]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Dec 25 14:55:06 music volumio-cpu-tweak[1258]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Dec 25 14:55:06 music systemd[1]: volumio_cpu_tweak.service: Succeeded. Dec 25 14:55:07 music dhcpcd[1155]: wlan0: soliciting a DHCP lease Dec 25 14:55:07 music volumio[1257]: info: ------------------------------------------- Dec 25 14:55:07 music volumio[1257]: info: ----- Volumio3 ---- Dec 25 14:55:07 music volumio[1257]: info: ------------------------------------------- Dec 25 14:55:07 music volumio[1257]: info: ----- System startup ---- Dec 25 14:55:07 music volumio[1257]: info: ------------------------------------------- Dec 25 14:55:07 music volumio[1257]: info: MYVOLUMIO Environment detected Dec 25 14:55:07 music volumio[1257]: info: Plugin folders cleanup Dec 25 14:55:07 music volumio[1257]: info: Scanning into folder /volumio/app/plugins/ Dec 25 14:55:07 music volumio[1257]: info: Scanning category audio_interface Dec 25 14:55:07 music volumio[1257]: info: Scanning category miscellanea Dec 25 14:55:07 music volumio[1257]: info: Scanning category music_service Dec 25 14:55:07 music volumio[1257]: info: Scanning category plugins.json Dec 25 14:55:07 music volumio[1257]: info: Scanning category system_controller Dec 25 14:55:07 music volumio[1257]: info: Scanning category user_interface Dec 25 14:55:07 music volumio[1257]: info: Scanning into folder /data/plugins/ Dec 25 14:55:07 music volumio[1257]: info: Plugin folders cleanup completed Dec 25 14:55:07 music volumio[1257]: info: ------------------------------------------- Dec 25 14:55:07 music volumio[1257]: info: ----- Core plugins startup ---- Dec 25 14:55:07 music volumio[1257]: info: ------------------------------------------- Dec 25 14:55:07 music volumio[1257]: info: Loading plugins from folder /volumio/app/plugins/ Dec 25 14:55:07 music volumio[1257]: info: Adding plugin upnp to MyMusic Plugins Dec 25 14:55:07 music volumio[1257]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 25 14:55:07 music volumio[1257]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 25 14:55:07 music volumio[1257]: info: Loading plugins from folder /data/plugins/ Dec 25 14:55:07 music volumio[1257]: info: Loading plugin "system"... Dec 25 14:55:07 music volumio[1257]: info: Loading plugin "appearance"... Dec 25 14:55:08 music ntpd[978]: Listen normally on 4 wlan0 192.168.211.1:123 Dec 25 14:55:08 music ntpd[978]: new interface(s) found: waking up resolver Dec 25 14:55:08 music kernel: hwmon hwmon3: Undervoltage detected! Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "network"... Dec 25 14:55:08 music volumio[1257]: info: Refreshing Cached IP Addresses Dec 25 14:55:08 music sudo[1290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 25 14:55:08 music sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:55:08 music sudo[1290]: pam_unix(sudo:session): session closed for user root Dec 25 14:55:08 music sudo[1292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 25 14:55:08 music sudo[1292]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:55:08 music sudo[1292]: pam_unix(sudo:session): session closed for user root Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "services"... Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "alsa_controller"... Dec 25 14:55:08 music sudo[1301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 25 14:55:08 music sudo[1301]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:55:08 music kernel: ieee80211 phy0: brcmf_vif_set_mgmt_ie: vndr ie set error : -52 Dec 25 14:55:08 music kernel: ieee80211 phy0: brcmf_cfg80211_scan: scan error (-52) Dec 25 14:55:08 music sudo[1301]: pam_unix(sudo:session): session closed for user root Dec 25 14:55:08 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "wizard"... Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "networkfs"... Dec 25 14:55:08 music volumio[1257]: info: Starting Udev Watcher for removable devices Dec 25 14:55:08 music sudo[1316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=simon,password=Linux123!@#,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.44.253/simon/music_archive_lossless/ /mnt/NAS/qnap-smp Dec 25 14:55:08 music sudo[1316]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:55:08 music volumio[1257]: info: Ignoring mount for partition: boot Dec 25 14:55:08 music volumio[1257]: info: Ignoring mount for partition: volumio Dec 25 14:55:08 music volumio[1257]: info: Ignoring mount for partition: volumio_data Dec 25 14:55:08 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "volumio_command_line_client"... Dec 25 14:55:08 music volumio[1257]: info: Plugin upnp is not enabled Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "my_music"... Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "mpd"... Dec 25 14:55:08 music kernel: Key type cifs.spnego registered Dec 25 14:55:08 music kernel: Key type cifs.idmap registered Dec 25 14:55:08 music 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. Dec 25 14:55:08 music kernel: CIFS: Attempting to mount //192.168.44.253/simon/music_archive_lossless Dec 25 14:55:08 music volumio[1257]: info: Plugin upnp_browser is not enabled Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "alarm-clock"... Dec 25 14:55:08 music volumio[1257]: info: Plugin airplay_emulation is not enabled Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "last_100"... Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "webradio"... Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "i2s_dacs"... Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "volumiodiscovery"... Dec 25 14:55:08 music volumio[1257]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 25 14:55:08 music node[1257]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 25 14:55:08 music node[1257]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 25 14:55:08 music volumio[1257]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 25 14:55:08 music volumio[1257]: *** WARNING *** For more information see Dec 25 14:55:08 music volumio[1257]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 25 14:55:08 music volumio[1257]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 25 14:55:08 music volumio[1257]: *** WARNING *** For more information see Dec 25 14:55:08 music node[1257]: *** WARNING *** For more information see Dec 25 14:55:08 music node[1257]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 25 14:55:08 music node[1257]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 25 14:55:08 music node[1257]: *** WARNING *** For more information see Dec 25 14:55:08 music volumio[1257]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 25 14:55:08 music volumio[1257]: info: Discovery: Started advertising with name: music Dec 25 14:55:08 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "outputs"... Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "albumart"... Dec 25 14:55:08 music volumio[1257]: info: Plugin example_plugin is not enabled Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "inputs"... Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "updater_comm"... Dec 25 14:55:08 music volumio[1257]: info: Plugin mpdemulation is not enabled Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "rest_api"... Dec 25 14:55:08 music volumio[1257]: info: Loading plugin "websocket"... Dec 25 14:55:08 music volumio[1257]: Forking 3 albumart workers Dec 25 14:55:08 music volumio[1257]: info: Starting Socket.io Server version 2.3.0 Dec 25 14:55:08 music volumio[1257]: info: Loading i18n strings for locale en Dec 25 14:55:08 music volumio[1257]: Updating browse sources language Dec 25 14:55:08 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::initPlayerControls Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 25 14:55:09 music volumio[1257]: Express server listening on port 3000 Dec 25 14:55:09 music volumio[1257]: [Metrics] WebUI: 2s 118.61ms Dec 25 14:55:09 music volumio[1257]: info: CoreStateMachine::resetVolumioState Dec 25 14:55:09 music volumio[1257]: info: CoreStateMachine::getcurrentVolume Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::volumioRetrievevolume Dec 25 14:55:09 music volumio[1257]: info: CoreStateMachine::pushState Dec 25 14:55:09 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 14:55:09 music volumio[1257]: info: CoreCommandRouter::volumioPushState Dec 25 14:55:09 music volumio[1257]: info: Volumio Network Manager: Network status updated: 1 Dec 25 14:55:09 music volumio[1257]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 25 14:55:09 music volumio[1257]: wlan0 Interface doesn't support scanning : Invalid exchange Dec 25 14:55:09 music volumio[1257]: info: Cannot use regular scanning, forcing with ap-force Dec 25 14:55:09 music sudo[1372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 25 14:55:09 music sudo[1372]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 14:55:09 music volumio[1257]: Starting albumart workers Dec 25 14:55:09 music volumio[1257]: Starting albumart workers Dec 25 14:55:09 music volumio[1257]: Starting albumart workers Dec 25 14:55:10 music volumio-remote-updater[859]: [2025-12-25 14:55:10] [connect] Successful connection Dec 25 14:55:12 music dhcpcd[1155]: wlan0: probing for an IPv4LL address Dec 25 14:55:12 music kernel: hwmon hwmon3: Voltage normalised Dec 25 14:55:12 music sudo[1372]: pam_unix(sudo:session): session closed for user root Dec 25 14:55:12 music volumio[1257]: verbose: New Socket.io Connection to 192.168.44.105:3000 from 192.168.44.249 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Dec 25 14:55:12 music volumio-remote-updater[859]: [2025-12-25 14:55:12] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766670910 101 Dec 25 14:55:12 music volumio[1257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Dec 25 14:55:12 music volumio[1257]: verbose: New Socket.io Connection to 192.168.44.109 from 192.168.44.115 UA: Mozilla/5.0 (Linux; Android 15; 24069PC21G Build/AQ3A.240912.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Dec 25 14:55:12 music volumio[1257]: verbose: New Socket.io Connection to 192.168.44.109 from 192.168.44.115 UA: Mozilla/5.0 (Linux; Android 15; 24069PC21G Build/AQ3A.240912.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 14:55:12 music volumio[1257]: info: Reloading queue from file Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 14:55:12 music volumio[1257]: info: Discovery: Getting this device information Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioGetState Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 14:55:12 music volumio[1257]: info: CoreStateMachine::setRepeat null single undefined Dec 25 14:55:12 music volumio[1257]: info: CoreStateMachine::pushState Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioPushState Dec 25 14:55:12 music volumio[1257]: info: CoreStateMachine::setRandom null Dec 25 14:55:12 music volumio[1257]: info: CoreStateMachine::pushState Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioPushState Dec 25 14:55:12 music volumio[1257]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 25 14:55:12 music volumio[1257]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Dec 25 14:55:12 music volumio[1257]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 25 14:55:12 music volumio[1257]: info: Setting Device type: Raspberry PI Dec 25 14:55:12 music volumio[1257]: info: Discovery: adding 13c9312f-d1d6-4265-b382-ad1225ed636d Dec 25 14:55:12 music volumio[1257]: info: Discovery: Found device music Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioGetState Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:12 music volumio[1257]: info: Discovery: adding 55cd1512-98d7-4c9b-9c23-944b5c4141b2 Dec 25 14:55:12 music volumio[1257]: info: Discovery: Found device oliver Dec 25 14:55:12 music volumio[1257]: info: Discovery: Connecting to remote: 192.168.44.249 Dec 25 14:55:12 music volumio[1257]: info: Discovery: this is already registered, 13c9312f-d1d6-4265-b382-ad1225ed636d Dec 25 14:55:12 music volumio[1257]: info: Discovery: Found device music Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioGetState Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:12 music volumio[1257]: verbose: New Socket.io Connection to 192.168.44.109 from 192.168.44.115 UA: Mozilla/5.0 (Linux; Android 15; 24069PC21G Build/AQ3A.240912.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 25 14:55:12 music volumio[1257]: verbose: New Socket.io Connection to 192.168.44.105:3000 from 192.168.44.115 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 25 14:55:12 music volumio[1257]: verbose: New Socket.io Connection to 192.168.44.105:3000 from 192.168.44.115 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 25 14:55:12 music volumio[1257]: info: Received Get System Info Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 14:55:12 music volumio[1257]: info: Discovery: Getting this device information Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioGetState Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioGetState Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioGetVisibleSources Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioGetState Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 25 14:55:12 music volumio[1257]: info: Received Get System Info Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 14:55:12 music volumio[1257]: info: Discovery: Getting this device information Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioGetState Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioGetState Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:12 music volumio[1257]: info: Listing playlists Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioGetQueue Dec 25 14:55:12 music volumio[1257]: info: CoreStateMachine::getQueue Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getQueue Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 14:55:12 music volumio[1257]: info: Discovery: Getting this device information Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::volumioGetState Dec 25 14:55:12 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:12 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 14:55:13 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Dec 25 14:55:13 music volumio[1257]: info: Discovery: Connected to remote: 192.168.44.249 Dec 25 14:55:13 music volumio[1257]: info: CoreCommandRouter::volumioGetState Dec 25 14:55:13 music volumio[1257]: info: CorePlayQueue::getTrack 0 Dec 25 14:55:14 music kernel: hwmon hwmon3: Undervoltage detected! Dec 25 14:55:16 music kernel: hwmon hwmon3: Voltage normalised Dec 25 14:55:17 music dhcpcd[1155]: wlan0: using IPv4LL address 169.254.130.190 Dec 25 14:55:17 music avahi-daemon[867]: Registering new address record for 169.254.130.190 on wlan0.IPv4. Dec 25 14:55:17 music dhcpcd[1155]: wlan0: adding route to 169.254.0.0/16 Dec 25 14:55:18 music systemd[1]: systemd-timedated.service: Succeeded. Dec 25 14:55:18 music kernel: hwmon hwmon3: Undervoltage detected! Dec 25 14:55:19 music ntpd[978]: Listen normally on 5 wlan0 169.254.130.190:123 Dec 25 14:55:19 music ntpd[978]: new interface(s) found: waking up resolver Dec 25 14:55:20 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 25 14:55:20 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 25 14:55:21 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 25 14:55:21 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 25 14:55:22 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 25 14:55:22 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 25 14:55:23 music volumio[1257]: Searching all installed plugins Dec 25 14:55:23 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 25 14:55:23 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: , search Dec 25 14:55:23 music volumio[1257]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 25 14:55:23 music volumio[1257]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 25 14:55:23 music volumio[1257]: TypeError: Cannot read property 'then' of undefined Dec 25 14:55:23 music volumio[1257]: at ControllerMpd.search (/volumio/app/plugins/music_service/mpd/index.js:1601:17) Dec 25 14:55:23 music volumio[1257]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Dec 25 14:55:23 music volumio[1257]: at CoreMusicLibrary.searchOnPlugin (/volumio/app/musiclibrary.js:668:44) Dec 25 14:55:23 music volumio[1257]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:455:27) Dec 25 14:55:23 music volumio[1257]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44) Dec 25 14:55:23 music volumio[1257]: at Socket.emit (events.js:315:20) Dec 25 14:55:23 music volumio[1257]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 25 14:55:23 music volumio[1257]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Dec 25 14:55:23 music volumio[1257]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 25 14:55:23 music sudo[1449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-25 14:54 Dec 25 14:55:23 music sudo[1449]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"