May 27 00:00:44 volumio-hhai kernel: Linux version 6.12.57-volumio (gkkpch@UbuntuVM24.04) (gcc (Ubuntu 13.3.0-6ubuntu2~24.04) 13.3.0, GNU ld (GNU Binutils for Ubuntu) 2.42) #2 SMP PREEMPT_DYNAMIC Thu Nov 13 17:08:37 CET 2025 May 27 00:00:44 volumio-hhai kernel: Command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=989265ff-d248-4f89-8e52-b7555c637af2 bootpart=UUID=DDF4-322F datapart=UUID=e4183fc1-3cea-4235-aefc-fb12bf1a152b hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=native net.ifnames=0 use_kmsg=no May 27 00:00:44 volumio-hhai kernel: KERNEL supported cpus: May 27 00:00:44 volumio-hhai kernel: Intel GenuineIntel May 27 00:00:44 volumio-hhai kernel: AMD AuthenticAMD May 27 00:00:44 volumio-hhai kernel: Hygon HygonGenuine May 27 00:00:44 volumio-hhai kernel: Centaur CentaurHauls May 27 00:00:44 volumio-hhai kernel: zhaoxin Shanghai May 27 00:00:44 volumio-hhai kernel: BIOS-provided physical RAM map: May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x0000000000000000-0x0000000000057fff] usable May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x0000000000058000-0x0000000000058fff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x0000000000059000-0x000000000009efff] usable May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x000000000009f000-0x000000000009ffff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000b7265fff] usable May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000b7266000-0x00000000b726cfff] ACPI NVS May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000b726d000-0x00000000b76bafff] usable May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000b76bb000-0x00000000b7ccbfff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000b7ccc000-0x00000000bcf57fff] usable May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000bcf58000-0x00000000bcfedfff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000bcfee000-0x00000000bd100fff] usable May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000bd101000-0x00000000bd539fff] ACPI NVS May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000bd53a000-0x00000000bdf7ffff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000bdf80000-0x00000000bdffefff] type 20 May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000bdfff000-0x00000000bdffffff] usable May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000bf000000-0x00000000df1fffff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000f8000000-0x00000000fbffffff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000fed00000-0x00000000fed03fff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x00000000ff000000-0x00000000ffffffff] reserved May 27 00:00:44 volumio-hhai kernel: BIOS-e820: [mem 0x0000000100000000-0x000000021fdfffff] usable May 27 00:00:44 volumio-hhai kernel: NX (Execute Disable) protection: active May 27 00:00:44 volumio-hhai kernel: APIC: Static calls initialized May 27 00:00:44 volumio-hhai kernel: efi: EFI v2.3.1 by American Megatrends May 27 00:00:44 volumio-hhai kernel: efi: ESRT=0xbdf7e998 ACPI 2.0=0xbd503000 ACPI=0xbd503000 SMBIOS=0xf05b0 May 27 00:00:44 volumio-hhai kernel: efi: Remove mem247: MMIO range=[0xf8000000-0xfbffffff] (64MB) from e820 map May 27 00:00:44 volumio-hhai kernel: e820: remove [mem 0xf8000000-0xfbffffff] reserved May 27 00:00:44 volumio-hhai kernel: efi: Not removing mem248: MMIO range=[0xfec00000-0xfec00fff] (4KB) from e820 map May 27 00:00:44 volumio-hhai kernel: efi: Not removing mem249: MMIO range=[0xfed00000-0xfed03fff] (16KB) from e820 map May 27 00:00:44 volumio-hhai kernel: efi: Not removing mem250: MMIO range=[0xfed1c000-0xfed1ffff] (16KB) from e820 map May 27 00:00:44 volumio-hhai kernel: efi: Not removing mem251: MMIO range=[0xfee00000-0xfee00fff] (4KB) from e820 map May 27 00:00:44 volumio-hhai kernel: efi: Remove mem252: MMIO range=[0xff000000-0xffffffff] (16MB) from e820 map May 27 00:00:44 volumio-hhai kernel: e820: remove [mem 0xff000000-0xffffffff] reserved May 27 00:00:44 volumio-hhai kernel: SMBIOS 2.8 present. May 27 00:00:44 volumio-hhai kernel: DMI: MSI MS-7851/Z97I AC (MS-7851), BIOS V4.10 02/17/2016 May 27 00:00:44 volumio-hhai kernel: DMI: Memory slots populated: 1/4 May 27 00:00:44 volumio-hhai kernel: tsc: Fast TSC calibration using PIT May 27 00:00:44 volumio-hhai kernel: tsc: Detected 2899.995 MHz processor May 27 00:00:44 volumio-hhai kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved May 27 00:00:44 volumio-hhai kernel: e820: remove [mem 0x000a0000-0x000fffff] usable May 27 00:00:44 volumio-hhai kernel: last_pfn = 0x21fe00 max_arch_pfn = 0x400000000 May 27 00:00:44 volumio-hhai kernel: MTRR map: 9 entries (5 fixed + 4 variable; max 25), built from 10 variable MTRRs May 27 00:00:44 volumio-hhai kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT May 27 00:00:44 volumio-hhai kernel: e820: update [mem 0xbf000000-0xffffffff] usable ==> reserved May 27 00:00:44 volumio-hhai kernel: last_pfn = 0xbe000 max_arch_pfn = 0x400000000 May 27 00:00:44 volumio-hhai kernel: found SMP MP-table at [mem 0x000fd9a0-0x000fd9af] May 27 00:00:44 volumio-hhai kernel: esrt: Reserving ESRT space from 0x00000000bdf7e998 to 0x00000000bdf7e9d0. May 27 00:00:44 volumio-hhai kernel: Using GB pages for direct mapping May 27 00:00:44 volumio-hhai kernel: Secure boot could not be determined May 27 00:00:44 volumio-hhai kernel: RAMDISK: [mem 0x2e241000-0x33117fff] May 27 00:00:44 volumio-hhai kernel: ACPI: Early table checksum verification disabled May 27 00:00:44 volumio-hhai kernel: ACPI: RSDP 0x00000000BD503000 000024 (v02 ALASKA) May 27 00:00:44 volumio-hhai kernel: ACPI: XSDT 0x00000000BD503088 000094 (v01 ALASKA A M I 01072009 AMI 00010013) May 27 00:00:44 volumio-hhai kernel: ACPI: FACP 0x00000000BD515B08 00010C (v05 ALASKA A M I 01072009 AMI 00010013) May 27 00:00:44 volumio-hhai kernel: ACPI: DSDT 0x00000000BD5031B8 01294F (v02 ALASKA A M I 00000023 INTL 20120711) May 27 00:00:44 volumio-hhai kernel: ACPI: FACS 0x00000000BD539F80 000040 May 27 00:00:44 volumio-hhai kernel: ACPI: APIC 0x00000000BD515C18 000062 (v03 ALASKA A M I 01072009 AMI 00010013) May 27 00:00:44 volumio-hhai kernel: ACPI: FPDT 0x00000000BD515C80 000044 (v01 ALASKA A M I 01072009 AMI 00010013) May 27 00:00:44 volumio-hhai kernel: ACPI: FIDT 0x00000000BD515CC8 00009C (v01 ALASKA A M I 01072009 AMI 00010013) May 27 00:00:44 volumio-hhai kernel: ACPI: ASF! 0x00000000BD515D68 0000A5 (v32 INTEL HCG 00000001 TFSM 000F4240) May 27 00:00:44 volumio-hhai kernel: ACPI: SSDT 0x00000000BD515E10 000C7D (v02 Ther_R Ther_Rvp 00001000 INTL 20120711) May 27 00:00:44 volumio-hhai kernel: ACPI: SSDT 0x00000000BD516A90 000B74 (v02 CpuRef CpuSsdt 00003000 INTL 20051117) May 27 00:00:44 volumio-hhai kernel: ACPI: MCFG 0x00000000BD517608 00003C (v01 ALASKA A M I 01072009 MSFT 00000097) May 27 00:00:44 volumio-hhai kernel: ACPI: HPET 0x00000000BD517648 000038 (v01 ALASKA A M I 01072009 AMI. 00000005) May 27 00:00:44 volumio-hhai kernel: ACPI: SSDT 0x00000000BD517680 00036D (v01 SataRe SataTabl 00001000 INTL 20120711) May 27 00:00:44 volumio-hhai kernel: ACPI: SSDT 0x00000000BD5179F0 005835 (v02 SaSsdt SaSsdt 00003000 INTL 20120711) May 27 00:00:44 volumio-hhai kernel: ACPI: UEFI 0x00000000BD51D228 000042 (v01 ALASKA A M I 01072009 00000000) May 27 00:00:44 volumio-hhai kernel: ACPI: DMAR 0x00000000BD51D270 0000B8 (v01 INTEL BDW 00000001 INTL 00000001) May 27 00:00:44 volumio-hhai kernel: ACPI: BGRT 0x00000000BD51D328 000038 (v01 ALASKA A M I 01072009 AMI 00010013) May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving FACP table memory at [mem 0xbd515b08-0xbd515c13] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving DSDT table memory at [mem 0xbd5031b8-0xbd515b06] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving FACS table memory at [mem 0xbd539f80-0xbd539fbf] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving APIC table memory at [mem 0xbd515c18-0xbd515c79] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving FPDT table memory at [mem 0xbd515c80-0xbd515cc3] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving FIDT table memory at [mem 0xbd515cc8-0xbd515d63] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving ASF! table memory at [mem 0xbd515d68-0xbd515e0c] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving SSDT table memory at [mem 0xbd515e10-0xbd516a8c] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving SSDT table memory at [mem 0xbd516a90-0xbd517603] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving MCFG table memory at [mem 0xbd517608-0xbd517643] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving HPET table memory at [mem 0xbd517648-0xbd51767f] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving SSDT table memory at [mem 0xbd517680-0xbd5179ec] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving SSDT table memory at [mem 0xbd5179f0-0xbd51d224] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving UEFI table memory at [mem 0xbd51d228-0xbd51d269] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving DMAR table memory at [mem 0xbd51d270-0xbd51d327] May 27 00:00:44 volumio-hhai kernel: ACPI: Reserving BGRT table memory at [mem 0xbd51d328-0xbd51d35f] May 27 00:00:44 volumio-hhai kernel: Zone ranges: May 27 00:00:44 volumio-hhai kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] May 27 00:00:44 volumio-hhai kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] May 27 00:00:44 volumio-hhai kernel: Normal [mem 0x0000000100000000-0x000000021fdfffff] May 27 00:00:44 volumio-hhai kernel: Movable zone start for each node May 27 00:00:44 volumio-hhai kernel: Early memory node ranges May 27 00:00:44 volumio-hhai kernel: node 0: [mem 0x0000000000001000-0x0000000000057fff] May 27 00:00:44 volumio-hhai kernel: node 0: [mem 0x0000000000059000-0x000000000009efff] May 27 00:00:44 volumio-hhai kernel: node 0: [mem 0x0000000000100000-0x00000000b7265fff] May 27 00:00:44 volumio-hhai kernel: node 0: [mem 0x00000000b726d000-0x00000000b76bafff] May 27 00:00:44 volumio-hhai kernel: node 0: [mem 0x00000000b7ccc000-0x00000000bcf57fff] May 27 00:00:44 volumio-hhai kernel: node 0: [mem 0x00000000bcfee000-0x00000000bd100fff] May 27 00:00:44 volumio-hhai kernel: node 0: [mem 0x00000000bdfff000-0x00000000bdffffff] May 27 00:00:44 volumio-hhai kernel: node 0: [mem 0x0000000100000000-0x000000021fdfffff] May 27 00:00:44 volumio-hhai kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000021fdfffff] May 27 00:00:44 volumio-hhai kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 27 00:00:44 volumio-hhai kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 27 00:00:44 volumio-hhai kernel: On node 0, zone DMA: 97 pages in unavailable ranges May 27 00:00:44 volumio-hhai kernel: On node 0, zone DMA32: 7 pages in unavailable ranges May 27 00:00:44 volumio-hhai kernel: On node 0, zone DMA32: 1553 pages in unavailable ranges May 27 00:00:44 volumio-hhai kernel: On node 0, zone DMA32: 150 pages in unavailable ranges May 27 00:00:44 volumio-hhai kernel: On node 0, zone DMA32: 3838 pages in unavailable ranges May 27 00:00:44 volumio-hhai kernel: On node 0, zone Normal: 8192 pages in unavailable ranges May 27 00:00:44 volumio-hhai kernel: On node 0, zone Normal: 512 pages in unavailable ranges May 27 00:00:44 volumio-hhai kernel: Reserving Intel graphics memory at [mem 0xbf200000-0xdf1fffff] May 27 00:00:44 volumio-hhai kernel: ACPI: PM-Timer IO Port: 0x1808 May 27 00:00:44 volumio-hhai kernel: ACPI: LAPIC_NMI (acpi_id[0xff] high edge lint[0x1]) May 27 00:00:44 volumio-hhai kernel: IOAPIC[0]: apic_id 8, version 32, address 0xfec00000, GSI 0-23 May 27 00:00:44 volumio-hhai kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) May 27 00:00:44 volumio-hhai kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) May 27 00:00:44 volumio-hhai kernel: ACPI: Using ACPI (MADT) for SMP configuration information May 27 00:00:44 volumio-hhai kernel: ACPI: HPET id: 0x8086a701 base: 0xfed00000 May 27 00:00:44 volumio-hhai kernel: e820: update [mem 0xb67e8000-0xb6a28fff] usable ==> reserved May 27 00:00:44 volumio-hhai kernel: [Firmware Bug]: TSC_DEADLINE disabled due to Errata; please update microcode to version: 0x22 (or later) May 27 00:00:44 volumio-hhai kernel: CPU topo: Max. logical packages: 1 May 27 00:00:44 volumio-hhai kernel: CPU topo: Max. logical dies: 1 May 27 00:00:44 volumio-hhai kernel: CPU topo: Max. dies per package: 1 May 27 00:00:44 volumio-hhai kernel: CPU topo: Max. threads per core: 1 May 27 00:00:44 volumio-hhai kernel: CPU topo: Num. cores per package: 2 May 27 00:00:44 volumio-hhai kernel: CPU topo: Num. threads per package: 2 May 27 00:00:44 volumio-hhai kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs May 27 00:00:44 volumio-hhai kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] May 27 00:00:44 volumio-hhai kernel: PM: hibernation: Registered nosave memory: [mem 0x00058000-0x00058fff] May 27 00:00:44 volumio-hhai kernel: PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] May 27 00:00:44 volumio-hhai kernel: PM: hibernation: Registered nosave memory: [mem 0xb67e8000-0xb6a28fff] May 27 00:00:44 volumio-hhai kernel: PM: hibernation: Registered nosave memory: [mem 0xb7266000-0xb726cfff] May 27 00:00:44 volumio-hhai kernel: PM: hibernation: Registered nosave memory: [mem 0xb76bb000-0xb7ccbfff] May 27 00:00:44 volumio-hhai kernel: PM: hibernation: Registered nosave memory: [mem 0xbcf58000-0xbcfedfff] May 27 00:00:44 volumio-hhai kernel: PM: hibernation: Registered nosave memory: [mem 0xbd101000-0xbdffefff] May 27 00:00:44 volumio-hhai kernel: PM: hibernation: Registered nosave memory: [mem 0xbe000000-0xffffffff] May 27 00:00:44 volumio-hhai kernel: [mem 0xdf200000-0xfebfffff] available for PCI devices May 27 00:00:44 volumio-hhai kernel: Booting paravirtualized kernel on bare hardware May 27 00:00:44 volumio-hhai kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns May 27 00:00:44 volumio-hhai kernel: setup_percpu: NR_CPUS:64 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 May 27 00:00:44 volumio-hhai kernel: percpu: Embedded 59 pages/cpu s201368 r8192 d32104 u1048576 May 27 00:00:44 volumio-hhai kernel: pcpu-alloc: s201368 r8192 d32104 u1048576 alloc=1*2097152 May 27 00:00:44 volumio-hhai kernel: pcpu-alloc: [0] 0 1 May 27 00:00:44 volumio-hhai kernel: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=989265ff-d248-4f89-8e52-b7555c637af2 bootpart=UUID=DDF4-322F datapart=UUID=e4183fc1-3cea-4235-aefc-fb12bf1a152b hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=native net.ifnames=0 use_kmsg=no May 27 00:00:44 volumio-hhai kernel: Unknown kernel command line parameters "splash bootdelay=5 biosdevname=0 imgpart=UUID=989265ff-d248-4f89-8e52-b7555c637af2 bootpart=UUID=DDF4-322F datapart=UUID=e4183fc1-3cea-4235-aefc-fb12bf1a152b hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh use_kmsg=no", will be passed to user space. May 27 00:00:44 volumio-hhai kernel: random: crng init done May 27 00:00:44 volumio-hhai kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) May 27 00:00:44 volumio-hhai kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 27 00:00:44 volumio-hhai kernel: Built 1 zonelists, mobility grouping on. Total pages: 1951729 May 27 00:00:44 volumio-hhai kernel: mem auto-init: stack:all(pattern), heap alloc:off, heap free:off May 27 00:00:44 volumio-hhai kernel: software IO TLB: area num 2. May 27 00:00:44 volumio-hhai kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 May 27 00:00:44 volumio-hhai kernel: Kernel/User page tables isolation: enabled May 27 00:00:44 volumio-hhai kernel: ftrace: allocating 43851 entries in 172 pages May 27 00:00:44 volumio-hhai kernel: ftrace: allocated 172 pages with 4 groups May 27 00:00:44 volumio-hhai kernel: Dynamic Preempt: voluntary May 27 00:00:44 volumio-hhai kernel: rcu: Preemptible hierarchical RCU implementation. May 27 00:00:44 volumio-hhai kernel: rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=2. May 27 00:00:44 volumio-hhai kernel: Trampoline variant of Tasks RCU enabled. May 27 00:00:44 volumio-hhai kernel: Rude variant of Tasks RCU enabled. May 27 00:00:44 volumio-hhai kernel: Tracing variant of Tasks RCU enabled. May 27 00:00:44 volumio-hhai kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. May 27 00:00:44 volumio-hhai kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 May 27 00:00:44 volumio-hhai kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 27 00:00:44 volumio-hhai kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 27 00:00:44 volumio-hhai kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 27 00:00:44 volumio-hhai kernel: NR_IRQS: 4352, nr_irqs: 440, preallocated irqs: 16 May 27 00:00:44 volumio-hhai kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 27 00:00:44 volumio-hhai kernel: Console: colour dummy device 80x25 May 27 00:00:44 volumio-hhai kernel: printk: legacy console [tty0] enabled May 27 00:00:44 volumio-hhai kernel: ACPI: Core revision 20240827 May 27 00:00:44 volumio-hhai kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 133484882848 ns May 27 00:00:44 volumio-hhai kernel: APIC: Switch to symmetric I/O mode setup May 27 00:00:44 volumio-hhai kernel: x2apic: IRQ remapping doesn't support X2APIC mode May 27 00:00:44 volumio-hhai kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=0 pin2=0 May 27 00:00:44 volumio-hhai kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x29cd3e36b6e, max_idle_ns: 440795243774 ns May 27 00:00:44 volumio-hhai kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 5799.99 BogoMIPS (lpj=11599980) May 27 00:00:44 volumio-hhai kernel: CPU0: Thermal monitoring enabled (TM1) May 27 00:00:44 volumio-hhai kernel: Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024 May 27 00:00:44 volumio-hhai kernel: Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4 May 27 00:00:44 volumio-hhai kernel: process: using mwait in idle threads May 27 00:00:44 volumio-hhai kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization May 27 00:00:44 volumio-hhai kernel: Spectre V2 : Mitigation: Retpolines May 27 00:00:44 volumio-hhai kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT May 27 00:00:44 volumio-hhai kernel: Speculative Store Bypass: Vulnerable May 27 00:00:44 volumio-hhai kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode May 27 00:00:44 volumio-hhai kernel: MMIO Stale Data: Unknown: No mitigations May 27 00:00:44 volumio-hhai kernel: SRBDS: Vulnerable: No microcode May 27 00:00:44 volumio-hhai kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' May 27 00:00:44 volumio-hhai kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' May 27 00:00:44 volumio-hhai kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' May 27 00:00:44 volumio-hhai kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 May 27 00:00:44 volumio-hhai kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. May 27 00:00:44 volumio-hhai kernel: Freeing SMP alternatives memory: 36K May 27 00:00:44 volumio-hhai kernel: pid_max: default: 32768 minimum: 301 May 27 00:00:44 volumio-hhai kernel: LSM: initializing lsm=capability,yama May 27 00:00:44 volumio-hhai kernel: Yama: becoming mindful. May 27 00:00:44 volumio-hhai kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) May 27 00:00:44 volumio-hhai kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) May 27 00:00:44 volumio-hhai kernel: smpboot: CPU0: Intel(R) Core(TM) i5-4570T CPU @ 2.90GHz (family: 0x6, model: 0x3c, stepping: 0x3) May 27 00:00:44 volumio-hhai kernel: Performance Events: PEBS fmt2+, Haswell events, 16-deep LBR, full-width counters, Intel PMU driver. May 27 00:00:44 volumio-hhai kernel: ... version: 3 May 27 00:00:44 volumio-hhai kernel: ... bit width: 48 May 27 00:00:44 volumio-hhai kernel: ... generic registers: 8 May 27 00:00:44 volumio-hhai kernel: ... value mask: 0000ffffffffffff May 27 00:00:44 volumio-hhai kernel: ... max period: 00007fffffffffff May 27 00:00:44 volumio-hhai kernel: ... fixed-purpose events: 3 May 27 00:00:44 volumio-hhai kernel: ... event mask: 00000007000000ff May 27 00:00:44 volumio-hhai kernel: signal: max sigframe size: 1776 May 27 00:00:44 volumio-hhai kernel: Estimated ratio of average max frequency by base frequency (times 1024): 1024 May 27 00:00:44 volumio-hhai kernel: rcu: Hierarchical SRCU implementation. May 27 00:00:44 volumio-hhai kernel: rcu: Max phase no-delay instances is 1000. May 27 00:00:44 volumio-hhai kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level May 27 00:00:44 volumio-hhai kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. May 27 00:00:44 volumio-hhai kernel: smp: Bringing up secondary CPUs ... May 27 00:00:44 volumio-hhai kernel: smpboot: x86: Booting SMP configuration: May 27 00:00:44 volumio-hhai kernel: .... node #0, CPUs: #1 May 27 00:00:44 volumio-hhai kernel: smp: Brought up 1 node, 2 CPUs May 27 00:00:44 volumio-hhai kernel: smpboot: Total of 2 processors activated (11599.98 BogoMIPS) May 27 00:00:44 volumio-hhai kernel: Memory: 7485964K/7806916K available (16384K kernel code, 2032K rwdata, 5320K rodata, 3128K init, 840K bss, 314372K reserved, 0K cma-reserved) May 27 00:00:44 volumio-hhai kernel: devtmpfs: initialized May 27 00:00:44 volumio-hhai kernel: x86/mm: Memory block size: 128MB May 27 00:00:44 volumio-hhai kernel: ACPI: PM: Registering ACPI NVS region [mem 0xb7266000-0xb726cfff] (28672 bytes) May 27 00:00:44 volumio-hhai kernel: ACPI: PM: Registering ACPI NVS region [mem 0xbd101000-0xbd539fff] (4427776 bytes) May 27 00:00:44 volumio-hhai kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns May 27 00:00:44 volumio-hhai kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) May 27 00:00:44 volumio-hhai kernel: pinctrl core: initialized pinctrl subsystem May 27 00:00:44 volumio-hhai kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 27 00:00:44 volumio-hhai kernel: audit: initializing netlink subsys (disabled) May 27 00:00:44 volumio-hhai kernel: audit: type=2000 audit(1779814831.000:1): state=initialized audit_enabled=0 res=1 May 27 00:00:44 volumio-hhai kernel: thermal_sys: Registered thermal governor 'fair_share' May 27 00:00:44 volumio-hhai kernel: thermal_sys: Registered thermal governor 'bang_bang' May 27 00:00:44 volumio-hhai kernel: thermal_sys: Registered thermal governor 'step_wise' May 27 00:00:44 volumio-hhai kernel: thermal_sys: Registered thermal governor 'user_space' May 27 00:00:44 volumio-hhai kernel: cpuidle: using governor ladder May 27 00:00:44 volumio-hhai kernel: cpuidle: using governor menu May 27 00:00:44 volumio-hhai kernel: ACPI FADT declares the system doesn't support PCIe ASPM, so disable it May 27 00:00:44 volumio-hhai kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 27 00:00:44 volumio-hhai kernel: PCI: ECAM [mem 0xf8000000-0xfbffffff] (base 0xf8000000) for domain 0000 [bus 00-3f] May 27 00:00:44 volumio-hhai kernel: PCI: Using configuration type 1 for base access May 27 00:00:44 volumio-hhai kernel: core: PMU erratum BJ122, BV98, HSD29 workaround disabled, HT off May 27 00:00:44 volumio-hhai kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 27 00:00:44 volumio-hhai kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 27 00:00:44 volumio-hhai kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page May 27 00:00:44 volumio-hhai kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 27 00:00:44 volumio-hhai kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page May 27 00:00:44 volumio-hhai kernel: ACPI: Added _OSI(Module Device) May 27 00:00:44 volumio-hhai kernel: ACPI: Added _OSI(Processor Device) May 27 00:00:44 volumio-hhai kernel: ACPI: Added _OSI(Processor Aggregator Device) May 27 00:00:44 volumio-hhai kernel: ACPI: 5 ACPI AML tables successfully acquired and loaded May 27 00:00:44 volumio-hhai kernel: ACPI: [Firmware Bug]: BIOS _OSI(Linux) query ignored May 27 00:00:44 volumio-hhai kernel: ACPI: Dynamic OEM Table Load: May 27 00:00:44 volumio-hhai kernel: ACPI: SSDT 0xFFFF8881002C6C00 0003D3 (v02 PmRef Cpu0Cst 00003001 INTL 20051117) May 27 00:00:44 volumio-hhai kernel: ACPI: Dynamic OEM Table Load: May 27 00:00:44 volumio-hhai kernel: ACPI: SSDT 0xFFFF888100264200 000119 (v02 PmRef ApCst 00003000 INTL 20051117) May 27 00:00:44 volumio-hhai kernel: ACPI: Interpreter enabled May 27 00:00:44 volumio-hhai kernel: ACPI: PM: (supports S0 S3 S4 S5) May 27 00:00:44 volumio-hhai kernel: ACPI: Using IOAPIC for interrupt routing May 27 00:00:44 volumio-hhai kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug May 27 00:00:44 volumio-hhai kernel: PCI: Using E820 reservations for host bridge windows May 27 00:00:44 volumio-hhai kernel: ACPI: Enabled 9 GPEs in block 00 to 3F May 27 00:00:44 volumio-hhai kernel: ACPI: \_SB_.PCI0.PEG0.PG00: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_SB_.PCI0.PEG1.PG01: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_SB_.PCI0.PEG2.PG02: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_SB_.PCI0.RP01.PXSX.WRST: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_SB_.PCI0.RP02.PXSX.WRST: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_SB_.PCI0.RP03.PXSX.WRST: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_SB_.PCI0.RP04.PXSX.WRST: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_SB_.PCI0.RP05.PXSX.WRST: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_SB_.PCI0.RP06.PXSX.WRST: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_SB_.PCI0.RP07.PXSX.WRST: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_SB_.PCI0.RP08.PXSX.WRST: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_TZ_.FN00: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_TZ_.FN01: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_TZ_.FN02: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_TZ_.FN03: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: \_TZ_.FN04: New power resource May 27 00:00:44 volumio-hhai kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-3e]) May 27 00:00:44 volumio-hhai kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 27 00:00:44 volumio-hhai kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug SHPCHotplug PME] May 27 00:00:44 volumio-hhai kernel: acpi PNP0A08:00: _OSC: OS now controls [AER PCIeCapability LTR] May 27 00:00:44 volumio-hhai kernel: acpi PNP0A08:00: FADT indicates ASPM is unsupported, using BIOS configuration May 27 00:00:44 volumio-hhai kernel: acpi PNP0A08:00: host bridge window expanded to [mem 0xdf200000-0xfeafffff window]; [mem 0xfe101000-0xfe113fff window] ignored May 27 00:00:44 volumio-hhai kernel: PCI host bridge to bus 0000:00 May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: root bus resource [mem 0x000d0000-0x000dffff window] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: root bus resource [mem 0xdf200000-0xfeafffff window] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: root bus resource [bus 00-3e] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:00.0: [8086:0c00] type 00 class 0x060000 conventional PCI endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:00:01.0: [8086:0c01] type 01 class 0x060400 PCIe Root Port May 27 00:00:44 volumio-hhai kernel: pci 0000:00:01.0: PCI bridge to [bus 01] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:01.0: bridge window [mem 0xf7b00000-0xf7bfffff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:01.0: PME# supported from D0 D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:02.0: [8086:0412] type 00 class 0x030000 conventional PCI endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:00:02.0: BAR 0 [mem 0xf7400000-0xf77fffff 64bit] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:02.0: BAR 2 [mem 0xe0000000-0xefffffff 64bit pref] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:02.0: BAR 4 [io 0xf000-0xf03f] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:03.0: [8086:0c0c] type 00 class 0x040300 PCIe Root Complex Integrated Endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:00:03.0: BAR 0 [mem 0xf7c10000-0xf7c13fff 64bit] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:14.0: [8086:8cb1] type 00 class 0x0c0330 conventional PCI endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:00:14.0: BAR 0 [mem 0xf7c00000-0xf7c0ffff 64bit] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:14.0: PME# supported from D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:16.0: [8086:8cba] type 00 class 0x078000 conventional PCI endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:00:16.0: BAR 0 [mem 0xf7c19000-0xf7c1900f 64bit] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:16.0: PME# supported from D0 D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1a.0: [8086:8cad] type 00 class 0x0c0320 conventional PCI endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1a.0: BAR 0 [mem 0xf7c17000-0xf7c173ff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1a.0: PME# supported from D0 D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.0: [8086:8c90] type 01 class 0x060400 PCIe Root Port May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.0: PCI bridge to [bus 02] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.2: [8086:8c94] type 01 class 0x060400 PCIe Root Port May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.2: PCI bridge to [bus 03] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.2: bridge window [io 0xe000-0xefff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.2: bridge window [mem 0xf7a00000-0xf7afffff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.2: bridge window [mem 0xf0100000-0xf01fffff 64bit pref] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.3: [8086:8c96] type 01 class 0x060400 PCIe Root Port May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.3: PCI bridge to [bus 04] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.3: bridge window [io 0xd000-0xdfff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.3: bridge window [mem 0xf7900000-0xf79fffff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.3: bridge window [mem 0xf0000000-0xf00fffff 64bit pref] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.4: [8086:8c98] type 01 class 0x060400 PCIe Root Port May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.4: PCI bridge to [bus 05] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.4: bridge window [mem 0xf7800000-0xf78fffff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.4: PME# supported from D0 D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1d.0: [8086:8ca6] type 00 class 0x0c0320 conventional PCI endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1d.0: BAR 0 [mem 0xf7c16000-0xf7c163ff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1d.0: PME# supported from D0 D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.0: [8086:8cc4] type 00 class 0x060100 conventional PCI endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.2: [8086:8c82] type 00 class 0x010601 conventional PCI endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.2: BAR 0 [io 0xf0b0-0xf0b7] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.2: BAR 1 [io 0xf0a0-0xf0a3] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.2: BAR 2 [io 0xf090-0xf097] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.2: BAR 3 [io 0xf080-0xf083] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.2: BAR 4 [io 0xf060-0xf07f] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.2: BAR 5 [mem 0xf7c15000-0xf7c157ff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.2: PME# supported from D3hot May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.3: [8086:8ca2] type 00 class 0x0c0500 conventional PCI endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.3: BAR 0 [mem 0xf7c14000-0xf7c140ff 64bit] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1f.3: BAR 4 [io 0xf040-0xf05f] May 27 00:00:44 volumio-hhai kernel: pci 0000:01:00.0: [104c:8241] type 00 class 0x0c0330 PCIe Endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:01:00.0: BAR 0 [mem 0xf7b00000-0xf7b0ffff 64bit] May 27 00:00:44 volumio-hhai kernel: pci 0000:01:00.0: BAR 2 [mem 0xf7b10000-0xf7b11fff 64bit] May 27 00:00:44 volumio-hhai kernel: pci 0000:01:00.0: supports D1 D2 May 27 00:00:44 volumio-hhai kernel: pci 0000:01:00.0: PME# supported from D0 D1 D2 D3hot May 27 00:00:44 volumio-hhai kernel: pci 0000:00:01.0: PCI bridge to [bus 01] May 27 00:00:44 volumio-hhai kernel: acpiphp: Slot [1] registered May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.0: PCI bridge to [bus 02] May 27 00:00:44 volumio-hhai kernel: pci 0000:03:00.0: [10ec:8168] type 00 class 0x020000 PCIe Endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:03:00.0: BAR 0 [io 0xe000-0xe0ff] May 27 00:00:44 volumio-hhai kernel: pci 0000:03:00.0: BAR 2 [mem 0xf7a00000-0xf7a00fff 64bit] May 27 00:00:44 volumio-hhai kernel: pci 0000:03:00.0: BAR 4 [mem 0xf0100000-0xf0103fff 64bit pref] May 27 00:00:44 volumio-hhai kernel: pci 0000:03:00.0: supports D1 D2 May 27 00:00:44 volumio-hhai kernel: pci 0000:03:00.0: PME# supported from D0 D1 D2 D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.2: PCI bridge to [bus 03] May 27 00:00:44 volumio-hhai kernel: pci 0000:04:00.0: [10ec:8168] type 00 class 0x020000 PCIe Endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:04:00.0: BAR 0 [io 0xd000-0xd0ff] May 27 00:00:44 volumio-hhai kernel: pci 0000:04:00.0: BAR 2 [mem 0xf7900000-0xf7900fff 64bit] May 27 00:00:44 volumio-hhai kernel: pci 0000:04:00.0: BAR 4 [mem 0xf0000000-0xf0003fff 64bit pref] May 27 00:00:44 volumio-hhai kernel: pci 0000:04:00.0: supports D1 D2 May 27 00:00:44 volumio-hhai kernel: pci 0000:04:00.0: PME# supported from D0 D1 D2 D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.3: PCI bridge to [bus 04] May 27 00:00:44 volumio-hhai kernel: pci 0000:05:00.0: [8086:08b1] type 00 class 0x028000 PCIe Endpoint May 27 00:00:44 volumio-hhai kernel: pci 0000:05:00.0: BAR 0 [mem 0xf7800000-0xf7801fff 64bit] May 27 00:00:44 volumio-hhai kernel: pci 0000:05:00.0: PME# supported from D0 D3hot D3cold May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.4: PCI bridge to [bus 05] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: on NUMA node 0 May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 11 May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 0 May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKB disabled May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 3 May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 5 May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 0 May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKE disabled May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 0 May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKF disabled May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 0 May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKG disabled May 27 00:00:44 volumio-hhai kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 May 27 00:00:44 volumio-hhai kernel: iommu: Default domain type: Translated May 27 00:00:44 volumio-hhai kernel: iommu: DMA domain TLB invalidation policy: lazy mode May 27 00:00:44 volumio-hhai kernel: SCSI subsystem initialized May 27 00:00:44 volumio-hhai kernel: libata version 3.00 loaded. May 27 00:00:44 volumio-hhai kernel: ACPI: bus type USB registered May 27 00:00:44 volumio-hhai kernel: usbcore: registered new interface driver usbfs May 27 00:00:44 volumio-hhai kernel: usbcore: registered new interface driver hub May 27 00:00:44 volumio-hhai kernel: usbcore: registered new device driver usb May 27 00:00:44 volumio-hhai kernel: efivars: Registered efivars operations May 27 00:00:44 volumio-hhai kernel: PCI: Using ACPI for IRQ routing May 27 00:00:44 volumio-hhai kernel: PCI: pci_cache_line_size set to 64 bytes May 27 00:00:44 volumio-hhai kernel: e820: reserve RAM buffer [mem 0x00058000-0x0005ffff] May 27 00:00:44 volumio-hhai kernel: e820: reserve RAM buffer [mem 0x0009f000-0x0009ffff] May 27 00:00:44 volumio-hhai kernel: e820: reserve RAM buffer [mem 0xb67e8000-0xb7ffffff] May 27 00:00:44 volumio-hhai kernel: e820: reserve RAM buffer [mem 0xb7266000-0xb7ffffff] May 27 00:00:44 volumio-hhai kernel: e820: reserve RAM buffer [mem 0xb76bb000-0xb7ffffff] May 27 00:00:44 volumio-hhai kernel: e820: reserve RAM buffer [mem 0xbcf58000-0xbfffffff] May 27 00:00:44 volumio-hhai kernel: e820: reserve RAM buffer [mem 0xbd101000-0xbfffffff] May 27 00:00:44 volumio-hhai kernel: e820: reserve RAM buffer [mem 0xbe000000-0xbfffffff] May 27 00:00:44 volumio-hhai kernel: e820: reserve RAM buffer [mem 0x21fe00000-0x21fffffff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device May 27 00:00:44 volumio-hhai kernel: pci 0000:00:02.0: vgaarb: bridge control possible May 27 00:00:44 volumio-hhai kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none May 27 00:00:44 volumio-hhai kernel: vgaarb: loaded May 27 00:00:44 volumio-hhai kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0 May 27 00:00:44 volumio-hhai kernel: hpet0: 8 comparators, 64-bit 14.318180 MHz counter May 27 00:00:44 volumio-hhai kernel: clocksource: Switched to clocksource tsc-early May 27 00:00:44 volumio-hhai kernel: VFS: Disk quotas dquot_6.6.0 May 27 00:00:44 volumio-hhai kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 27 00:00:44 volumio-hhai kernel: pnp: PnP ACPI init May 27 00:00:44 volumio-hhai kernel: system 00:00: [mem 0xfed40000-0xfed44fff] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:01: [io 0x0800-0x087f] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:03: [io 0x0a00-0x0a0f] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:03: [io 0x0a10-0x0a1f] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:03: [io 0x0a20-0x0a2f] has been reserved May 27 00:00:44 volumio-hhai kernel: pnp 00:04: [dma 0 disabled] May 27 00:00:44 volumio-hhai kernel: system 00:05: [io 0x04d0-0x04d1] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xfed1c000-0xfed1ffff] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xfed10000-0xfed17fff] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xfed18000-0xfed18fff] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xfed19000-0xfed19fff] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xf8000000-0xfbffffff] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xfed20000-0xfed3ffff] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xfed90000-0xfed93fff] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xfed45000-0xfed8ffff] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xff000000-0xffffffff] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xfee00000-0xfeefffff] could not be reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xf7fe0000-0xf7feffff] has been reserved May 27 00:00:44 volumio-hhai kernel: system 00:06: [mem 0xf7ff0000-0xf7ffffff] has been reserved May 27 00:00:44 volumio-hhai kernel: pnp: PnP ACPI: found 7 devices May 27 00:00:44 volumio-hhai kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns May 27 00:00:44 volumio-hhai kernel: NET: Registered PF_INET protocol family May 27 00:00:44 volumio-hhai kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) May 27 00:00:44 volumio-hhai kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) May 27 00:00:44 volumio-hhai kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 27 00:00:44 volumio-hhai kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) May 27 00:00:44 volumio-hhai kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) May 27 00:00:44 volumio-hhai kernel: TCP: Hash tables configured (established 65536 bind 65536) May 27 00:00:44 volumio-hhai kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) May 27 00:00:44 volumio-hhai kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) May 27 00:00:44 volumio-hhai kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 27 00:00:44 volumio-hhai kernel: pci 0000:00:01.0: PCI bridge to [bus 01] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:01.0: bridge window [mem 0xf7b00000-0xf7bfffff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.0: PCI bridge to [bus 02] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.2: PCI bridge to [bus 03] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.2: bridge window [io 0xe000-0xefff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.2: bridge window [mem 0xf7a00000-0xf7afffff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.2: bridge window [mem 0xf0100000-0xf01fffff 64bit pref] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.3: PCI bridge to [bus 04] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.3: bridge window [io 0xd000-0xdfff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.3: bridge window [mem 0xf7900000-0xf79fffff] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.3: bridge window [mem 0xf0000000-0xf00fffff 64bit pref] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.4: PCI bridge to [bus 05] May 27 00:00:44 volumio-hhai kernel: pci 0000:00:1c.4: bridge window [mem 0xf7800000-0xf78fffff] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: resource 7 [mem 0x000d0000-0x000dffff window] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:00: resource 8 [mem 0xdf200000-0xfeafffff window] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:01: resource 1 [mem 0xf7b00000-0xf7bfffff] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:03: resource 0 [io 0xe000-0xefff] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:03: resource 1 [mem 0xf7a00000-0xf7afffff] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:03: resource 2 [mem 0xf0100000-0xf01fffff 64bit pref] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:04: resource 0 [io 0xd000-0xdfff] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:04: resource 1 [mem 0xf7900000-0xf79fffff] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:04: resource 2 [mem 0xf0000000-0xf00fffff 64bit pref] May 27 00:00:44 volumio-hhai kernel: pci_bus 0000:05: resource 1 [mem 0xf7800000-0xf78fffff] May 27 00:00:44 volumio-hhai kernel: PCI: CLS 64 bytes, default 64 May 27 00:00:44 volumio-hhai kernel: DMAR: Host address width 39 May 27 00:00:44 volumio-hhai kernel: DMAR: DRHD base: 0x000000fed90000 flags: 0x0 May 27 00:00:44 volumio-hhai kernel: DMAR: dmar0: reg_base_addr fed90000 ver 1:0 cap c0000020660462 ecap f0101a May 27 00:00:44 volumio-hhai kernel: DMAR: DRHD base: 0x000000fed91000 flags: 0x1 May 27 00:00:44 volumio-hhai kernel: DMAR: dmar1: reg_base_addr fed91000 ver 1:0 cap d2008c20660462 ecap f010da May 27 00:00:44 volumio-hhai kernel: DMAR: RMRR base: 0x000000bdea4000 end: 0x000000bdeb3fff May 27 00:00:44 volumio-hhai kernel: DMAR: RMRR base: 0x000000bf000000 end: 0x000000df1fffff May 27 00:00:44 volumio-hhai kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) May 27 00:00:44 volumio-hhai kernel: software IO TLB: mapped [mem 0x00000000b24e7000-0x00000000b64e7000] (64MB) May 27 00:00:44 volumio-hhai kernel: Trying to unpack rootfs image as initramfs... May 27 00:00:44 volumio-hhai kernel: RAPL PMU: API unit is 2^-32 Joules, 4 fixed counters, 655360 ms ovfl timer May 27 00:00:44 volumio-hhai kernel: RAPL PMU: hw unit of domain pp0-core 2^-14 Joules May 27 00:00:44 volumio-hhai kernel: RAPL PMU: hw unit of domain package 2^-14 Joules May 27 00:00:44 volumio-hhai kernel: RAPL PMU: hw unit of domain dram 2^-14 Joules May 27 00:00:44 volumio-hhai kernel: RAPL PMU: hw unit of domain pp1-gpu 2^-14 Joules May 27 00:00:44 volumio-hhai kernel: Initialise system trusted keyrings May 27 00:00:44 volumio-hhai kernel: workingset: timestamp_bits=46 max_order=21 bucket_order=0 May 27 00:00:44 volumio-hhai kernel: Key type asymmetric registered May 27 00:00:44 volumio-hhai kernel: Asymmetric key parser 'x509' registered May 27 00:00:44 volumio-hhai kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 27 00:00:44 volumio-hhai kernel: io scheduler mq-deadline registered May 27 00:00:44 volumio-hhai kernel: io scheduler kyber registered May 27 00:00:44 volumio-hhai kernel: ledtrig-cpu: registered to indicate activity on CPUs May 27 00:00:44 volumio-hhai kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 May 27 00:00:44 volumio-hhai kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 May 27 00:00:44 volumio-hhai kernel: ACPI: button: Power Button [PWRB] May 27 00:00:44 volumio-hhai kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 May 27 00:00:44 volumio-hhai kernel: ACPI: button: Sleep Button [SLPB] May 27 00:00:44 volumio-hhai kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 May 27 00:00:44 volumio-hhai kernel: ACPI: button: Power Button [PWRF] May 27 00:00:44 volumio-hhai kernel: thermal LNXTHERM:00: registered as thermal_zone0 May 27 00:00:44 volumio-hhai kernel: ACPI: thermal: Thermal Zone [TZ00] (28 C) May 27 00:00:44 volumio-hhai kernel: thermal LNXTHERM:01: registered as thermal_zone1 May 27 00:00:44 volumio-hhai kernel: ACPI: thermal: Thermal Zone [TZ01] (30 C) May 27 00:00:44 volumio-hhai kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled May 27 00:00:44 volumio-hhai kernel: 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A May 27 00:00:44 volumio-hhai kernel: Linux agpgart interface v0.103 May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1 May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x0000000000009810 May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2 May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:00:14.0: Host supports USB 3.0 SuperSpeed May 27 00:00:44 volumio-hhai kernel: ehci-pci 0000:00:1a.0: EHCI Host Controller May 27 00:00:44 volumio-hhai kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12 May 27 00:00:44 volumio-hhai kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 May 27 00:00:44 volumio-hhai kernel: usb usb1: Product: xHCI Host Controller May 27 00:00:44 volumio-hhai kernel: usb usb1: Manufacturer: Linux 6.12.57-volumio xhci-hcd May 27 00:00:44 volumio-hhai kernel: usb usb1: SerialNumber: 0000:00:14.0 May 27 00:00:44 volumio-hhai kernel: hub 1-0:1.0: USB hub found May 27 00:00:44 volumio-hhai kernel: hub 1-0:1.0: 14 ports detected May 27 00:00:44 volumio-hhai kernel: ehci-pci 0000:00:1a.0: new USB bus registered, assigned bus number 3 May 27 00:00:44 volumio-hhai kernel: ehci-pci 0000:00:1a.0: debug port 2 May 27 00:00:44 volumio-hhai kernel: ehci-pci 0000:00:1a.0: irq 16, io mem 0xf7c17000 May 27 00:00:44 volumio-hhai kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.12 May 27 00:00:44 volumio-hhai kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 May 27 00:00:44 volumio-hhai kernel: usb usb2: Product: xHCI Host Controller May 27 00:00:44 volumio-hhai kernel: usb usb2: Manufacturer: Linux 6.12.57-volumio xhci-hcd May 27 00:00:44 volumio-hhai kernel: usb usb2: SerialNumber: 0000:00:14.0 May 27 00:00:44 volumio-hhai kernel: hub 2-0:1.0: USB hub found May 27 00:00:44 volumio-hhai kernel: hub 2-0:1.0: 6 ports detected May 27 00:00:44 volumio-hhai kernel: ehci-pci 0000:00:1a.0: USB 2.0 started, EHCI 1.00 May 27 00:00:44 volumio-hhai kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12 May 27 00:00:44 volumio-hhai kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 May 27 00:00:44 volumio-hhai kernel: usb usb3: Product: EHCI Host Controller May 27 00:00:44 volumio-hhai kernel: usb usb3: Manufacturer: Linux 6.12.57-volumio ehci_hcd May 27 00:00:44 volumio-hhai kernel: usb usb3: SerialNumber: 0000:00:1a.0 May 27 00:00:44 volumio-hhai kernel: hub 3-0:1.0: USB hub found May 27 00:00:44 volumio-hhai kernel: hub 3-0:1.0: 2 ports detected May 27 00:00:44 volumio-hhai kernel: ehci-pci 0000:00:1d.0: EHCI Host Controller May 27 00:00:44 volumio-hhai kernel: ehci-pci 0000:00:1d.0: new USB bus registered, assigned bus number 4 May 27 00:00:44 volumio-hhai kernel: ehci-pci 0000:00:1d.0: debug port 2 May 27 00:00:44 volumio-hhai kernel: ehci-pci 0000:00:1d.0: irq 23, io mem 0xf7c16000 May 27 00:00:44 volumio-hhai kernel: ehci-pci 0000:00:1d.0: USB 2.0 started, EHCI 1.00 May 27 00:00:44 volumio-hhai kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12 May 27 00:00:44 volumio-hhai kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 May 27 00:00:44 volumio-hhai kernel: usb usb4: Product: EHCI Host Controller May 27 00:00:44 volumio-hhai kernel: usb usb4: Manufacturer: Linux 6.12.57-volumio ehci_hcd May 27 00:00:44 volumio-hhai kernel: usb usb4: SerialNumber: 0000:00:1d.0 May 27 00:00:44 volumio-hhai kernel: hub 4-0:1.0: USB hub found May 27 00:00:44 volumio-hhai kernel: hub 4-0:1.0: 2 ports detected May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 5 May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:01:00.0: hcc params 0x0270f06d hci version 0x96 quirks 0x0000000004000000 May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 6 May 27 00:00:44 volumio-hhai kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed May 27 00:00:44 volumio-hhai kernel: usb usb5: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12 May 27 00:00:44 volumio-hhai kernel: usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 May 27 00:00:44 volumio-hhai kernel: usb usb5: Product: xHCI Host Controller May 27 00:00:44 volumio-hhai kernel: usb usb5: Manufacturer: Linux 6.12.57-volumio xhci-hcd May 27 00:00:44 volumio-hhai kernel: usb usb5: SerialNumber: 0000:01:00.0 May 27 00:00:44 volumio-hhai kernel: hub 5-0:1.0: USB hub found May 27 00:00:44 volumio-hhai kernel: hub 5-0:1.0: 2 ports detected May 27 00:00:44 volumio-hhai kernel: usb usb6: We don't know the algorithms for LPM for this host, disabling LPM. May 27 00:00:44 volumio-hhai kernel: usb usb6: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.12 May 27 00:00:44 volumio-hhai kernel: usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1 May 27 00:00:44 volumio-hhai kernel: usb usb6: Product: xHCI Host Controller May 27 00:00:44 volumio-hhai kernel: usb usb6: Manufacturer: Linux 6.12.57-volumio xhci-hcd May 27 00:00:44 volumio-hhai kernel: usb usb6: SerialNumber: 0000:01:00.0 May 27 00:00:44 volumio-hhai kernel: hub 6-0:1.0: USB hub found May 27 00:00:44 volumio-hhai kernel: hub 6-0:1.0: 2 ports detected May 27 00:00:44 volumio-hhai kernel: usbcore: registered new interface driver usb-storage May 27 00:00:44 volumio-hhai kernel: i8042: PNP: No PS/2 controller found. May 27 00:00:44 volumio-hhai kernel: mousedev: PS/2 mouse device common for all mice May 27 00:00:44 volumio-hhai kernel: rtc_cmos 00:02: RTC can wake from S4 May 27 00:00:44 volumio-hhai kernel: rtc_cmos 00:02: registered as rtc0 May 27 00:00:44 volumio-hhai kernel: rtc_cmos 00:02: setting system clock to 2026-05-26T17:00:31 UTC (1779814831) May 27 00:00:44 volumio-hhai kernel: rtc_cmos 00:02: alarms up to one month, y3k, 242 bytes nvram May 27 00:00:44 volumio-hhai kernel: i2c_dev: i2c /dev entries driver May 27 00:00:44 volumio-hhai kernel: intel_pstate: Intel P-state driver initializing May 27 00:00:44 volumio-hhai kernel: efifb: probing for efifb May 27 00:00:44 volumio-hhai kernel: efifb: framebuffer at 0xe0000000, using 3072k, total 3072k May 27 00:00:44 volumio-hhai kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 May 27 00:00:44 volumio-hhai kernel: efifb: scrolling: redraw May 27 00:00:44 volumio-hhai kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 May 27 00:00:44 volumio-hhai kernel: Console: switching to colour frame buffer device 128x48 May 27 00:00:44 volumio-hhai kernel: fb0: EFI VGA frame buffer device May 27 00:00:44 volumio-hhai kernel: hid: raw HID events driver (C) Jiri Kosina May 27 00:00:44 volumio-hhai kernel: NET: Registered PF_INET6 protocol family May 27 00:00:44 volumio-hhai kernel: Segment Routing with IPv6 May 27 00:00:44 volumio-hhai kernel: In-situ OAM (IOAM) with IPv6 May 27 00:00:44 volumio-hhai kernel: mip6: Mobile IPv6 May 27 00:00:44 volumio-hhai kernel: NET: Registered PF_PACKET protocol family May 27 00:00:44 volumio-hhai kernel: mpls_gso: MPLS GSO support May 27 00:00:44 volumio-hhai kernel: microcode: Current revision: 0x0000001e May 27 00:00:44 volumio-hhai kernel: IPI shorthand broadcast: enabled May 27 00:00:44 volumio-hhai kernel: sched_clock: Marking stable (344003708, 189902)->(352015427, -7821817) May 27 00:00:44 volumio-hhai kernel: Loading compiled-in X.509 certificates May 27 00:00:44 volumio-hhai kernel: clk: Disabling unused clocks May 27 00:00:44 volumio-hhai kernel: PM: genpd: Disabling unused power domains May 27 00:00:44 volumio-hhai kernel: usb 1-7: new full-speed USB device number 2 using xhci_hcd May 27 00:00:44 volumio-hhai kernel: usb 3-1: new high-speed USB device number 2 using ehci-pci May 27 00:00:44 volumio-hhai kernel: usb 5-1: new high-speed USB device number 2 using xhci_hcd May 27 00:00:44 volumio-hhai kernel: usb 4-1: new high-speed USB device number 2 using ehci-pci May 27 00:00:44 volumio-hhai kernel: usb 1-7: New USB device found, idVendor=8087, idProduct=07dc, bcdDevice= 0.01 May 27 00:00:44 volumio-hhai kernel: usb 1-7: New USB device strings: Mfr=0, Product=0, SerialNumber=0 May 27 00:00:44 volumio-hhai kernel: usb 3-1: New USB device found, idVendor=8087, idProduct=8009, bcdDevice= 0.00 May 27 00:00:44 volumio-hhai kernel: usb 3-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 May 27 00:00:44 volumio-hhai kernel: hub 3-1:1.0: USB hub found May 27 00:00:44 volumio-hhai kernel: hub 3-1:1.0: 6 ports detected May 27 00:00:44 volumio-hhai kernel: usb 5-1: New USB device found, idVendor=245f, idProduct=0815, bcdDevice= 1.97 May 27 00:00:44 volumio-hhai kernel: usb 5-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 May 27 00:00:44 volumio-hhai kernel: usb 5-1: Product: HugoTT2 May 27 00:00:44 volumio-hhai kernel: usb 5-1: Manufacturer: Chord Electronics Ltd May 27 00:00:44 volumio-hhai kernel: usb 5-1: SerialNumber: 413-001 May 27 00:00:44 volumio-hhai kernel: usb 4-1: New USB device found, idVendor=8087, idProduct=8001, bcdDevice= 0.00 May 27 00:00:44 volumio-hhai kernel: usb 4-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 May 27 00:00:44 volumio-hhai kernel: hub 4-1:1.0: USB hub found May 27 00:00:44 volumio-hhai kernel: hub 4-1:1.0: 8 ports detected May 27 00:00:44 volumio-hhai kernel: Freeing initrd memory: 80732K May 27 00:00:44 volumio-hhai kernel: Freeing unused kernel image (initmem) memory: 3128K May 27 00:00:44 volumio-hhai kernel: Write protecting the kernel read-only data: 22528k May 27 00:00:44 volumio-hhai kernel: Freeing unused kernel image (rodata/data gap) memory: 824K May 27 00:00:44 volumio-hhai kernel: Run /init as init process May 27 00:00:44 volumio-hhai kernel: with arguments: May 27 00:00:44 volumio-hhai kernel: /init May 27 00:00:44 volumio-hhai kernel: splash May 27 00:00:44 volumio-hhai kernel: with environment: May 27 00:00:44 volumio-hhai kernel: HOME=/ May 27 00:00:44 volumio-hhai kernel: TERM=linux May 27 00:00:44 volumio-hhai kernel: bootdelay=5 May 27 00:00:44 volumio-hhai kernel: biosdevname=0 May 27 00:00:44 volumio-hhai kernel: imgpart=UUID=989265ff-d248-4f89-8e52-b7555c637af2 May 27 00:00:44 volumio-hhai kernel: bootpart=UUID=DDF4-322F May 27 00:00:44 volumio-hhai kernel: datapart=UUID=e4183fc1-3cea-4235-aefc-fb12bf1a152b May 27 00:00:44 volumio-hhai kernel: hwdevice=x86 May 27 00:00:44 volumio-hhai kernel: uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg May 27 00:00:44 volumio-hhai kernel: imgfile=/volumio_current.sqsh May 27 00:00:44 volumio-hhai kernel: use_kmsg=no May 27 00:00:44 volumio-hhai kernel: i801_smbus 0000:00:1f.3: SPD Write Disable is set May 27 00:00:44 volumio-hhai kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt May 27 00:00:44 volumio-hhai kernel: i2c i2c-0: Successfully instantiated SPD at 0x52 May 27 00:00:44 volumio-hhai kernel: ahci 0000:00:1f.2: version 3.0 May 27 00:00:44 volumio-hhai kernel: ahci 0000:00:1f.2: AHCI vers 0001.0300, 32 command slots, 6 Gbps, SATA mode May 27 00:00:44 volumio-hhai kernel: ahci 0000:00:1f.2: 1/6 ports implemented (port mask 0x4) May 27 00:00:44 volumio-hhai kernel: ahci 0000:00:1f.2: flags: 64bit ncq led clo pio slum part ems apst May 27 00:00:44 volumio-hhai kernel: r8169 0000:03:00.0: can't disable ASPM; OS doesn't have ASPM control May 27 00:00:44 volumio-hhai kernel: scsi host0: ahci May 27 00:00:44 volumio-hhai kernel: ACPI: bus type drm_connector registered May 27 00:00:44 volumio-hhai kernel: scsi host1: ahci May 27 00:00:44 volumio-hhai kernel: snd_hda_intel 0000:00:03.0: enabling device (0000 -> 0002) May 27 00:00:44 volumio-hhai kernel: scsi host2: ahci May 27 00:00:44 volumio-hhai kernel: scsi host3: ahci May 27 00:00:44 volumio-hhai kernel: scsi host4: ahci May 27 00:00:44 volumio-hhai kernel: r8169 0000:03:00.0 eth0: RTL8168g/8111g, d8:cb:8a:5d:c9:91, XID 4c0, IRQ 34 May 27 00:00:44 volumio-hhai kernel: r8169 0000:03:00.0 eth0: jumbo features [frames: 9194 bytes, tx checksumming: ko] May 27 00:00:44 volumio-hhai kernel: r8169 0000:04:00.0: can't disable ASPM; OS doesn't have ASPM control May 27 00:00:44 volumio-hhai kernel: scsi host5: ahci May 27 00:00:44 volumio-hhai kernel: ata1: DUMMY May 27 00:00:44 volumio-hhai kernel: ata2: DUMMY May 27 00:00:44 volumio-hhai kernel: ata3: SATA max UDMA/133 abar m2048@0xf7c15000 port 0xf7c15200 irq 33 lpm-pol 3 May 27 00:00:44 volumio-hhai kernel: ata4: DUMMY May 27 00:00:44 volumio-hhai kernel: ata5: DUMMY May 27 00:00:44 volumio-hhai kernel: ata6: DUMMY May 27 00:00:44 volumio-hhai kernel: r8169 0000:04:00.0 eth1: RTL8168g/8111g, d8:cb:8a:5d:c9:90, XID 4c0, IRQ 35 May 27 00:00:44 volumio-hhai kernel: r8169 0000:04:00.0 eth1: jumbo features [frames: 9194 bytes, tx checksumming: ko] May 27 00:00:44 volumio-hhai kernel: ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300) May 27 00:00:44 volumio-hhai kernel: ata3.00: ATA-9: SAMSUNG MZ7TE128HMGR-000L1, EXT06L0Q, max UDMA/133 May 27 00:00:44 volumio-hhai kernel: ata3.00: NCQ Send/Recv Log not supported May 27 00:00:44 volumio-hhai kernel: ata3.00: 250069680 sectors, multi 16: LBA48 NCQ (depth 32), AA May 27 00:00:44 volumio-hhai kernel: ata3.00: Features: Dev-Sleep May 27 00:00:44 volumio-hhai kernel: ata3.00: NCQ Send/Recv Log not supported May 27 00:00:44 volumio-hhai kernel: ata3.00: configured for UDMA/133 May 27 00:00:44 volumio-hhai kernel: scsi 2:0:0:0: Direct-Access ATA SAMSUNG MZ7TE128 6L0Q PQ: 0 ANSI: 5 May 27 00:00:44 volumio-hhai kernel: sd 2:0:0:0: [sda] 250069680 512-byte logical blocks: (128 GB/119 GiB) May 27 00:00:44 volumio-hhai kernel: sd 2:0:0:0: [sda] Write Protect is off May 27 00:00:44 volumio-hhai kernel: sd 2:0:0:0: [sda] Mode Sense: 00 3a 00 00 May 27 00:00:44 volumio-hhai kernel: sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA May 27 00:00:44 volumio-hhai kernel: sd 2:0:0:0: [sda] Preferred minimum I/O size 512 bytes May 27 00:00:44 volumio-hhai kernel: sda: sda1 sda2 sda3 May 27 00:00:44 volumio-hhai kernel: sd 2:0:0:0: [sda] Attached SCSI disk May 27 00:00:44 volumio-hhai kernel: tsc: Refined TSC clocksource calibration: 2899.997 MHz May 27 00:00:44 volumio-hhai kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x29cd4058c5c, max_idle_ns: 440795330155 ns May 27 00:00:44 volumio-hhai kernel: clocksource: Switched to clocksource tsc May 27 00:00:44 volumio-hhai kernel: i915 0000:00:02.0: [drm] Found HASWELL (device ID 0412) display version 7.00 stepping N/A May 27 00:00:44 volumio-hhai kernel: Console: switching to colour dummy device 80x25 May 27 00:00:44 volumio-hhai kernel: i915 0000:00:02.0: vgaarb: deactivate vga console May 27 00:00:44 volumio-hhai kernel: i915 0000:00:02.0: vgaarb: VGA decodes changed: olddecodes=io+mem,decodes=io+mem:owns=io+mem May 27 00:00:44 volumio-hhai kernel: [drm] Initialized i915 1.6.0 for 0000:00:02.0 on minor 0 May 27 00:00:44 volumio-hhai kernel: ACPI: video: Video Device [GFX0] (multi-head: yes rom: no post: no) May 27 00:00:44 volumio-hhai kernel: input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input3 May 27 00:00:44 volumio-hhai kernel: fbcon: i915drmfb (fb0) is primary device May 27 00:00:44 volumio-hhai kernel: Console: switching to colour frame buffer device 240x67 May 27 00:00:44 volumio-hhai kernel: i915 0000:00:02.0: [drm] fb0: i915drmfb frame buffer device May 27 00:00:44 volumio-hhai kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 27 00:00:44 volumio-hhai kernel: fuse: init (API version 7.41) May 27 00:00:44 volumio-hhai kernel: sdhci: Secure Digital Host Controller Interface driver May 27 00:00:44 volumio-hhai kernel: sdhci: Copyright(c) Pierre Ossman May 27 00:00:44 volumio-hhai kernel: usbcore: registered new interface driver usbhid May 27 00:00:44 volumio-hhai kernel: usbhid: USB HID core driver May 27 00:00:44 volumio-hhai kernel: snd_hda_intel 0000:00:03.0: bound 0000:00:02.0 (ops __SCT__tp_func_intel_frontbuffer_flush [i915]) May 27 00:00:44 volumio-hhai kernel: input: HDA Intel HDMI HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:03.0/sound/card0/input4 May 27 00:00:44 volumio-hhai kernel: input: HDA Intel HDMI HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:03.0/sound/card0/input5 May 27 00:00:44 volumio-hhai kernel: input: HDA Intel HDMI HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:03.0/sound/card0/input6 May 27 00:00:44 volumio-hhai kernel: usbcore: registered new interface driver uas May 27 00:00:44 volumio-hhai kernel: MXM: GUID detected in BIOS May 27 00:00:44 volumio-hhai kernel: [drm] radeon kernel modesetting enabled. May 27 00:00:44 volumio-hhai kernel: [drm] amdgpu kernel modesetting enabled. May 27 00:00:44 volumio-hhai kernel: scsi host6: pata_legacy May 27 00:00:44 volumio-hhai kernel: ata7: PATA max PIO4 cmd 0x1f0 ctl 0x3f6 irq 14 lpm-pol 0 May 27 00:00:44 volumio-hhai kernel: scsi host6: pata_legacy May 27 00:00:44 volumio-hhai kernel: ata7: PATA max PIO4 cmd 0x170 ctl 0x376 irq 15 lpm-pol 0 May 27 00:00:44 volumio-hhai kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! May 27 00:00:44 volumio-hhai kernel: EXT4-fs (sda2): recovery complete May 27 00:00:44 volumio-hhai kernel: EXT4-fs (sda2): mounted filesystem 989265ff-d248-4f89-8e52-b7555c637af2 r/w with ordered data mode. Quota mode: none. May 27 00:00:44 volumio-hhai kernel: loop: module loaded May 27 00:00:44 volumio-hhai kernel: block device autoloading is deprecated and will be removed. May 27 00:00:44 volumio-hhai kernel: loop0: detected capacity change from 0 to 2331568 May 27 00:00:44 volumio-hhai kernel: EXT4-fs (sda3): recovery complete May 27 00:00:44 volumio-hhai kernel: EXT4-fs (sda3): mounted filesystem e4183fc1-3cea-4235-aefc-fb12bf1a152b r/w with ordered data mode. Quota mode: none. May 27 00:00:44 volumio-hhai systemd[1]: Inserted module 'autofs4' May 27 00:00:44 volumio-hhai systemd[1]: systemd 252.39-1~deb12u1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) May 27 00:00:44 volumio-hhai systemd[1]: Detected architecture x86-64. May 27 00:00:44 volumio-hhai systemd[1]: Hostname set to . May 27 00:00:44 volumio-hhai systemd-gpt-auto-generator[501]: EFI loader partition unknown, exiting. May 27 00:00:44 volumio-hhai systemd-gpt-auto-generator[501]: (The boot loader did not set EFI variable LoaderDevicePartUUID.) May 27 00:00:44 volumio-hhai systemd[1]: Queued start job for default target graphical.target. May 27 00:00:44 volumio-hhai systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 27 00:00:44 volumio-hhai systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 27 00:00:44 volumio-hhai systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 27 00:00:44 volumio-hhai systemd[1]: Created slice user.slice - User and Session Slice. May 27 00:00:44 volumio-hhai systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 27 00:00:44 volumio-hhai systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 27 00:00:44 volumio-hhai systemd[1]: Expecting device dev-disk-by\x2duuid-DDF4\x2d322F.device - /dev/disk/by-uuid/DDF4-322F... May 27 00:00:44 volumio-hhai systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 27 00:00:44 volumio-hhai systemd[1]: Reached target slices.target - Slice Units. May 27 00:00:44 volumio-hhai systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 27 00:00:44 volumio-hhai systemd[1]: Listening on rpcbind.socket - RPCbind Server Activation Socket. May 27 00:00:44 volumio-hhai systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket. May 27 00:00:44 volumio-hhai systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. May 27 00:00:44 volumio-hhai systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. May 27 00:00:44 volumio-hhai systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 27 00:00:44 volumio-hhai systemd[1]: Listening on systemd-journald.socket - Journal Socket. May 27 00:00:44 volumio-hhai systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 27 00:00:44 volumio-hhai systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 27 00:00:44 volumio-hhai systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 27 00:00:44 volumio-hhai systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 27 00:00:44 volumio-hhai systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 27 00:00:44 volumio-hhai systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 27 00:00:44 volumio-hhai systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). May 27 00:00:44 volumio-hhai systemd[1]: Started dynamicswap.service - dynamicswap service. May 27 00:00:44 volumio-hhai systemd[1]: Reached target swap.target - Swaps. May 27 00:00:44 volumio-hhai systemd[1]: Starting fake-hwclock.service - Restore / save the current clock... May 27 00:00:44 volumio-hhai systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 27 00:00:44 volumio-hhai kernel: pstore: Using crash dump compression: deflate May 27 00:00:44 volumio-hhai systemd[1]: Starting systemd-journald.service - Journal Service... May 27 00:00:44 volumio-hhai kernel: pstore: Registered efi_pstore as persistent store backend May 27 00:00:44 volumio-hhai systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 27 00:00:44 volumio-hhai systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 27 00:00:44 volumio-hhai systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 27 00:00:44 volumio-hhai systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 27 00:00:44 volumio-hhai systemd[1]: modprobe@configfs.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 27 00:00:44 volumio-hhai systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 27 00:00:44 volumio-hhai systemd[1]: modprobe@drm.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 27 00:00:44 volumio-hhai systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 27 00:00:44 volumio-hhai systemd[1]: modprobe@fuse.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 27 00:00:44 volumio-hhai systemd[1]: modprobe@loop.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 27 00:00:44 volumio-hhai systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 27 00:00:44 volumio-hhai systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 27 00:00:44 volumio-hhai systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 27 00:00:44 volumio-hhai systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 27 00:00:44 volumio-hhai systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 27 00:00:44 volumio-hhai systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 27 00:00:44 volumio-hhai systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 27 00:00:44 volumio-hhai systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 27 00:00:44 volumio-hhai systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 27 00:00:44 volumio-hhai systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 27 00:00:44 volumio-hhai systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). May 27 00:00:44 volumio-hhai systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 27 00:00:44 volumio-hhai systemd[1]: Starting systemd-random-seed.service - Load/Save Random Seed... May 27 00:00:44 volumio-hhai systemd[1]: Starting systemd-sysusers.service - Create System Users... May 27 00:00:44 volumio-hhai systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 27 00:00:44 volumio-hhai systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 27 00:00:44 volumio-hhai systemd[1]: Finished fake-hwclock.service - Restore / save the current clock. May 27 00:00:44 volumio-hhai systemd[1]: Finished systemd-random-seed.service - Load/Save Random Seed. May 27 00:00:44 volumio-hhai systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). May 27 00:00:44 volumio-hhai systemd[1]: Finished systemd-sysusers.service - Create System Users. May 27 00:00:44 volumio-hhai systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 27 00:00:44 volumio-hhai systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 27 00:00:44 volumio-hhai systemd-journald[528]: Journal started May 27 00:00:44 volumio-hhai systemd-journald[528]: Runtime Journal (/run/log/journal/30175a60cf76629f74f78d9769c2cd99) is 3.7M, max 30.0M, 26.2M free. May 27 00:00:44 volumio-hhai fake-hwclock[519]: Current system time: 2026-05-26 17:00:44 May 27 00:00:44 volumio-hhai fake-hwclock[519]: fake-hwclock saved clock information is in the past: 2026-05-26 17:00:13 May 27 00:00:44 volumio-hhai fake-hwclock[519]: To set system time to this saved clock anyway, use "force" May 27 00:00:44 volumio-hhai systemd[1]: Started systemd-journald.service - Journal Service. May 27 00:00:44 volumio-hhai systemd[1]: dynamicswap.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 27 00:00:44 volumio-hhai systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 27 00:00:44 volumio-hhai systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 27 00:00:44 volumio-hhai systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 27 00:00:44 volumio-hhai systemd[1]: Starting ifupdown-pre.service - Helper to synchronize boot up for ifupdown... May 27 00:00:44 volumio-hhai systemd[1]: Finished ifupdown-pre.service - Helper to synchronize boot up for ifupdown. May 27 00:00:44 volumio-hhai systemd-udevd[551]: Using default interface naming scheme 'v252'. May 27 00:00:44 volumio-hhai systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 27 00:00:44 volumio-hhai (udev-worker)[555]: Network interface NamePolicy= disabled on kernel command line. May 27 00:00:44 volumio-hhai (udev-worker)[568]: Network interface NamePolicy= disabled on kernel command line. May 27 00:00:44 volumio-hhai kernel: sd 2:0:0:0: Attached scsi generic sg0 type 0 May 27 00:00:44 volumio-hhai systemd[1]: Expecting device sys-subsystem-net-devices-eth0.device - /sys/subsystem/net/devices/eth0... May 27 00:00:44 volumio-hhai systemd[1]: Found device dev-disk-by\x2duuid-DDF4\x2d322F.device - SAMSUNG_MZ7TE128HMGR-000L1 boot. May 27 00:00:44 volumio-hhai systemd[1]: Starting systemd-fsck@dev-disk-by\x2duuid-DDF4\x2d322F.service - File System Check on /dev/disk/by-uuid/DDF4-322F... May 27 00:00:44 volumio-hhai systemd[1]: Found device sys-subsystem-net-devices-eth0.device - RTL8111/8168/8211/8411 PCI Express Gigabit Ethernet Controller. May 27 00:00:44 volumio-hhai systemd[1]: Started systemd-fsckd.service - File System Check Daemon to report status. May 27 00:00:44 volumio-hhai systemd-fsck[606]: fsck.fat 4.2 (2021-01-31) May 27 00:00:44 volumio-hhai systemd-fsck[606]: /dev/sda1: 18 files, 23294/93500 clusters May 27 00:00:44 volumio-hhai systemd[1]: Finished systemd-fsck@dev-disk-by\x2duuid-DDF4\x2d322F.service - File System Check on /dev/disk/by-uuid/DDF4-322F. May 27 00:00:44 volumio-hhai rfkill[609]: unblock set for type bluetooth May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 27 00:00:44 volumio-hhai systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). May 27 00:00:44 volumio-hhai systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). May 27 00:00:44 volumio-hhai systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 27 00:00:44 volumio-hhai systemd[1]: modprobe@loop.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 27 00:00:44 volumio-hhai systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 27 00:00:44 volumio-hhai systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 27 00:00:44 volumio-hhai systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 27 00:00:44 volumio-hhai systemd[1]: Listening on systemd-rfkill.socket - Load/Save RF Kill Switch Status /dev/rfkill Watch. May 27 00:00:44 volumio-hhai kernel: at24 0-0052: supply vcc not found, using dummy regulator May 27 00:00:44 volumio-hhai kernel: cryptd: max_cpu_qlen set to 1000 May 27 00:00:44 volumio-hhai kernel: AES CTR mode by8 optimization enabled May 27 00:00:44 volumio-hhai kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database May 27 00:00:44 volumio-hhai kernel: at24 0-0052: 256 byte spd EEPROM, read-only May 27 00:00:44 volumio-hhai kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' May 27 00:00:44 volumio-hhai kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' May 27 00:00:44 volumio-hhai kernel: Bluetooth: Core ver 2.22 May 27 00:00:44 volumio-hhai kernel: NET: Registered PF_BLUETOOTH protocol family May 27 00:00:44 volumio-hhai kernel: Bluetooth: HCI device and connection manager initialized May 27 00:00:44 volumio-hhai kernel: Bluetooth: HCI socket layer initialized May 27 00:00:44 volumio-hhai kernel: Bluetooth: L2CAP socket layer initialized May 27 00:00:44 volumio-hhai kernel: Bluetooth: SCO socket layer initialized May 27 00:00:44 volumio-hhai kernel: usb 5-1: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. May 27 00:00:44 volumio-hhai kernel: usb 5-1: [10] FU [PCM Playback Volume] ch = 2, val = -32767/0/1 May 27 00:00:44 volumio-hhai kernel: usb 5-1: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. May 27 00:00:44 volumio-hhai kernel: usb 5-1: [10] FU [PCM Playback Volume] ch = 1, val = -32767/0/1 May 27 00:00:44 volumio-hhai kernel: usbcore: registered new interface driver snd-usb-audio May 27 00:00:44 volumio-hhai kernel: Intel(R) Wireless WiFi driver for Linux May 27 00:00:44 volumio-hhai kernel: iwlwifi 0000:05:00.0: enabling device (0000 -> 0002) May 27 00:00:44 volumio-hhai kernel: iwlwifi 0000:05:00.0: Detected crf-id 0x0, cnv-id 0x0 wfpm id 0x0 May 27 00:00:44 volumio-hhai kernel: iwlwifi 0000:05:00.0: PCI dev 08b1/4070, rev=0x144, rfid=0xd55555d5 May 27 00:00:44 volumio-hhai kernel: iwlwifi 0000:05:00.0: Detected Intel(R) Dual Band Wireless AC 7260 May 27 00:00:44 volumio-hhai kernel: iwlwifi 0000:05:00.0: loaded firmware version 17.bfb58538.0 7260-17.ucode op_mode iwlmvm May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 27 00:00:44 volumio-hhai systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 27 00:00:44 volumio-hhai systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). May 27 00:00:44 volumio-hhai systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). May 27 00:00:44 volumio-hhai systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 27 00:00:44 volumio-hhai systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 27 00:00:44 volumio-hhai systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 27 00:00:44 volumio-hhai systemd[1]: modprobe@loop.service: Deactivated successfully. May 27 00:00:44 volumio-hhai systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 27 00:00:44 volumio-hhai systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 27 00:00:44 volumio-hhai systemd[1]: Starting systemd-rfkill.service - Load/Save RF Kill Switch Status... May 27 00:00:44 volumio-hhai kernel: usbcore: registered new interface driver btusb May 27 00:00:44 volumio-hhai kernel: Bluetooth: hci0: Legacy ROM 2.5 revision 8.0 build 1 week 45 2013 May 27 00:00:44 volumio-hhai kernel: Bluetooth: hci0: Intel device is already patched. patch num: 2a May 27 00:00:44 volumio-hhai (udev-worker)[566]: hci0: Process '/usr/bin/hciconfig hci0 up' failed with exit code 1. May 27 00:00:44 volumio-hhai rfkill[740]: unblock set for type bluetooth May 27 00:00:45 volumio-hhai systemd[1]: Started systemd-rfkill.service - Load/Save RF Kill Switch Status. May 27 00:00:45 volumio-hhai systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 27 00:00:45 volumio-hhai systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 27 00:00:45 volumio-hhai systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 27 00:00:45 volumio-hhai systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). May 27 00:00:45 volumio-hhai systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). May 27 00:00:45 volumio-hhai systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 27 00:00:45 volumio-hhai systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 27 00:00:45 volumio-hhai systemd[1]: modprobe@loop.service: Deactivated successfully. May 27 00:00:45 volumio-hhai systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 27 00:00:45 volumio-hhai systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 27 00:00:45 volumio-hhai systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 27 00:00:45 volumio-hhai systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 27 00:00:45 volumio-hhai systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 27 00:00:45 volumio-hhai kernel: iwlwifi 0000:05:00.0: base HW address: d8:fc:93:b9:da:0c, OTP minor version: 0x0 May 27 00:00:45 volumio-hhai (udev-worker)[556]: pcmC5D0p: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. May 27 00:00:45 volumio-hhai systemd[1]: Mounting boot.mount - /boot... May 27 00:00:45 volumio-hhai systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. May 27 00:00:45 volumio-hhai systemd[1]: Mounting tmp.mount - /tmp... May 27 00:00:45 volumio-hhai systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. May 27 00:00:45 volumio-hhai systemd[1]: Mounting var-log.mount - /var/log... May 27 00:00:45 volumio-hhai kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! May 27 00:00:45 volumio-hhai systemd[1]: Mounting var-spool-cups.mount - /var/spool/cups... May 27 00:00:45 volumio-hhai systemd[1]: Mounted boot.mount - /boot. May 27 00:00:45 volumio-hhai systemd[1]: Mounted tmp.mount - /tmp. May 27 00:00:45 volumio-hhai systemd[1]: Mounted var-log.mount - /var/log. May 27 00:00:45 volumio-hhai systemd[1]: Mounted var-spool-cups.mount - /var/spool/cups. May 27 00:00:45 volumio-hhai systemd[1]: Mounting var-spool-cups-tmp.mount - /var/spool/cups/tmp... May 27 00:00:45 volumio-hhai systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 27 00:00:45 volumio-hhai systemd[1]: Mounted var-spool-cups-tmp.mount - /var/spool/cups/tmp. May 27 00:00:45 volumio-hhai systemd[1]: Reached target local-fs.target - Local File Systems. May 27 00:00:45 volumio-hhai systemd[1]: Started ifup@eth0.service - ifup for eth0. May 27 00:00:45 volumio-hhai systemd[1]: Starting networking.service - Raise network interfaces... May 27 00:00:45 volumio-hhai systemd-journald[528]: Runtime Journal (/run/log/journal/30175a60cf76629f74f78d9769c2cd99) is 3.7M, max 30.0M, 26.2M free. May 27 00:00:45 volumio-hhai systemd[1]: Starting plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data... May 27 00:00:45 volumio-hhai systemd[1]: Starting plymouth-rotation.service - Plymouth rotation detection for shutdown/reboot... May 27 00:00:45 volumio-hhai systemd-journald[528]: Received client request to flush runtime journal. May 27 00:00:45 volumio-hhai systemd[1]: Starting systemd-binfmt.service - Set Up Additional Binary Formats... May 27 00:00:45 volumio-hhai systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). May 27 00:00:45 volumio-hhai systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 27 00:00:45 volumio-hhai systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 27 00:00:45 volumio-hhai systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 755 (systemd-binfmt) May 27 00:00:45 volumio-hhai systemd[1]: Received SIGRTMIN+20 from PID 387 (plymouthd). May 27 00:00:45 volumio-hhai systemd[1]: Finished plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data. May 27 00:00:45 volumio-hhai systemd[1]: Finished plymouth-rotation.service - Plymouth rotation detection for shutdown/reboot. May 27 00:00:45 volumio-hhai systemd[1]: Starting plymouth-start.service - Show Plymouth Boot Screen... May 27 00:00:45 volumio-hhai systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 27 00:00:45 volumio-hhai systemd[1]: Started haveged.service - Entropy Daemon based on the HAVEGE algorithm. May 27 00:00:45 volumio-hhai systemd[1]: Starting rpcbind.service - RPC bind portmap service... May 27 00:00:45 volumio-hhai systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 27 00:00:45 volumio-hhai systemd[1]: Started plymouth-start.service - Show Plymouth Boot Screen. May 27 00:00:45 volumio-hhai systemd[1]: systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch was skipped because of an unmet condition check (ConditionPathExists=!/run/plymouth/pid). May 27 00:00:45 volumio-hhai systemd[1]: Started systemd-ask-password-plymouth.path - Forward Password Requests to Plymouth Directory Watch. May 27 00:00:45 volumio-hhai systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 27 00:00:45 volumio-hhai systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 27 00:00:45 volumio-hhai systemd[1]: Started rpcbind.service - RPC bind portmap service. May 27 00:00:45 volumio-hhai systemd[1]: Reached target rpcbind.target - RPC Port Mapper. May 27 00:00:45 volumio-hhai kernel: ieee80211 phy0: Selected rate control algorithm 'iwl-mvm-rs' May 27 00:00:45 volumio-hhai haveged[770]: haveged: command socket is listening at fd 3 May 27 00:00:45 volumio-hhai systemd[1]: Expecting device sys-subsystem-net-devices-wlan0.device - /sys/subsystem/net/devices/wlan0... May 27 00:00:45 volumio-hhai systemd[1]: Found device sys-subsystem-net-devices-wlan0.device - Wireless 7260 (Dual Band Wireless-AC 7260 [Wilkins Peak 2]). May 27 00:00:45 volumio-hhai sh[815]: dhcpcd-9.4.1 starting May 27 00:00:45 volumio-hhai dhcpcd[815]: dhcpcd-9.4.1 starting May 27 00:00:45 volumio-hhai sh[815]: DUID 00:04:00:00:00:00:00:00:00:00:00:00:d8:cb:8a:5d:c9:91 May 27 00:00:45 volumio-hhai dhcpcd[827]: DUID 00:04:00:00:00:00:00:00:00:00:00:00:d8:cb:8a:5d:c9:91 May 27 00:00:45 volumio-hhai systemd[1]: Started ifup@wlan0.service - ifup for wlan0. May 27 00:00:45 volumio-hhai kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 May 27 00:00:45 volumio-hhai kernel: 8021q: 802.1Q VLAN Support v1.8 May 27 00:00:45 volumio-hhai haveged[770]: haveged: ver: 1.9.14; arch: x86; vend: GenuineIntel; build: (gcc 12.2.0 ITV); collect: 128K May 27 00:00:45 volumio-hhai haveged[770]: haveged: cpu: (L4 VC); data: 32K (L4 V); inst: 32K (L4 V); idx: 24/40; sz: 32010/53875 May 27 00:00:45 volumio-hhai haveged[770]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99917 May 27 00:00:45 volumio-hhai haveged[770]: haveged: fills: 0, generated: 0 May 27 00:00:45 volumio-hhai sh[875]: Failed to print the table: Broken pipe May 27 00:00:45 volumio-hhai sh[894]: wlan0=wlan0 May 27 00:00:45 volumio-hhai kernel: Generic FE-GE Realtek PHY r8169-0-300:00: attached PHY driver (mii_bus:phy_addr=r8169-0-300:00, irq=MAC) May 27 00:00:45 volumio-hhai systemd[1]: Finished networking.service - Raise network interfaces. May 27 00:00:45 volumio-hhai sh[815]: eth0: waiting for carrier May 27 00:00:45 volumio-hhai dhcpcd[827]: eth0: waiting for carrier May 27 00:00:45 volumio-hhai sh[815]: eth0: carrier acquired May 27 00:00:45 volumio-hhai dhcpcd[827]: eth0: carrier acquired May 27 00:00:45 volumio-hhai sh[815]: eth0: IAID 8a:5d:c9:91 May 27 00:00:45 volumio-hhai dhcpcd[827]: eth0: IAID 8a:5d:c9:91 May 27 00:00:45 volumio-hhai kernel: r8169 0000:03:00.0 eth0: Link is Down May 27 00:00:45 volumio-hhai dhcpcd[827]: eth0: adding address fe80::b089:1ea3:8b40:cfaa May 27 00:00:45 volumio-hhai sh[815]: eth0: adding address fe80::b089:1ea3:8b40:cfaa May 27 00:00:45 volumio-hhai sh[815]: ipv6_addaddr1: Permission denied May 27 00:00:45 volumio-hhai dhcpcd[827]: ipv6_addaddr1: Permission denied May 27 00:00:46 volumio-hhai systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... May 27 00:00:46 volumio-hhai systemd[1]: Mounting run-rpc_pipefs.mount - RPC Pipe File System... May 27 00:00:46 volumio-hhai systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. May 27 00:00:46 volumio-hhai systemd[1]: Finished systemd-binfmt.service - Set Up Additional Binary Formats. May 27 00:00:46 volumio-hhai systemd[1]: Reached target sysinit.target - System Initialization. May 27 00:00:46 volumio-hhai systemd[1]: Started acpid.path - ACPI Events Check. May 27 00:00:46 volumio-hhai systemd[1]: Started apt-daily.timer - Daily apt download activities. May 27 00:00:46 volumio-hhai systemd[1]: Started apt-daily-upgrade.timer - Daily apt upgrade and clean activities. May 27 00:00:46 volumio-hhai systemd[1]: Started dpkg-db-backup.timer - Daily dpkg database backup timer. May 27 00:00:46 volumio-hhai systemd[1]: Started e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems. May 27 00:00:46 volumio-hhai systemd[1]: Started fstrim.timer - Discard unused blocks once a week. May 27 00:00:46 volumio-hhai systemd[1]: Started man-db.timer - Daily man-db regeneration. May 27 00:00:46 volumio-hhai systemd[1]: Started ntpsec-rotate-stats.timer - Rotate ntpd stats daily. May 27 00:00:46 volumio-hhai systemd[1]: Started setdatetime-helper.timer - Volumio Time Sync Watchdog Timer. May 27 00:00:46 volumio-hhai systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 27 00:00:46 volumio-hhai systemd[1]: Reached target paths.target - Path Units. May 27 00:00:46 volumio-hhai systemd[1]: Reached target timers.target - Timer Units. May 27 00:00:46 volumio-hhai systemd[1]: Listening on acpid.socket - ACPID Listen Socket. May 27 00:00:46 volumio-hhai systemd[1]: Listening on avahi-daemon.socket - Avahi mDNS/DNS-SD Stack Activation Socket. May 27 00:00:46 volumio-hhai systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 27 00:00:46 volumio-hhai systemd[1]: Reached target sockets.target - Socket Units. May 27 00:00:46 volumio-hhai systemd[1]: systemd-pcrphase-sysinit.service - TPM2 PCR Barrier (Initialization) was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). May 27 00:00:46 volumio-hhai systemd[1]: Reached target basic.target - Basic System. May 27 00:00:46 volumio-hhai systemd[1]: Started acpid.service - ACPI event daemon. May 27 00:00:46 volumio-hhai systemd[1]: alsa-state.service - Manage Sound Card State (restore and store) was skipped because of an unmet condition check (ConditionPathExists=/etc/alsa/state-daemon.conf). May 27 00:00:46 volumio-hhai acpid[921]: starting up with netlink and the input layer May 27 00:00:46 volumio-hhai acpid[921]: 3 rules loaded May 27 00:00:46 volumio-hhai systemd[1]: Starting alsa-restore.service - Save/Restore Sound Card State... May 27 00:00:46 volumio-hhai acpid[921]: waiting for events: event logging is off May 27 00:00:46 volumio-hhai systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... May 27 00:00:46 volumio-hhai systemd[1]: Starting bluetooth.service - Bluetooth service... May 27 00:00:46 volumio-hhai systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 27 00:00:46 volumio-hhai systemd[1]: Starting e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots... May 27 00:00:46 volumio-hhai systemd[1]: getty-static.service - getty on tty2-tty6 if dbus and logind are not available was skipped because of an unmet condition check (ConditionPathExists=!/usr/bin/dbus-daemon). May 27 00:00:46 volumio-hhai systemd[1]: headless_wireless.service - Copy user wpa_supplicant.conf was skipped because of an unmet condition check (ConditionPathExists=/boot/wpa_supplicant.conf). May 27 00:00:46 volumio-hhai systemd[1]: Starting dhcpcd.service - DHCP Client Daemon on all interfaces... May 27 00:00:46 volumio-hhai avahi-daemon[923]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). May 27 00:00:46 volumio-hhai avahi-daemon[923]: Successfully dropped root privileges. May 27 00:00:46 volumio-hhai avahi-daemon[923]: avahi-daemon 0.8 starting up. May 27 00:00:46 volumio-hhai systemd[1]: Started iptables.service - Volumio Iptables Module. May 27 00:00:46 volumio-hhai systemd[1]: Starting systemd-logind.service - User Login Management... May 27 00:00:46 volumio-hhai systemd[1]: Starting triggerhappy.service - triggerhappy global hotkey daemon... May 27 00:00:46 volumio-hhai systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 27 00:00:46 volumio-hhai systemd[1]: Started volumio-remote-updater.service - Volumio Remote OTA Updater. May 27 00:00:46 volumio-hhai systemd[1]: volumiossh.service - Volumio SSH enabler was skipped because of an unmet condition check (ConditionPathExistsGlob=/boot/ssh{,.txt}). May 27 00:00:46 volumio-hhai kernel: RPC: Registered named UNIX socket transport module. May 27 00:00:46 volumio-hhai kernel: RPC: Registered udp transport module. May 27 00:00:46 volumio-hhai kernel: RPC: Registered tcp transport module. May 27 00:00:46 volumio-hhai kernel: RPC: Registered tcp-with-tls transport module. May 27 00:00:46 volumio-hhai kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. May 27 00:00:46 volumio-hhai systemd[1]: Starting wireless.service - Wireless Services... May 27 00:00:46 volumio-hhai systemd[1]: Mounted run-rpc_pipefs.mount - RPC Pipe File System. May 27 00:00:46 volumio-hhai systemd[1]: Reached target rpc_pipefs.target. May 27 00:00:46 volumio-hhai systemd[1]: rpc-gssd.service - RPC security service for NFS client and server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). May 27 00:00:46 volumio-hhai systemd[1]: Reached target nfs-client.target - NFS client services. May 27 00:00:46 volumio-hhai systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 27 00:00:46 volumio-hhai systemd[1]: Reached target remote-fs.target - Remote File Systems. May 27 00:00:46 volumio-hhai systemd[1]: Starting loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling... May 27 00:00:46 volumio-hhai systemd[1]: systemd-pcrphase.service - TPM2 PCR Barrier (User) was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). May 27 00:00:46 volumio-hhai systemd[1]: e2scrub_reap.service: Deactivated successfully. May 27 00:00:46 volumio-hhai systemd[1]: Finished e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots. May 27 00:00:46 volumio-hhai thd[931]: Unable to parse trigger line: May 27 00:00:46 volumio-hhai thd[931]: Unable to parse trigger line: May 27 00:00:46 volumio-hhai systemd[1]: Started triggerhappy.service - triggerhappy global hotkey daemon. May 27 00:00:46 volumio-hhai systemd[1]: Starting th-udev-rebind.service - Late rebind of input devices to triggerhappy... May 27 00:00:46 volumio-hhai th-udev-rebind.sh[944]: Rebinding /dev/input/event0 to thd using --add... May 27 00:00:46 volumio-hhai dhcpcd[927]: dhcpcd-9.4.1 starting May 27 00:00:46 volumio-hhai systemd[1]: Finished alsa-restore.service - Save/Restore Sound Card State. May 27 00:00:46 volumio-hhai systemd[1]: Reached target sound.target - Sound Card. May 27 00:00:46 volumio-hhai th-udev-rebind.sh[944]: Rebinding /dev/input/event1 to thd using --add... May 27 00:00:46 volumio-hhai th-udev-rebind.sh[944]: Rebinding /dev/input/event2 to thd using --add... May 27 00:00:46 volumio-hhai th-udev-rebind.sh[944]: Rebinding /dev/input/event3 to thd using --add... May 27 00:00:46 volumio-hhai th-udev-rebind.sh[944]: Rebinding /dev/input/event4 to thd using --add... May 27 00:00:46 volumio-hhai th-udev-rebind.sh[944]: Rebinding /dev/input/event5 to thd using --add... May 27 00:00:46 volumio-hhai bluetoothd[924]: Bluetooth daemon 5.83 May 27 00:00:46 volumio-hhai th-udev-rebind.sh[944]: Rebinding /dev/input/event6 to thd using --add... May 27 00:00:46 volumio-hhai dhcpcd[952]: dev: loaded udev May 27 00:00:46 volumio-hhai dhcpcd[952]: DUID 00:04:00:00:00:00:00:00:00:00:00:00:d8:cb:8a:5d:c9:91 May 27 00:00:46 volumio-hhai systemd-logind[930]: New seat seat0. May 27 00:00:46 volumio-hhai systemd[1]: th-udev-rebind.service: Deactivated successfully. May 27 00:00:46 volumio-hhai systemd[1]: Finished th-udev-rebind.service - Late rebind of input devices to triggerhappy. May 27 00:00:46 volumio-hhai systemd-logind[930]: Watching system buttons on /dev/input/event2 (Power Button) May 27 00:00:46 volumio-hhai systemd-logind[930]: Watching system buttons on /dev/input/event0 (Power Button) May 27 00:00:46 volumio-hhai systemd-logind[930]: Watching system buttons on /dev/input/event1 (Sleep Button) May 27 00:00:46 volumio-hhai systemd[1]: Started dhcpcd.service - DHCP Client Daemon on all interfaces. May 27 00:00:46 volumio-hhai systemd[1]: Started dbus.service - D-Bus System Message Bus. May 27 00:00:46 volumio-hhai dbus-daemon[925]: [system] Successfully activated service 'org.freedesktop.systemd1' May 27 00:00:46 volumio-hhai avahi-daemon[923]: Successfully called chroot(). May 27 00:00:46 volumio-hhai avahi-daemon[923]: Successfully dropped remaining capabilities. May 27 00:00:46 volumio-hhai dhcpcd[827]: eth0: soliciting an IPv6 router May 27 00:00:46 volumio-hhai sh[815]: eth0: soliciting an IPv6 router May 27 00:00:46 volumio-hhai bluetoothd[924]: Starting SDP server May 27 00:00:46 volumio-hhai bluetoothd[924]: Excluding (cli) sap May 27 00:00:46 volumio-hhai bluetoothd[924]: Excluding (cli) scanparam May 27 00:00:46 volumio-hhai bluetoothd[924]: Excluding (cli) midi May 27 00:00:46 volumio-hhai bluetoothd[924]: Excluding (cli) battery May 27 00:00:46 volumio-hhai avahi-daemon[923]: Loading service file /services/volumio.service. May 27 00:00:46 volumio-hhai systemd[1]: Starting wpa_supplicant.service - WPA supplicant... May 27 00:00:46 volumio-hhai systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. May 27 00:00:46 volumio-hhai systemd[1]: Started bluetooth.service - Bluetooth service. May 27 00:00:46 volumio-hhai systemd[1]: Started systemd-logind.service - User Login Management. May 27 00:00:46 volumio-hhai avahi-daemon[923]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. May 27 00:00:46 volumio-hhai avahi-daemon[923]: New relevant interface lo.IPv4 for mDNS. May 27 00:00:46 volumio-hhai avahi-daemon[923]: Network interface enumeration completed. May 27 00:00:46 volumio-hhai avahi-daemon[923]: Registering new address record for 127.0.0.1 on lo.IPv4. May 27 00:00:46 volumio-hhai dhcpcd[952]: eth0: IAID 8a:5d:c9:91 May 27 00:00:46 volumio-hhai dhcpcd[952]: eth0: adding address fe80::b089:1ea3:8b40:cfaa May 27 00:00:46 volumio-hhai dhcpcd[952]: ipv6_addaddr1: Permission denied May 27 00:00:46 volumio-hhai dhcpcd[952]: wlan0: waiting for carrier May 27 00:00:46 volumio-hhai volumio-remote-updater[933]: Volumio OTA Client: 1.7.0 May 27 00:00:46 volumio-hhai systemd[1]: Starting bluealsa.service - BlueALSA service... May 27 00:00:46 volumio-hhai volumio-remote-updater[933]: Error: No active session May 27 00:00:46 volumio-hhai volumio-remote-updater[933]: [2026-05-27 00:00:46] [info] asio async_connect error: asio.system:111 (Connection refused) May 27 00:00:46 volumio-hhai volumio-remote-updater[933]: [2026-05-27 00:00:46] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) May 27 00:00:46 volumio-hhai volumio-remote-updater[933]: [2026-05-27 00:00:46] [error] handle_connect error: Connection refused May 27 00:00:46 volumio-hhai kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 May 27 00:00:46 volumio-hhai kernel: Bluetooth: BNEP filters: protocol multicast May 27 00:00:46 volumio-hhai kernel: Bluetooth: BNEP socket layer initialized May 27 00:00:46 volumio-hhai bluetoothd[924]: Bluetooth management interface 1.23 initialized May 27 00:00:46 volumio-hhai bluetoothd[924]: Battery Provider Manager created May 27 00:00:46 volumio-hhai dbus-daemon[925]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=0 pid=924 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap,b") May 27 00:00:46 volumio-hhai kernel: Bluetooth: MGMT ver 1.23 May 27 00:00:46 volumio-hhai kernel: NET: Registered PF_ALG protocol family May 27 00:00:46 volumio-hhai dhcpcd[952]: eth0: rebinding lease of 192.168.30.243 May 27 00:00:46 volumio-hhai systemd[1]: Starting systemd-hostnamed.service - Hostname Service... May 27 00:00:46 volumio-hhai systemd[1]: iptables.service: Deactivated successfully. May 27 00:00:46 volumio-hhai upmpdcli[932]: Could not open config: /tmp/upmpdcli.conf May 27 00:00:46 volumio-hhai systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 27 00:00:46 volumio-hhai systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 27 00:00:46 volumio-hhai wpa_supplicant[971]: Successfully initialized wpa_supplicant May 27 00:00:46 volumio-hhai systemd[1]: Started wpa_supplicant.service - WPA supplicant. May 27 00:00:46 volumio-hhai systemd[1]: Reached target network.target - Network. May 27 00:00:46 volumio-hhai systemd[1]: Reached target network-online.target - Network is Online. May 27 00:00:46 volumio-hhai dbus-daemon[925]: [system] Successfully activated service 'org.freedesktop.hostname1' May 27 00:00:46 volumio-hhai loadcpufreq[939]: Loading cpufreq kernel modules...done (acpi-cpufreq). May 27 00:00:46 volumio-hhai systemd[1]: Starting ifplugd.service - LSB: Brings up/down network automatically... May 27 00:00:46 volumio-hhai systemd[1]: Starting nmbd.service - Samba NMB Daemon... May 27 00:00:46 volumio-hhai systemd[1]: Starting ntpsec.service - Network Time Service... May 27 00:00:46 volumio-hhai bluetoothd[924]: profiles/audio/bap.c:bap_adapter_probe() BAP requires ISO Socket which is not enabled May 27 00:00:46 volumio-hhai bluetoothd[924]: bap: Operation not supported (95) May 27 00:00:46 volumio-hhai systemd[1]: Starting rc-local.service - /etc/rc.local Compatibility... May 27 00:00:46 volumio-hhai systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart... May 27 00:00:46 volumio-hhai systemd[1]: Starting samba-ad-dc.service - Samba AD Daemon... May 27 00:00:46 volumio-hhai bluetoothd[924]: Adv Monitor Manager created with supported features:0x00000000, enabled features:0x00000000, max number of supported monitors:32, max number of supported patterns:16 May 27 00:00:46 volumio-hhai sm-notify[1032]: Version 2.6.2 starting May 27 00:00:46 volumio-hhai systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... May 27 00:00:46 volumio-hhai systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 27 00:00:46 volumio-hhai systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 27 00:00:46 volumio-hhai systemd[1]: Started volumio-ipchange.service - Volumio IP Change Monitor. May 27 00:00:46 volumio-hhai systemd[1]: Starting welcome.service - Show a welcome message on console... May 27 00:00:46 volumio-hhai systemd[1]: Started loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling. May 27 00:00:46 volumio-hhai systemd[1]: Started rc-local.service - /etc/rc.local Compatibility. May 27 00:00:46 volumio-hhai systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart. May 27 00:00:46 volumio-hhai systemd[1]: Started systemd-hostnamed.service - Hostname Service. May 27 00:00:46 volumio-hhai welcome[1047]: Resolved ip:[0] May 27 00:00:46 volumio-hhai ntpd[1042]: INIT: ntpd ntpsec-1.2.2: Starting May 27 00:00:46 volumio-hhai ntpd[1042]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec May 27 00:00:46 volumio-hhai ntp-systemd-wrapper[1042]: 2026-05-27T00:00:46 ntpd[1042]: INIT: ntpd ntpsec-1.2.2: Starting May 27 00:00:46 volumio-hhai ntp-systemd-wrapper[1042]: 2026-05-27T00:00:46 ntpd[1042]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec May 27 00:00:46 volumio-hhai systemd[1]: Starting cpufrequtils.service - LSB: set CPUFreq kernel parameters... May 27 00:00:46 volumio-hhai systemd[1]: Started ntpsec.service - Network Time Service. May 27 00:00:46 volumio-hhai systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 27 00:00:46 volumio-hhai systemd[1]: Starting plymouth-quit-wait.service - Hold until boot process finishes up... May 27 00:00:46 volumio-hhai systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... May 27 00:00:46 volumio-hhai ntpd[1058]: INIT: precision = 0.065 usec (-24) May 27 00:00:46 volumio-hhai systemd[1]: Received SIGRTMIN+21 from PID 387 (plymouthd). May 27 00:00:46 volumio-hhai ifplugd(eth0)[1072]: ifplugd 0.28 initializing. May 27 00:00:46 volumio-hhai ifplugd(eth0)[1072]: Using interface eth0/D8:CB:8A:5D:C9:91 with driver (version: 6.12.57-volumio) May 27 00:00:46 volumio-hhai dhcpcd[952]: eth0: carrier lost May 27 00:00:46 volumio-hhai ifplugd(eth0)[1072]: Using detection mode: SIOCETHTOOL May 27 00:00:46 volumio-hhai ifplugd(eth0)[1072]: Initialization complete, link beat not detected. May 27 00:00:46 volumio-hhai ntpd[1058]: INIT: successfully locked into RAM May 27 00:00:46 volumio-hhai dhcpcd[827]: eth0: carrier lost May 27 00:00:46 volumio-hhai sh[815]: eth0: carrier lost May 27 00:00:46 volumio-hhai ntpd[1058]: CONFIG: readconfig: parsing file: /etc/ntpsec/ntp.conf May 27 00:00:46 volumio-hhai ntpd[1058]: CONFIG: restrict nopeer ignored May 27 00:00:46 volumio-hhai sh[815]: cat: /run/dhcpcd/hook-state/resolv.conf.eth0.link: No such file or directory May 27 00:00:46 volumio-hhai ntpd[1058]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 27 00:00:46 volumio-hhai ntpd[1058]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2026-06-28T00:00Z last=2017-01-01T00:00Z ofs=37 May 27 00:00:46 volumio-hhai ntpd[1058]: INIT: Using SO_TIMESTAMPNS(ns) May 27 00:00:46 volumio-hhai ntpd[1058]: IO: Listen and drop on 0 v6wildcard [::]:123 May 27 00:00:46 volumio-hhai ntpd[1058]: IO: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 27 00:00:46 volumio-hhai ntpd[1058]: IO: Listen normally on 2 lo 127.0.0.1:123 May 27 00:00:46 volumio-hhai ntpd[1058]: IO: Listening on routing socket on fd #19 for interface updates May 27 00:00:46 volumio-hhai ntpd[1058]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes May 27 00:00:46 volumio-hhai ntpd[1058]: INIT: Built with OpenSSL 3.0.9 30 May 2023, 30000090 May 27 00:00:46 volumio-hhai ntpd[1058]: INIT: Running with OpenSSL 3.0.18 30 Sep 2025, 30000120 May 27 00:00:46 volumio-hhai ntpd[1058]: NTSc: Using system default root certificates. May 27 00:00:46 volumio-hhai systemd[1]: Finished welcome.service - Show a welcome message on console. May 27 00:00:46 volumio-hhai systemd[1]: Received SIGRTMIN+21 from PID 387 (plymouthd). May 27 00:00:46 volumio-hhai systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. May 27 00:00:46 volumio-hhai ntpd[1058]: statistics directory /var/log/ntpsec/ does not exist or is unwriteable, error No such file or directory May 27 00:00:46 volumio-hhai systemd[1]: Started getty@tty1.service - Getty on tty1. May 27 00:00:46 volumio-hhai ifplugd[1021]: Network Interface Plugging Daemon...start eth0...done. May 27 00:00:46 volumio-hhai systemd[1]: Reached target getty.target - Login Prompts. May 27 00:00:46 volumio-hhai systemd[1]: Started ifplugd.service - LSB: Brings up/down network automatically. May 27 00:00:46 volumio-hhai systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. May 27 00:00:46 volumio-hhai cpufrequtils[1051]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. May 27 00:00:46 volumio-hhai systemd[1]: Started cpufrequtils.service - LSB: set CPUFreq kernel parameters. May 27 00:00:46 volumio-hhai bluealsa[980]: ../src/storage.c:90: Initializing persistent storage: /var/lib/bluealsa May 27 00:00:46 volumio-hhai bluealsa[980]: main.c:663: Starting main dispatching loop May 27 00:00:46 volumio-hhai systemd[1]: Started bluealsa.service - BlueALSA service. May 27 00:00:46 volumio-hhai bluealsa[980]: main.c:118: Acquired D-Bus service name: org.bluealsa May 27 00:00:46 volumio-hhai bluealsa[980]: bluealsa-dbus.c:358: Registering BlueALSA D-Bus manager: /org/bluealsa May 27 00:00:46 volumio-hhai systemd[1]: Reached target bluetooth.target - Bluetooth Support. May 27 00:00:46 volumio-hhai bluealsa[980]: bluez.c:153: Registering media application: /org/bluez/hci0 May 27 00:00:46 volumio-hhai bluealsa[980]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/source/1 May 27 00:00:46 volumio-hhai bluealsa[980]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/source/2 May 27 00:00:46 volumio-hhai bluealsa[980]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/sink/1 May 27 00:00:46 volumio-hhai bluealsa[980]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/sink/2 May 27 00:00:46 volumio-hhai bluetoothd[924]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/1 May 27 00:00:46 volumio-hhai bluetoothd[924]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/2 May 27 00:00:46 volumio-hhai bluetoothd[924]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/2 May 27 00:00:46 volumio-hhai bluetoothd[924]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/1 May 27 00:00:47 volumio-hhai systemd[1]: samba-ad-dc.service: Skipped due to 'exec-condition'. May 27 00:00:47 volumio-hhai systemd[1]: Condition check resulted in samba-ad-dc.service - Samba AD Daemon being skipped. May 27 00:00:47 volumio-hhai avahi-daemon[923]: Server startup complete. Host name is volumio-hhai.local. Local service cookie is 516966544. May 27 00:00:47 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Single Network Mode enabled (default) - only one network device can be active at a time between ethernet and wireless May 27 00:00:47 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow May 27 00:00:47 volumio-hhai nmbd[1144]: [2026/05/27 00:00:47.371639, 0] ../../source3/nmbd/nmbd.c:901(main) May 27 00:00:47 volumio-hhai nmbd[1144]: nmbd version 4.17.12-Debian started. May 27 00:00:47 volumio-hhai nmbd[1144]: Copyright Andrew Tridgell and the Samba Team 1992-2022 May 27 00:00:47 volumio-hhai nmbd[1144]: [2026/05/27 00:00:47.374610, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) May 27 00:00:47 volumio-hhai nmbd[1144]: started asyncdns process 1155 May 27 00:00:47 volumio-hhai nmbd[1144]: [2026/05/27 00:00:47.374946, 0] ../../lib/util/become_daemon.c:150(daemon_status) May 27 00:00:47 volumio-hhai nmbd[1144]: daemon_status: daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... May 27 00:00:47 volumio-hhai nmbd[1144]: [2026/05/27 00:00:47.374965, 0] ../../source3/nmbd/nmbd_subnetdb.c:252(create_subnets) May 27 00:00:47 volumio-hhai nmbd[1144]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). May 27 00:00:47 volumio-hhai sudo[1165]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 27 00:00:47 volumio-hhai sudo[1165]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:47 volumio-hhai sudo[1165]: pam_unix(sudo:session): session closed for user root May 27 00:00:47 volumio-hhai sudo[1168]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 27 00:00:47 volumio-hhai sudo[1168]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:47 volumio-hhai sudo[1168]: pam_unix(sudo:session): session closed for user root May 27 00:00:47 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Cleaning previous... May 27 00:00:47 volumio-hhai sudo[1171]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 27 00:00:47 volumio-hhai sudo[1171]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:47 volumio-hhai ntpd[1058]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 May 27 00:00:47 volumio-hhai ntpd[1058]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 May 27 00:00:47 volumio-hhai ntpd[1058]: DNS: dns_check: DNS error: -11, System error May 27 00:00:47 volumio-hhai ntpd[1058]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 May 27 00:00:47 volumio-hhai sudo[1171]: pam_unix(sudo:session): session closed for user root May 27 00:00:47 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations May 27 00:00:47 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 1ms May 27 00:00:47 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: d8:fc:93:b9:da:0c) May 27 00:00:47 volumio-hhai sudo[1179]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 27 00:00:47 volumio-hhai sudo[1179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:47 volumio-hhai sudo[1179]: pam_unix(sudo:session): session closed for user root May 27 00:00:47 volumio-hhai sudo[1187]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 27 00:00:47 volumio-hhai sudo[1187]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:48 volumio-hhai avahi-daemon[923]: Service "Volumio HHai" (/services/volumio.service) successfully established. May 27 00:00:48 volumio-hhai ntpd[1058]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 May 27 00:00:48 volumio-hhai ntpd[1058]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 May 27 00:00:48 volumio-hhai ntpd[1058]: DNS: dns_check: DNS error: -11, System error May 27 00:00:48 volumio-hhai ntpd[1058]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12 May 27 00:00:48 volumio-hhai dhcpcd[952]: eth0: carrier acquired May 27 00:00:48 volumio-hhai sh[815]: eth0: carrier acquired May 27 00:00:48 volumio-hhai dhcpcd[827]: eth0: carrier acquired May 27 00:00:48 volumio-hhai kernel: r8169 0000:03:00.0 eth0: Link is Up - 1Gbps/Full - flow control off May 27 00:00:48 volumio-hhai sh[815]: eth0: IAID 8a:5d:c9:91 May 27 00:00:48 volumio-hhai dhcpcd[952]: eth0: IAID 8a:5d:c9:91 May 27 00:00:48 volumio-hhai dhcpcd[827]: eth0: IAID 8a:5d:c9:91 May 27 00:00:48 volumio-hhai ifplugd(eth0)[1072]: Link beat detected. May 27 00:00:48 volumio-hhai ifplugd(eth0)[1072]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. May 27 00:00:48 volumio-hhai ifplugd(eth0)[1072]: client: ifup: waiting for lock on /run/network/ifstate.eth0 May 27 00:00:48 volumio-hhai dhcpcd[952]: eth0: soliciting an IPv6 router May 27 00:00:48 volumio-hhai dhcpcd[827]: eth0: soliciting an IPv6 router May 27 00:00:48 volumio-hhai sh[815]: eth0: soliciting an IPv6 router May 27 00:00:49 volumio-hhai ntpd[1058]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 May 27 00:00:49 volumio-hhai ntpd[1058]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 May 27 00:00:49 volumio-hhai ntpd[1058]: DNS: dns_check: DNS error: -11, System error May 27 00:00:49 volumio-hhai ntpd[1058]: DNS: dns_take_status: 2.debian.pool.ntp.org=>error, 12 May 27 00:00:50 volumio-hhai systemd[1]: systemd-rfkill.service: Deactivated successfully. May 27 00:00:50 volumio-hhai dhcpcd[952]: eth0: rebinding lease of 192.168.30.243 May 27 00:00:50 volumio-hhai dhcpcd[952]: eth0: probing address 192.168.30.243/24 May 27 00:00:50 volumio-hhai sh[815]: eth0: rebinding lease of 192.168.30.243 May 27 00:00:50 volumio-hhai dhcpcd[827]: eth0: rebinding lease of 192.168.30.243 May 27 00:00:50 volumio-hhai dhcpcd[827]: eth0: probing address 192.168.30.243/24 May 27 00:00:50 volumio-hhai sh[815]: eth0: probing address 192.168.30.243/24 May 27 00:00:50 volumio-hhai ntpd[1058]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 May 27 00:00:50 volumio-hhai ntpd[1058]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 May 27 00:00:50 volumio-hhai ntpd[1058]: DNS: dns_check: DNS error: -11, System error May 27 00:00:50 volumio-hhai ntpd[1058]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12 May 27 00:00:51 volumio-hhai sudo[1187]: pam_unix(sudo:session): session closed for user root May 27 00:00:51 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: SETTING APPROPRIATE REG DOMAIN: US May 27 00:00:51 volumio-hhai sudo[1227]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set US May 27 00:00:51 volumio-hhai sudo[1227]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:51 volumio-hhai sudo[1227]: pam_unix(sudo:session): session closed for user root May 27 00:00:51 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: SUCCESSFULLY SET NEW REGDOMAIN: US May 27 00:00:51 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: refreshEthernetState: Corrected ethernet state: connected May 27 00:00:51 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: netconfigured file not found, starting hotspot May 27 00:00:51 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Single Network Mode: Ethernet active, maintaining WiFi scan capability May 27 00:00:51 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: SNM: Maintaining wlan0 UP without IP (scan mode) May 27 00:00:51 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: SNM: Users can configure WiFi via WebUI while ethernet is active May 27 00:00:51 volumio-hhai sudo[1236]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 27 00:00:51 volumio-hhai sudo[1236]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:51 volumio-hhai sudo[1236]: pam_unix(sudo:session): session closed for user root May 27 00:00:51 volumio-hhai sudo[1239]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 27 00:00:51 volumio-hhai sudo[1239]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:51 volumio-hhai sudo[1239]: pam_unix(sudo:session): session closed for user root May 27 00:00:51 volumio-hhai wpa_supplicant[1242]: Successfully initialized wpa_supplicant May 27 00:00:51 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: SNM: wlan0 is UP without IP, scan capable May 27 00:00:51 volumio-hhai wireless.js[934]: Failed to connect to non-global ctrl_ifname: wlan0 error: No such file or directory May 27 00:00:51 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Notified systemd about wireless ready May 27 00:00:51 volumio-hhai systemd[1]: Started wireless.service - Wireless Services. May 27 00:00:51 volumio-hhai systemd[1]: Started volumio.service - Volumio Backend Module. May 27 00:00:51 volumio-hhai systemd[1]: Started screenshot.service - Process screenshots triggered by PrtSc-button. May 27 00:00:51 volumio-hhai systemd[1]: Started soundcard-init.service - Intel SST and HDA soundcard init service. May 27 00:00:51 volumio-hhai systemd[1]: Started volumio-kiosk.service - Start Volumio Kiosk. May 27 00:00:51 volumio-hhai systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. May 27 00:00:51 volumio-hhai volumio-remote-updater[933]: [2026-05-27 00:00:51] [info] asio async_connect error: asio.system:111 (Connection refused) May 27 00:00:51 volumio-hhai volumio-remote-updater[933]: [2026-05-27 00:00:51] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) May 27 00:00:51 volumio-hhai volumio-remote-updater[933]: [2026-05-27 00:00:51] [error] handle_connect error: Connection refused May 27 00:00:51 volumio-hhai volumio-cpu-tweak[1270]: Setting RT Priority for mpd May 27 00:00:51 volumio-hhai volumio-cpu-tweak[1300]: pid 35's current scheduling policy: SCHED_OTHER May 27 00:00:51 volumio-hhai volumio-cpu-tweak[1300]: pid 35's current scheduling priority: 0 May 27 00:00:51 volumio-hhai volumio-cpu-tweak[1270]: Not enough cores to set MPD affinity May 27 00:00:51 volumio-hhai volumio-cpu-tweak[1270]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 27 00:00:51 volumio-hhai systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. May 27 00:00:51 volumio-hhai soundcard-init.sh[1338]: Card 0 Chip Intel Haswell HDMI Name HDA Intel HDMI May 27 00:00:51 volumio-hhai soundcard-init.sh[1338]: Card 5 Chip USB Mixer Name HugoTT2 May 27 00:00:51 volumio-hhai systemd[1]: soundcard-init.service: Deactivated successfully. May 27 00:00:51 volumio-hhai startx[1337]: X.Org X Server 1.21.1.7 May 27 00:00:51 volumio-hhai startx[1337]: X Protocol Version 11, Revision 0 May 27 00:00:51 volumio-hhai startx[1337]: Current Operating System: Linux volumio-hhai 6.12.57-volumio #2 SMP PREEMPT_DYNAMIC Thu Nov 13 17:08:37 CET 2025 x86_64 May 27 00:00:51 volumio-hhai startx[1337]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=989265ff-d248-4f89-8e52-b7555c637af2 bootpart=UUID=DDF4-322F datapart=UUID=e4183fc1-3cea-4235-aefc-fb12bf1a152b hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=native net.ifnames=0 use_kmsg=no May 27 00:00:51 volumio-hhai startx[1337]: xorg-server 2:21.1.7-3+deb12u11 (https://www.debian.org/support) May 27 00:00:51 volumio-hhai startx[1337]: Current version of pixman: 0.42.2 May 27 00:00:51 volumio-hhai startx[1337]: Before reporting problems, check http://wiki.x.org May 27 00:00:51 volumio-hhai startx[1337]: to make sure that you have the latest version. May 27 00:00:51 volumio-hhai startx[1337]: Markers: (--) probed, (**) from config file, (==) default setting, May 27 00:00:51 volumio-hhai startx[1337]: (++) from command line, (!!) notice, (II) informational, May 27 00:00:51 volumio-hhai startx[1337]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 27 00:00:51 volumio-hhai startx[1337]: (==) Log file: "/var/log/Xorg.0.log", Time: Wed May 27 00:00:51 2026 May 27 00:00:51 volumio-hhai startx[1337]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: === SNM TRANSITION === May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Previous ethernet state: disconnected May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: New ethernet state: connected May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Single Network Mode: enabled May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: First start: no May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode) May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: === END TRANSITION === May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: SNM: Ethernet connected, switching to ethernet (WiFi scan mode) May 27 00:00:52 volumio-hhai sudo[1371]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd -k wlan0 May 27 00:00:52 volumio-hhai sudo[1371]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:52 volumio-hhai dhcpcd[1372]: dhcpcd not running May 27 00:00:52 volumio-hhai sudo[1371]: pam_unix(sudo:session): session closed for user root May 27 00:00:52 volumio-hhai wireless.js[934]: dhcpcd not running May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow May 27 00:00:52 volumio-hhai wpa_supplicant[1245]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all May 27 00:00:52 volumio-hhai wpa_supplicant[1245]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all May 27 00:00:52 volumio-hhai wpa_supplicant[1245]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0 May 27 00:00:52 volumio-hhai volumio[1261]: info: ------------------------------------------- May 27 00:00:52 volumio-hhai volumio[1261]: info: ----- Volumio3 ---- May 27 00:00:52 volumio-hhai volumio[1261]: info: ------------------------------------------- May 27 00:00:52 volumio-hhai volumio[1261]: info: ----- System startup ---- May 27 00:00:52 volumio-hhai volumio[1261]: info: ------------------------------------------- May 27 00:00:52 volumio-hhai wpa_supplicant[1245]: p2p-dev-wlan0: CTRL-EVENT-TERMINATING May 27 00:00:52 volumio-hhai wpa_supplicant[1245]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all May 27 00:00:52 volumio-hhai sudo[1386]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 27 00:00:52 volumio-hhai sudo[1386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:52 volumio-hhai sudo[1386]: pam_unix(sudo:session): session closed for user root May 27 00:00:52 volumio-hhai sudo[1388]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 27 00:00:52 volumio-hhai sudo[1388]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:52 volumio-hhai sudo[1388]: pam_unix(sudo:session): session closed for user root May 27 00:00:52 volumio-hhai wpa_supplicant[1245]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all May 27 00:00:52 volumio-hhai wpa_supplicant[1245]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 May 27 00:00:52 volumio-hhai wpa_supplicant[1245]: wlan0: CTRL-EVENT-TERMINATING May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Cleaning previous... May 27 00:00:52 volumio-hhai sudo[1392]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 27 00:00:52 volumio-hhai sudo[1392]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:52 volumio-hhai bash[1040]: setdatetime-helper: all HTTPS Date fallbacks failed May 27 00:00:52 volumio-hhai systemd[1]: setdatetime-helper.service: Deactivated successfully. May 27 00:00:52 volumio-hhai systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. May 27 00:00:52 volumio-hhai volumio[1261]: info: MYVOLUMIO Environment detected May 27 00:00:52 volumio-hhai volumio[1261]: info: Plugin folders cleanup May 27 00:00:52 volumio-hhai volumio[1261]: info: Scanning into folder /volumio/app/plugins/ May 27 00:00:52 volumio-hhai volumio[1261]: info: Scanning category audio_interface May 27 00:00:52 volumio-hhai volumio[1261]: info: Scanning category miscellanea May 27 00:00:52 volumio-hhai volumio[1261]: info: Scanning category music_service May 27 00:00:52 volumio-hhai volumio[1261]: info: Scanning category plugins.json May 27 00:00:52 volumio-hhai volumio[1261]: info: Scanning category system_controller May 27 00:00:52 volumio-hhai volumio[1261]: info: Scanning category user_interface May 27 00:00:52 volumio-hhai volumio[1261]: info: Scanning into folder /data/plugins/ May 27 00:00:52 volumio-hhai volumio[1261]: info: Scanning category music_service May 27 00:00:52 volumio-hhai volumio[1261]: info: Plugin folders cleanup completed May 27 00:00:52 volumio-hhai volumio[1261]: info: ------------------------------------------- May 27 00:00:52 volumio-hhai volumio[1261]: info: ----- Core plugins startup ---- May 27 00:00:52 volumio-hhai volumio[1261]: info: ------------------------------------------- May 27 00:00:52 volumio-hhai volumio[1261]: info: Loading plugins from folder /volumio/app/plugins/ May 27 00:00:52 volumio-hhai volumio[1261]: info: Adding plugin upnp to MyMusic Plugins May 27 00:00:52 volumio-hhai volumio[1261]: info: Adding plugin airplay_emulation to MyMusic Plugins May 27 00:00:52 volumio-hhai volumio[1261]: info: Adding plugin upnp_browser to MyMusic Plugins May 27 00:00:52 volumio-hhai volumio[1261]: info: Loading plugins from folder /data/plugins/ May 27 00:00:52 volumio-hhai volumio[1261]: info: Loading plugin "system"... May 27 00:00:52 volumio-hhai volumio[1261]: info: Loading plugin "appearance"... May 27 00:00:52 volumio-hhai sudo[1392]: pam_unix(sudo:session): session closed for user root May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 1ms May 27 00:00:52 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: d8:fc:93:b9:da:0c) May 27 00:00:52 volumio-hhai sudo[1409]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 27 00:00:52 volumio-hhai sudo[1409]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:52 volumio-hhai sudo[1409]: pam_unix(sudo:session): session closed for user root May 27 00:00:52 volumio-hhai sudo[1418]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 27 00:00:52 volumio-hhai sudo[1418]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "network"... May 27 00:00:53 volumio-hhai volumio[1261]: info: Refreshing Cached IP Addresses May 27 00:00:53 volumio-hhai sudo[1463]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 27 00:00:53 volumio-hhai sudo[1463]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:53 volumio-hhai sudo[1467]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 27 00:00:53 volumio-hhai sudo[1467]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:53 volumio-hhai sudo[1463]: pam_unix(sudo:session): session closed for user root May 27 00:00:53 volumio-hhai sudo[1467]: pam_unix(sudo:session): session closed for user root May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "services"... May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "volumio5onboarding"... May 27 00:00:53 volumio-hhai sudo[1488]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 27 00:00:53 volumio-hhai sudo[1488]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:53 volumio-hhai sudo[1488]: pam_unix(sudo:session): session closed for user root May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "alsa_controller"... May 27 00:00:53 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "wizard"... May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "networkfs"... May 27 00:00:53 volumio-hhai volumio[1261]: info: Starting Udev Watcher for removable devices May 27 00:00:53 volumio-hhai volumio[1261]: info: Ignoring mount for partition: boot May 27 00:00:53 volumio-hhai volumio[1261]: info: Ignoring mount for partition: volumio May 27 00:00:53 volumio-hhai volumio[1261]: info: Ignoring mount for partition: volumio_data May 27 00:00:53 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "volumio_command_line_client"... May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "upnp"... May 27 00:00:53 volumio-hhai volumio[1261]: info: [1779814853199] Starting Upmpd Daemon May 27 00:00:53 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "my_music"... May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "mpd"... May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "upnp_browser"... May 27 00:00:53 volumio-hhai volumio[1261]: info: Starting UPNP Browser May 27 00:00:53 volumio-hhai volumio[1261]: info: Loading plugin "alarm-clock"... May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "airplay_emulation"... May 27 00:00:54 volumio-hhai volumio[1261]: info: Starting Shairport Sync May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "last_100"... May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "webradio"... May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "i2s_dacs"... May 27 00:00:54 volumio-hhai volumio[1261]: info: I2S DAC not set, start Auto-detection May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "volumiodiscovery"... May 27 00:00:54 volumio-hhai volumio[1261]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 27 00:00:54 volumio-hhai node[1261]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 27 00:00:54 volumio-hhai volumio[1261]: *** WARNING *** Please fix your application to use the native API of Avahi! May 27 00:00:54 volumio-hhai node[1261]: *** WARNING *** Please fix your application to use the native API of Avahi! May 27 00:00:54 volumio-hhai volumio[1261]: *** WARNING *** For more information see May 27 00:00:54 volumio-hhai node[1261]: *** WARNING *** For more information see May 27 00:00:54 volumio-hhai volumio[1261]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 27 00:00:54 volumio-hhai node[1261]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 27 00:00:54 volumio-hhai volumio[1261]: *** WARNING *** Please fix your application to use the native API of Avahi! May 27 00:00:54 volumio-hhai node[1261]: *** WARNING *** Please fix your application to use the native API of Avahi! May 27 00:00:54 volumio-hhai volumio[1261]: *** WARNING *** For more information see May 27 00:00:54 volumio-hhai node[1261]: *** WARNING *** For more information see May 27 00:00:54 volumio-hhai volumio[1261]: info: Applying required configuration parameters for plugin volumiodiscovery May 27 00:00:54 volumio-hhai volumio[1261]: info: Discovery: Started advertising with name: Volumio HHai May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "spop"... May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "outputs"... May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "albumart"... May 27 00:00:54 volumio-hhai volumio[1261]: info: Plugin example_plugin is not enabled May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "inputs"... May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "updater_comm"... May 27 00:00:54 volumio-hhai volumio[1261]: info: Plugin mpdemulation is not enabled May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "rest_api"... May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading plugin "websocket"... May 27 00:00:54 volumio-hhai volumio[1261]: info: Starting Socket.io Server version 1.7.4 May 27 00:00:54 volumio-hhai volumio[1261]: info: Loading i18n strings for locale en May 27 00:00:54 volumio-hhai volumio[1261]: Updating browse sources language May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 27 00:00:54 volumio-hhai volumio[1556]: Forking 1 albumart workers May 27 00:00:54 volumio-hhai volumio[1567]: Starting albumart workers May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::initPlayerControls May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: Express server listening on port 3000 May 27 00:00:54 volumio-hhai volumio[1261]: [Metrics] WebUI: 2s 747.75ms May 27 00:00:54 volumio-hhai volumio[1261]: info: Setting Device type: x86 May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreStateMachine::resetVolumioState May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreStateMachine::getcurrentVolume May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioRetrievevolume May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' May 27 00:00:54 volumio-hhai volumio[1261]: info: Completed loading Core Plugins May 27 00:00:54 volumio-hhai volumio[1261]: info: Preparing to generate the ALSA configuration file May 27 00:00:54 volumio-hhai volumio[1261]: info: Cannot read play queue from file May 27 00:00:54 volumio-hhai volumio[1261]: info: Volumio Network Manager: Network status updated: 0 May 27 00:00:54 volumio-hhai volumio[1261]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 27 00:00:54 volumio-hhai volumio[1261]: wlan0 Interface doesn't support scanning : Device or resource busy May 27 00:00:54 volumio-hhai volumio[1261]: info: Cannot use regular scanning, forcing with ap-force May 27 00:00:54 volumio-hhai sudo[1586]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 27 00:00:54 volumio-hhai sudo[1586]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:54 volumio-hhai sudo[1586]: pam_unix(sudo:session): session closed for user root May 27 00:00:54 volumio-hhai volumio[1261]: command failed: Device or resource busy (-16) May 27 00:00:54 volumio-hhai volumio[1261]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force May 27 00:00:54 volumio-hhai volumio[1261]: command failed: Device or resource busy (-16) May 27 00:00:54 volumio-hhai volumio[1261]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision May 27 00:00:54 volumio-hhai volumio[1261]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 May 27 00:00:54 volumio-hhai volumio[1261]: info: Asound.conf file unchanged, so no further update is needed May 27 00:00:54 volumio-hhai volumio[1261]: info: Output device has changed, restarting MPD May 27 00:00:54 volumio-hhai volumio[1261]: info: Output device has changed, restarting Shairport Sync May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:54 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 00:00:54 volumio-hhai sudo[1607]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 27 00:00:54 volumio-hhai sudo[1607]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:54 volumio-hhai volumio[1261]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 27 00:00:54 volumio-hhai volumio[1261]: info: ___________ START PLUGINS ___________ May 27 00:00:54 volumio-hhai sudo[1609]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 27 00:00:54 volumio-hhai sudo[1609]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:54 volumio-hhai sudo[1607]: pam_unix(sudo:session): session closed for user root May 27 00:00:54 volumio-hhai volumio[1261]: info: ControllerMpd::onStart: Initializing MPD May 27 00:00:54 volumio-hhai volumio[1261]: info: Creating MPD Configuration file May 27 00:00:54 volumio-hhai sudo[1622]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service May 27 00:00:54 volumio-hhai sudo[1622]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:54 volumio-hhai systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 27 00:00:55 volumio-hhai systemd[1]: Starting mpd.service - Music Player Daemon... May 27 00:00:55 volumio-hhai systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 27 00:00:55 volumio-hhai volumio[1261]: info: [1779814855013] CoreMusicLibrary::Adding element Media Servers May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 27 00:00:55 volumio-hhai sudo[1622]: pam_unix(sudo:session): session closed for user root May 27 00:00:55 volumio-hhai sudo[1631]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 27 00:00:55 volumio-hhai sudo[1635]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 27 00:00:55 volumio-hhai sudo[1635]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:55 volumio-hhai volumio[1261]: info: UPNP Browser: Client initialized successfully May 27 00:00:55 volumio-hhai sudo[1631]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 00:00:55 volumio-hhai sudo[1633]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 27 00:00:55 volumio-hhai sudo[1633]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:55 volumio-hhai sudo[1633]: pam_unix(sudo:session): session closed for user root May 27 00:00:55 volumio-hhai systemd[1]: mpd.service: Deactivated successfully. May 27 00:00:55 volumio-hhai systemd[1]: Stopped mpd.service - Music Player Daemon. May 27 00:00:55 volumio-hhai systemd[1]: mpd.socket: Deactivated successfully. May 27 00:00:55 volumio-hhai systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 27 00:00:55 volumio-hhai systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 27 00:00:55 volumio-hhai volumio[1261]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 00:00:55 volumio-hhai sudo[1631]: pam_unix(sudo:session): session closed for user root May 27 00:00:55 volumio-hhai volumio[1261]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 27 00:00:55 volumio-hhai systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 27 00:00:55 volumio-hhai volumio[1261]: info: [1779814855086] CoreMusicLibrary::Adding element Last_100 May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 27 00:00:55 volumio-hhai systemd[1]: Starting mpd.service - Music Player Daemon... May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 27 00:00:55 volumio-hhai volumio[1261]: info: [1779814855093] CoreMusicLibrary::Adding element Webradio May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 27 00:00:55 volumio-hhai volumio[1261]: info: Initializing BBC Radios May 27 00:00:55 volumio-hhai sudo[1650]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 27 00:00:55 volumio-hhai sudo[1650]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:55 volumio-hhai sudo[1665]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory May 27 00:00:55 volumio-hhai sudo[1650]: pam_unix(sudo:session): session closed for user root May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: Creating Spotify config file May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: Volumio Calling Home May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreStateMachine::setRepeat null single undefined May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreStateMachine::pushState May 27 00:00:55 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioPushState May 27 00:00:55 volumio-hhai volumio5-onboarding[1634]: time=2026-05-27T00:00:55.351+07:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreStateMachine::setRandom null May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreStateMachine::pushState May 27 00:00:55 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioPushState May 27 00:00:55 volumio-hhai volumio[1261]: info: VolumeController:: Volume=undefined Mute =false May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreStateMachine::pushState May 27 00:00:55 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioPushState May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreStateMachine::updateTrackBlock May 27 00:00:55 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrackBlock May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioRetrievevolume May 27 00:00:55 volumio-hhai volumio[1261]: Unhandled rejection Error: No sockets available, cannot start. May 27 00:00:55 volumio-hhai volumio[1261]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) May 27 00:00:55 volumio-hhai volumio[1261]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) May 27 00:00:55 volumio-hhai volumio[1261]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 May 27 00:00:55 volumio-hhai volumio[1261]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) May 27 00:00:55 volumio-hhai volumio[1261]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) May 27 00:00:55 volumio-hhai volumio[1261]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) May 27 00:00:55 volumio-hhai volumio[1261]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) May 27 00:00:55 volumio-hhai volumio[1261]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) May 27 00:00:55 volumio-hhai volumio[1261]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) May 27 00:00:55 volumio-hhai volumio[1261]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) May 27 00:00:55 volumio-hhai volumio[1261]: at HashMap. (/volumio/app/pluginmanager.js:496:31) May 27 00:00:55 volumio-hhai volumio[1261]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) May 27 00:00:55 volumio-hhai volumio[1261]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) May 27 00:00:55 volumio-hhai volumio[1261]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) May 27 00:00:55 volumio-hhai volumio[1261]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) May 27 00:00:55 volumio-hhai volumio[1261]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 27 00:00:55 volumio-hhai volumio[1261]: info: MPD Permissions set May 27 00:00:55 volumio-hhai volumio[1261]: info: MPD Permissions set May 27 00:00:55 volumio-hhai volumio[1261]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 May 27 00:00:55 volumio-hhai volumio[1261]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 May 27 00:00:55 volumio-hhai volumio[1261]: info: Spotify config file written May 27 00:00:55 volumio-hhai volumio[1261]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 May 27 00:00:55 volumio-hhai sudo[1697]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service May 27 00:00:55 volumio-hhai volumio[1261]: info: Received Get System Info May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 27 00:00:55 volumio-hhai volumio[1261]: info: Discovery: Getting this device information May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:55 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 27 00:00:55 volumio-hhai sudo[1697]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:55 volumio-hhai volumio5-onboarding[1634]: time=2026-05-27T00:00:55.440+07:00 level=INFO msg="system info for cdffa80249ceb506559985fab855f015" deviceName="Volumio HHai" deviceVariant=volumio deviceModel= softwareVersion=4.119 May 27 00:00:55 volumio-hhai volumio[1261]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio5-onboarding[1634]: time=2026-05-27T00:00:55.451+07:00 level=INFO msg="bootstrapping state" hasInternet=false May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 27 00:00:55 volumio-hhai systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 27 00:00:55 volumio-hhai systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 27 00:00:55 volumio-hhai systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 27 00:00:55 volumio-hhai go-librespot[1708]: go-librespot daemon starting... May 27 00:00:55 volumio-hhai sudo[1697]: pam_unix(sudo:session): session closed for user root May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 27 00:00:55 volumio-hhai dhcpcd[952]: eth0: leased 192.168.30.243 for 1800 seconds May 27 00:00:55 volumio-hhai dhcpcd[952]: eth0: adding route to 192.168.30.0/24 May 27 00:00:55 volumio-hhai dhcpcd[952]: eth0: adding default route via 192.168.30.1 May 27 00:00:55 volumio-hhai avahi-daemon[923]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.30.243. May 27 00:00:55 volumio-hhai avahi-daemon[923]: New relevant interface eth0.IPv4 for mDNS. May 27 00:00:55 volumio-hhai avahi-daemon[923]: Registering new address record for 192.168.30.243 on eth0.IPv4. May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 00:00:55 volumio-hhai volumio[1261]: info: No need to fix Spotify hosts May 27 00:00:55 volumio-hhai volumio[1261]: info: Discovery: adding 3ce8b29d-bb7d-4158-86c6-64e9aa31c762 May 27 00:00:55 volumio-hhai volumio[1261]: info: Discovery: Found device Volumio HHai May 27 00:00:55 volumio-hhai systemd[1]: welcome.service: Deactivated successfully. May 27 00:00:55 volumio-hhai systemd[1]: Stopped welcome.service - Show a welcome message on console. May 27 00:00:55 volumio-hhai systemd[1]: Stopping welcome.service - Show a welcome message on console... May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:55 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:55 volumio-hhai systemd[1]: Starting welcome.service - Show a welcome message on console... May 27 00:00:55 volumio-hhai welcome[1731]: Resolved ip:[1] 192.168.30.243 May 27 00:00:55 volumio-hhai go-librespot[1710]: time="2026-05-27T00:00:55+07:00" level=info msg="running go-librespot 0.7.1" May 27 00:00:55 volumio-hhai go-librespot[1710]: time="2026-05-27T00:00:55+07:00" level=debug msg="app state loaded" May 27 00:00:55 volumio-hhai go-librespot[1710]: time="2026-05-27T00:00:55+07:00" level=debug msg="stored credentials not found" May 27 00:00:55 volumio-hhai volumio[1261]: info: VolumeController:: Volume=undefined Mute =false May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreStateMachine::pushState May 27 00:00:55 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioPushState May 27 00:00:55 volumio-hhai volumio[1261]: info: Received Get System Info May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 27 00:00:55 volumio-hhai volumio[1261]: info: Discovery: Getting this device information May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:55 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 27 00:00:55 volumio-hhai go-librespot[1710]: time="2026-05-27T00:00:55+07:00" level=info msg="api server listening on 127.0.0.1:9879" May 27 00:00:55 volumio-hhai systemd[1]: Finished welcome.service - Show a welcome message on console. May 27 00:00:55 volumio-hhai systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 27 00:00:55 volumio-hhai volumio5-onboarding[1634]: time=2026-05-27T00:00:55.601+07:00 level=INFO msg="enabling local network discovery" May 27 00:00:55 volumio-hhai volumio[1261]: info: Starting Shairport Sync May 27 00:00:55 volumio-hhai volumio5-onboarding[1634]: time=2026-05-27T00:00:55.609+07:00 level=INFO msg="enabling BLE discovery" May 27 00:00:55 volumio-hhai volumio[1261]: info: Starting Shairport Sync May 27 00:00:55 volumio-hhai volumio[1261]: info: Starting Shairport Sync May 27 00:00:55 volumio-hhai sudo[1753]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 27 00:00:55 volumio-hhai sudo[1753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:55 volumio-hhai systemd[1]: Started nmbd.service - Samba NMB Daemon. May 27 00:00:55 volumio-hhai sudo[1758]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 27 00:00:55 volumio-hhai sudo[1755]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 27 00:00:55 volumio-hhai sudo[1755]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:55 volumio-hhai systemd[1]: Starting winbind.service - Samba Winbind Daemon... May 27 00:00:55 volumio-hhai sudo[1758]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:00:55 volumio-hhai systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 27 00:00:55 volumio-hhai systemd[1]: shairport-sync.service: Deactivated successfully. May 27 00:00:55 volumio-hhai systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 27 00:00:55 volumio-hhai systemd[1]: shairport-sync.service: Consumed 1.411s CPU time. May 27 00:00:55 volumio-hhai systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 27 00:00:55 volumio-hhai sudo[1753]: pam_unix(sudo:session): session closed for user root May 27 00:00:55 volumio-hhai systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 27 00:00:55 volumio-hhai systemd[1]: shairport-sync.service: Deactivated successfully. May 27 00:00:55 volumio-hhai systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 27 00:00:55 volumio-hhai volumio[1261]: info: Shairport-Sync Started May 27 00:00:55 volumio-hhai volumio[1261]: Error adding Membership: Error: addMembership EINVAL May 27 00:00:55 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:55 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:55 volumio-hhai systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 27 00:00:55 volumio-hhai sudo[1755]: pam_unix(sudo:session): session closed for user root May 27 00:00:55 volumio-hhai sudo[1758]: pam_unix(sudo:session): session closed for user root May 27 00:00:55 volumio-hhai volumio[1261]: info: Shairport-Sync Started May 27 00:00:55 volumio-hhai volumio[1261]: info: Shairport-Sync Started May 27 00:00:55 volumio-hhai sudo[1418]: pam_unix(sudo:session): session closed for user root May 27 00:00:55 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Regdomain already correct: US May 27 00:00:55 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: netconfigured file not found, starting hotspot May 27 00:00:55 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Single Network Mode: Ethernet active, maintaining WiFi scan capability May 27 00:00:55 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: SNM: Maintaining wlan0 UP without IP (scan mode) May 27 00:00:55 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: SNM: Users can configure WiFi via WebUI while ethernet is active May 27 00:00:55 volumio-hhai dhcpcd[827]: eth0: leased 192.168.30.243 for 1800 seconds May 27 00:00:55 volumio-hhai sh[815]: eth0: leased 192.168.30.243 for 1800 seconds May 27 00:00:55 volumio-hhai systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. May 27 00:00:55 volumio-hhai systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... May 27 00:00:55 volumio-hhai systemd[1]: welcome.service: Deactivated successfully. May 27 00:00:55 volumio-hhai systemd[1]: Stopped welcome.service - Show a welcome message on console. May 27 00:00:55 volumio-hhai systemd[1]: Stopping welcome.service - Show a welcome message on console... May 27 00:00:55 volumio-hhai systemd[1]: Starting welcome.service - Show a welcome message on console... May 27 00:00:55 volumio-hhai welcome[1815]: Resolved ip:[1] 192.168.30.243 May 27 00:00:55 volumio-hhai dhcpcd[827]: eth0: adding route to 192.168.30.0/24 May 27 00:00:55 volumio-hhai dhcpcd[827]: eth0: adding default route via 192.168.30.1 May 27 00:00:55 volumio-hhai sh[815]: eth0: adding route to 192.168.30.0/24 May 27 00:00:55 volumio-hhai sudo[1826]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 27 00:00:55 volumio-hhai sudo[1826]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:55 volumio-hhai systemd[1]: Finished welcome.service - Show a welcome message on console. May 27 00:00:55 volumio-hhai systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. May 27 00:00:55 volumio-hhai sudo[1826]: pam_unix(sudo:session): session closed for user root May 27 00:00:55 volumio-hhai sudo[1854]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 27 00:00:55 volumio-hhai sudo[1854]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 27 00:00:55 volumio-hhai sudo[1854]: pam_unix(sudo:session): session closed for user root May 27 00:00:55 volumio-hhai wpa_supplicant[1860]: Successfully initialized wpa_supplicant May 27 00:00:56 volumio-hhai winbindd[1768]: [2026/05/27 00:00:56.006429, 0] ../../source3/winbindd/winbindd.c:1440(main) May 27 00:00:56 volumio-hhai winbindd[1768]: winbindd version 4.17.12-Debian started. May 27 00:00:56 volumio-hhai winbindd[1768]: Copyright Andrew Tridgell and the Samba Team 1992-2022 May 27 00:00:56 volumio-hhai winbindd[1768]: [2026/05/27 00:00:56.030393, 0] ../../source3/winbindd/winbindd_cache.c:3117(initialize_winbindd_cache) May 27 00:00:56 volumio-hhai winbindd[1768]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 27 00:00:56 volumio-hhai systemd[1]: Started winbind.service - Samba Winbind Daemon. May 27 00:00:56 volumio-hhai ifplugd(eth0)[1072]: client: ifup: interface eth0 already configured May 27 00:00:56 volumio-hhai systemd[1]: Starting smbd.service - Samba SMB Daemon... May 27 00:00:56 volumio-hhai sh[1878]: eth0=eth0 May 27 00:00:56 volumio-hhai go-librespot[1710]: time="2026-05-27T00:00:56+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" May 27 00:00:56 volumio-hhai go-librespot[1710]: time="2026-05-27T00:00:56+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" May 27 00:00:56 volumio-hhai go-librespot[1710]: time="2026-05-27T00:00:56+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" May 27 00:00:56 volumio-hhai go-librespot[1710]: time="2026-05-27T00:00:56+07:00" level=info msg="zeroconf server listening on port 41553" May 27 00:00:56 volumio-hhai go-librespot[1710]: time="2026-05-27T00:00:56+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" May 27 00:00:56 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: SNM: Transition to scan mode completed in 3898ms May 27 00:00:56 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: SNM: wlan0 is UP without IP, scan capable May 27 00:00:56 volumio-hhai wireless.js[934]: Failed to connect to non-global ctrl_ifname: wlan0 error: No such file or directory May 27 00:00:56 volumio-hhai wireless.js[934]: WIRELESS.JS - INFO: Notified systemd about wireless ready May 27 00:00:56 volumio-hhai ifplugd(eth0)[1072]: Program executed successfully. May 27 00:00:56 volumio-hhai smbd[1903]: [2026/05/27 00:00:56.342861, 0] ../../source3/smbd/server.c:1741(main) May 27 00:00:56 volumio-hhai smbd[1903]: smbd version 4.17.12-Debian started. May 27 00:00:56 volumio-hhai smbd[1903]: Copyright Andrew Tridgell and the Samba Team 1992-2022 May 27 00:00:56 volumio-hhai volumio[1261]: info: Received Get System Info May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 27 00:00:56 volumio-hhai volumio[1261]: info: Discovery: Getting this device information May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:56 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 27 00:00:56 volumio-hhai volumio[1261]: info: Received Get System Info May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 27 00:00:56 volumio-hhai volumio[1261]: info: Discovery: Getting this device information May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:56 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 27 00:00:56 volumio-hhai volumio[1261]: info: Discovery: this is already registered, 3ce8b29d-bb7d-4158-86c6-64e9aa31c762 May 27 00:00:56 volumio-hhai volumio[1261]: info: Discovery: Found device Volumio HHai May 27 00:00:56 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:56 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:57 volumio-hhai systemd[1]: Started smbd.service - Samba SMB Daemon. May 27 00:00:57 volumio-hhai systemd[1]: Reached target multi-user.target - Multi-User System. May 27 00:00:57 volumio-hhai systemd[1]: Reached target graphical.target - Graphical Interface. May 27 00:00:57 volumio-hhai systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... May 27 00:00:57 volumio-hhai systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. May 27 00:00:57 volumio-hhai systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. May 27 00:00:57 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 27 00:00:57 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 27 00:00:57 volumio-hhai volumio[1261]: info: Discovery: Getting this device information May 27 00:00:57 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:57 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:57 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 27 00:00:57 volumio-hhai volumio[1261]: verbose: New Socket.io Connection to 192.168.30.243:3000 from 192.168.30.249 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3 May 27 00:00:57 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 27 00:00:57 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 27 00:00:57 volumio-hhai mpd[1675]: 2026-05-27T00:00:57 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 27 00:00:57 volumio-hhai systemd[1]: Started mpd.service - Music Player Daemon. May 27 00:00:57 volumio-hhai sudo[1609]: pam_unix(sudo:session): session closed for user root May 27 00:00:57 volumio-hhai systemd[1]: Startup finished in 9.882s (firmware) + 1.793s (loader) + 12.653s (kernel) + 13.457s (userspace) = 37.787s. May 27 00:00:57 volumio-hhai sudo[1635]: pam_unix(sudo:session): session closed for user root May 27 00:00:57 volumio-hhai volumio[1261]: info: Completed starting Core Plugins May 27 00:00:57 volumio-hhai volumio[1261]: info: ------------------------------------------- May 27 00:00:57 volumio-hhai volumio[1261]: info: ----- MyVolumio plugins startup ---- May 27 00:00:57 volumio-hhai volumio[1261]: info: ------------------------------------------- May 27 00:00:57 volumio-hhai volumio[1261]: info: [MyVolumio PluginManager] Fetching plans data.... May 27 00:00:57 volumio-hhai volumio[1261]: error: updateQueue error: null May 27 00:00:57 volumio-hhai volumio[1261]: error: updateQueue error: null May 27 00:00:57 volumio-hhai volumio[1261]: info: MPD running with PID1675 May 27 00:00:57 volumio-hhai volumio[1261]: ,establishing connection May 27 00:00:57 volumio-hhai volumio[1261]: error: updateQueue error: null May 27 00:00:57 volumio-hhai ntpd[1058]: IO: Listen normally on 3 eth0 192.168.30.243:123 May 27 00:00:57 volumio-hhai ntpd[1058]: IO: new interface(s) found: waking up resolver May 27 00:00:57 volumio-hhai ntpd[1058]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 May 27 00:00:57 volumio-hhai volumio[1261]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 May 27 00:00:57 volumio-hhai ntpd[1058]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 May 27 00:00:57 volumio-hhai ntpd[1058]: DNS: Pool taking: 45.252.250.189 May 27 00:00:57 volumio-hhai ntpd[1058]: DNS: Pool taking: 103.70.12.61 May 27 00:00:57 volumio-hhai ntpd[1058]: DNS: Pool taking: 103.186.65.246 May 27 00:00:57 volumio-hhai ntpd[1058]: DNS: Pool taking: 103.130.217.41 May 27 00:00:57 volumio-hhai ntpd[1058]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 May 27 00:00:58 volumio-hhai volumio[1261]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetVisibleSources May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:58 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 27 00:00:58 volumio-hhai volumio[1261]: info: Received Get System Info May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 27 00:00:58 volumio-hhai volumio[1261]: info: Discovery: Getting this device information May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:58 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:58 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:58 volumio-hhai volumio[1261]: info: Listing playlists May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 27 00:00:58 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 27 00:00:58 volumio-hhai volumio5-onboarding[1634]: time=2026-05-27T00:00:58.582+07:00 level=INFO msg="service successfully established" component=discovery/localnet May 27 00:00:58 volumio-hhai volumio[1261]: info: go-librespot daemon successfully initialized May 27 00:00:58 volumio-hhai volumio5-onboarding[1634]: time=2026-05-27T00:00:58.700+07:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.30.249:40406 May 27 00:00:58 volumio-hhai ntpd[1058]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 May 27 00:00:58 volumio-hhai volumio-remote-updater[933]: [2026-05-27 00:00:58] [connect] Successful connection May 27 00:00:58 volumio-hhai volumio-remote-updater[933]: [2026-05-27 00:00:58] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1779814858 101 May 27 00:00:58 volumio-hhai volumio[1261]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 5 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool skipping: 45.252.250.189 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool taking: 103.221.223.143 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool skipping: 103.186.65.246 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool skipping: 103.70.12.61 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool taking: 2400:e920:0:5::14 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool taking: 2403:6a40:0:88::12 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool taking: 2400:6ea0:0:509c::a May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool taking: 2401:5b60:0:2::21 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 May 27 00:00:59 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:00:59 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool skipping: 103.186.65.246 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool skipping: 103.130.217.41 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool skipping: 45.252.250.189 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: Pool skipping: 103.70.12.61 May 27 00:00:59 volumio-hhai ntpd[1058]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 May 27 00:01:00 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 27 00:01:00 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 27 00:01:00 volumio-hhai volumio[1261]: info: Received Get System Info May 27 00:01:00 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 27 00:01:00 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 27 00:01:00 volumio-hhai volumio[1261]: info: Discovery: Getting this device information May 27 00:01:00 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:01:00 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:01:00 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 27 00:01:00 volumio-hhai ntpd[1058]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 May 27 00:01:01 volumio-hhai ntpd[1058]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 May 27 00:01:01 volumio-hhai ntpd[1058]: DNS: Pool skipping: 103.221.223.143 May 27 00:01:01 volumio-hhai ntpd[1058]: DNS: Pool skipping: 103.130.217.41 May 27 00:01:01 volumio-hhai ntpd[1058]: DNS: Pool skipping: 103.186.65.246 May 27 00:01:01 volumio-hhai ntpd[1058]: DNS: Pool skipping: 103.70.12.61 May 27 00:01:01 volumio-hhai ntpd[1058]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 May 27 00:01:01 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 27 00:01:01 volumio-hhai volumio[1261]: info: Initializing connection to go-librespot Websocket May 27 00:01:01 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:01+07:00" level=debug msg="new websocket client" May 27 00:01:01 volumio-hhai volumio[1261]: info: Connection to go-librespot Websocket established May 27 00:01:01 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 27 00:01:01 volumio-hhai volumio[1261]: info: Received Get System Info May 27 00:01:01 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 27 00:01:01 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 27 00:01:01 volumio-hhai volumio[1261]: info: Discovery: Getting this device information May 27 00:01:01 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:01:01 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:01:01 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 27 00:01:01 volumio-hhai systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1. May 27 00:01:01 volumio-hhai systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. May 27 00:01:01 volumio-hhai systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 27 00:01:01 volumio-hhai upmpdcli[1961]: Could not open config: /tmp/upmpdcli.conf May 27 00:01:01 volumio-hhai systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 27 00:01:01 volumio-hhai systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=debug msg="obtained new client token: AADy+YTyijP6P2qAYEDiBNUeN8Djvk9+jdO47I6l2sXr/iDhv5RWQvzDFWe0UADC9kh/NMD98xZMnC296ZVJiY4wNujNC4BdpTHmA5HFsksmmPIMXC/q+jSWs4II09SYXWCtKF/0xFxd33FoWieMvZvKLKEEGm0/QSYmSK/sJAsiofYCwmtA6ALc4VxoWcT9D660fgNjjJz+dFxUf0N1SyYiNT6nzf6yTAdC4b8hsR363NKEBThh0BPaZQ==" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" May 27 00:01:02 volumio-hhai volumio[1261]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=debug msg="completed keyexchange" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=debug msg="completed challenge" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=info msg="authenticated AP" username="5h*********************x5" May 27 00:01:02 volumio-hhai volumio[1261]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=info msg="authenticated Login5" username="5h*********************x5" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=info msg="accepted zeroconf from Nguyen Hong's S24+" username="5h*********************x5" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=debug msg="dealer connection opened" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=trace msg="starting accesspoint recv loop" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=trace msg="starting dealer recv loop" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=trace msg="received accesspoint ping" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=debug msg="received connection id: ZjliZDFkMzYtZWUx...RjM1OEFBNENGOQ==" May 27 00:01:02 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:02+07:00" level=trace msg="received accesspoint pong ack" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="put connect state because NEW_DEVICE" May 27 00:01:03 volumio-hhai volumio[1261]: info: Volumio Network Manager: Network status updated: 1 May 27 00:01:03 volumio-hhai sudo[1979]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 27 00:01:03 volumio-hhai sudo[1979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:01:03 volumio-hhai sudo[1981]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 27 00:01:03 volumio-hhai sudo[1981]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:01:03 volumio-hhai sudo[1979]: pam_unix(sudo:session): session closed for user root May 27 00:01:03 volumio-hhai sudo[1981]: pam_unix(sudo:session): session closed for user root May 27 00:01:03 volumio-hhai sudo[1985]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 27 00:01:03 volumio-hhai sudo[1985]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="handling transfer player command from 74e03d6814a03c84d4eeafb7636a8409b61e7276" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="resolved context of track" uri="spotify:album:14vsqihC0TkLwV0eXrdGxY" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=trace msg="fetched new page 0 with 10 items (list: 10)" uri="spotify:album:14vsqihC0TkLwV0eXrdGxY" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="loading track (paused: true, position: 22177ms)" uri="spotify:track:5sbvKgX3HujfI8MZJx4ZdA" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=trace msg="emitting websocket event: will_play" May 27 00:01:03 volumio-hhai volumio[1261]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:album:14vsqihC0TkLwV0eXrdGxY","uri":"spotify:track:5sbvKgX3HujfI8MZJx4ZdA","play_origin":"album"}} May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1415" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 411" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="selected format OGG_VORBIS_320 (ae027849a92ecd435463bf71378d234f17d0b579)" uri="spotify:track:5sbvKgX3HujfI8MZJx4ZdA" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="requested aes key for file ae027849a92ecd435463bf71378d234f17d0b579, gid: 5sbvKgX3HujfI8MZJx4ZdA" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=trace msg="found 2 cdn urls" uri="spotify:track:5sbvKgX3HujfI8MZJx4ZdA" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="fetched first chunk of 23, total size is 11864736 bytes" uri="spotify:track:5sbvKgX3HujfI8MZJx4ZdA" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="fetched chunk 1/22, size: 524288" uri="spotify:track:5sbvKgX3HujfI8MZJx4ZdA" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=trace msg="seek to 22177ms (diff: 108ms, samples: 978005, bytes: 825049)" uri="spotify:track:5sbvKgX3HujfI8MZJx4ZdA" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="created new output device" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=info msg="loaded track \"Nửa hồn thương đau\" (paused: true, position: 22177ms, duration: 316473ms, prefetched: false)" uri="spotify:track:5sbvKgX3HujfI8MZJx4ZdA" May 27 00:01:03 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:03+07:00" level=debug msg="fetched chunk 3/22, size: 524288" uri="spotify:track:5sbvKgX3HujfI8MZJx4ZdA" May 27 00:01:04 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:04+07:00" level=debug msg="fetched chunk 2/22, size: 524288" uri="spotify:track:5sbvKgX3HujfI8MZJx4ZdA" May 27 00:01:04 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:04+07:00" level=debug msg="fetched chunk 4/22, size: 524288" uri="spotify:track:5sbvKgX3HujfI8MZJx4ZdA" May 27 00:01:04 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:04+07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" May 27 00:01:04 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:04+07:00" level=trace msg="emitting websocket event: metadata" May 27 00:01:04 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:04+07:00" level=trace msg="emitting websocket event: active" May 27 00:01:04 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:04+07:00" level=debug msg="sending successful reply for dealer request" May 27 00:01:04 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:04+07:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update May 27 00:01:04 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:04+07:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update May 27 00:01:04 volumio-hhai volumio[1261]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:5sbvKgX3HujfI8MZJx4ZdA","name":"Nửa hồn thương đau","artist_names":["Hồ Hoàng Yến"],"album_name":"Dù Tình Yêu Đã Mất","album_cover_url":"https://i.scdn.co/image/ab67616d00001e022c9654a228e10b0cb7dbf1ce","position":22177,"duration":316473,"release_date":"year:2014 month:1 day:24","track_number":2,"disc_number":1}} May 27 00:01:04 volumio-hhai volumio[1261]: SPOTIFY: received: {"type":"active","data":null} May 27 00:01:04 volumio-hhai volumio[1261]: info: Aligning Spotify Volume to Volumio Volume May 27 00:01:04 volumio-hhai volumio[1261]: info: CoreCommandRouter::volumioGetState May 27 00:01:04 volumio-hhai volumio[1261]: info: CorePlayQueue::getTrack 0 May 27 00:01:04 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:04+07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" May 27 00:01:04 volumio-hhai go-librespot[1710]: time="2026-05-27T00:01:04+07:00" level=trace msg="emitting websocket event: paused" May 27 00:01:04 volumio-hhai volumio[1261]: SPOTIFY: received: {"type":"paused","data":{"context_uri":"spotify:album:14vsqihC0TkLwV0eXrdGxY","uri":"spotify:track:5sbvKgX3HujfI8MZJx4ZdA","play_origin":"album"}} May 27 00:01:04 volumio-hhai volumio[1261]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 27 00:01:04 volumio-hhai volumio[1261]: TypeError: Cannot read properties of undefined (reading 'service') May 27 00:01:04 volumio-hhai volumio[1261]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:346:50) May 27 00:01:04 volumio-hhai volumio[1261]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:280:18) May 27 00:01:04 volumio-hhai volumio[1261]: at WebSocket.message (/data/plugins/music_service/spop/index.js:199:14) May 27 00:01:04 volumio-hhai volumio[1261]: at WebSocket.emit (node:events:514:28) May 27 00:01:04 volumio-hhai volumio[1261]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) May 27 00:01:04 volumio-hhai volumio[1261]: at Receiver.emit (node:events:514:28) May 27 00:01:04 volumio-hhai volumio[1261]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) May 27 00:01:04 volumio-hhai volumio[1261]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) May 27 00:01:04 volumio-hhai volumio[1261]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) May 27 00:01:04 volumio-hhai volumio[1261]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) May 27 00:01:04 volumio-hhai volumio[1261]: at writeOrBuffer (node:internal/streams/writable:399:12) May 27 00:01:04 volumio-hhai volumio[1261]: at _write (node:internal/streams/writable:340:10) May 27 00:01:04 volumio-hhai volumio[1261]: at Writable.write (node:internal/streams/writable:344:10) May 27 00:01:04 volumio-hhai volumio[1261]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1355:35) May 27 00:01:04 volumio-hhai volumio[1261]: at Socket.emit (node:events:514:28) May 27 00:01:04 volumio-hhai volumio[1261]: at addChunk (node:internal/streams/readable:343:12) May 27 00:01:04 volumio-hhai volumio[1261]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 27 00:01:04 volumio-hhai sudo[2002]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-27 00:00' May 27 00:01:04 volumio-hhai sudo[2002]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"