May 31 15:56:28 volumio 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 31 15:56:28 volumio kernel: Command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=9c5aafd3-d1f5-42ac-80ba-2722edd0150c bootpart=UUID=7C3E-4B23 datapart=UUID=57e315c1-b339-4c2e-8155-8126725033f1 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 31 15:56:28 volumio kernel: KERNEL supported cpus:
May 31 15:56:28 volumio kernel: Intel GenuineIntel
May 31 15:56:28 volumio kernel: AMD AuthenticAMD
May 31 15:56:28 volumio kernel: Hygon HygonGenuine
May 31 15:56:28 volumio kernel: Centaur CentaurHauls
May 31 15:56:28 volumio kernel: zhaoxin Shanghai
May 31 15:56:28 volumio kernel: x86/split lock detection: #AC: crashing the kernel on kernel split_locks and warning on user-space split_locks
May 31 15:56:28 volumio kernel: BIOS-provided physical RAM map:
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000005dfff] usable
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x000000000005e000-0x000000000005efff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x000000000005f000-0x000000000009ffff] usable
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x00000000000a0000-0x00000000000fffff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x0000000000100000-0x000000006f15bfff] usable
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x000000006f15c000-0x000000006f15cfff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x000000006f15d000-0x000000006f192fff] usable
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x000000006f193000-0x000000006f193fff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x000000006f194000-0x000000006fc44fff] usable
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x000000006fc45000-0x0000000072d44fff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x0000000072d45000-0x0000000072e14fff] ACPI data
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x0000000072e15000-0x0000000073261fff] ACPI NVS
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x0000000073262000-0x0000000073e65fff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x0000000073e66000-0x0000000073efefff] type 20
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x0000000073eff000-0x0000000073efffff] usable
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x0000000073f00000-0x0000000079ffffff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x000000007aa00000-0x000000007abfffff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x000000007b000000-0x00000000803fffff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x00000000c0000000-0x00000000cfffffff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x00000000fe000000-0x00000000fe010fff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x00000000fed00000-0x00000000fed00fff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x00000000fed20000-0x00000000fed7ffff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x00000000ff000000-0x00000000ffffffff] reserved
May 31 15:56:28 volumio kernel: BIOS-e820: [mem 0x0000000100000000-0x000000047fbfffff] usable
May 31 15:56:28 volumio kernel: NX (Execute Disable) protection: active
May 31 15:56:28 volumio kernel: APIC: Static calls initialized
May 31 15:56:28 volumio kernel: efi: EFI v2.8 by American Megatrends
May 31 15:56:28 volumio kernel: efi: ACPI=0x7323e000 ACPI 2.0=0x7323e014 TPMFinalLog=0x7320d000 SMBIOS=0x73c76000 SMBIOS 3.0=0x73c75000 MEMATTR=0x6c6c1418 ESRT=0x6daee018
May 31 15:56:28 volumio kernel: efi: Remove mem81: MMIO range=[0xc0000000-0xcfffffff] (256MB) from e820 map
May 31 15:56:28 volumio kernel: e820: remove [mem 0xc0000000-0xcfffffff] reserved
May 31 15:56:28 volumio kernel: efi: Not removing mem82: MMIO range=[0xfe000000-0xfe010fff] (68KB) from e820 map
May 31 15:56:28 volumio kernel: efi: Not removing mem83: MMIO range=[0xfec00000-0xfec00fff] (4KB) from e820 map
May 31 15:56:28 volumio kernel: efi: Not removing mem84: MMIO range=[0xfed00000-0xfed00fff] (4KB) from e820 map
May 31 15:56:28 volumio kernel: efi: Not removing mem86: MMIO range=[0xfee00000-0xfee00fff] (4KB) from e820 map
May 31 15:56:28 volumio kernel: efi: Remove mem87: MMIO range=[0xff000000-0xffffffff] (16MB) from e820 map
May 31 15:56:28 volumio kernel: e820: remove [mem 0xff000000-0xffffffff] reserved
May 31 15:56:28 volumio kernel: SMBIOS 3.6.0 present.
May 31 15:56:28 volumio kernel: DMI: Firebat_Computer ZY-R1/ZYR1-SC, BIOS 5.26 08/23/2024
May 31 15:56:28 volumio kernel: DMI: Memory slots populated: 1/1
May 31 15:56:28 volumio kernel: tsc: Detected 800.000 MHz processor
May 31 15:56:28 volumio kernel: tsc: Detected 806.400 MHz TSC
May 31 15:56:28 volumio kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
May 31 15:56:28 volumio kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
May 31 15:56:28 volumio kernel: last_pfn = 0x47fc00 max_arch_pfn = 0x400000000
May 31 15:56:28 volumio kernel: MTRR map: 6 entries (3 fixed + 3 variable; max 23), built from 10 variable MTRRs
May 31 15:56:28 volumio kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT
May 31 15:56:28 volumio kernel: last_pfn = 0x73f00 max_arch_pfn = 0x400000000
May 31 15:56:28 volumio kernel: found SMP MP-table at [mem 0x000fce20-0x000fce2f]
May 31 15:56:28 volumio kernel: esrt: Reserving ESRT space from 0x000000006daee018 to 0x000000006daee190.
May 31 15:56:28 volumio kernel: e820: update [mem 0x6daee000-0x6daeefff] usable ==> reserved
May 31 15:56:28 volumio kernel: Using GB pages for direct mapping
May 31 15:56:28 volumio kernel: Secure boot could not be determined
May 31 15:56:28 volumio kernel: RAMDISK: [mem 0x2e241000-0x33117fff]
May 31 15:56:28 volumio kernel: ACPI: Early table checksum verification disabled
May 31 15:56:28 volumio kernel: ACPI: RSDP 0x000000007323E014 000024 (v02 ALASKA)
May 31 15:56:28 volumio kernel: ACPI: XSDT 0x000000007323D728 0000FC (v01 ALASKA A M I 01072009 AMI 01000013)
May 31 15:56:28 volumio kernel: ACPI: FACP 0x0000000072E12000 000114 (v06 ALASKA A M I 01072009 AMI 01000013)
May 31 15:56:28 volumio kernel: ACPI: DSDT 0x0000000072D9B000 07628F (v02 ALASKA A M I 01072009 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: FACS 0x0000000073261000 000040
May 31 15:56:28 volumio kernel: ACPI: FIDT 0x0000000072D9A000 00009C (v01 ALASKA A M I 01072009 AMI 00010013)
May 31 15:56:28 volumio kernel: ACPI: SSDT 0x0000000072E14000 00038C (v02 PmaxDv Pmax_Dev 00000001 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: SSDT 0x0000000072D94000 005D0B (v02 CpuRef CpuSsdt 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: SSDT 0x0000000072D91000 002A45 (v02 SaSsdt SaSsdt 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: SSDT 0x0000000072D8D000 003339 (v02 INTEL IgfxSsdt 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: HPET 0x0000000072E13000 000038 (v01 ALASKA A M I 01072009 AMI 01000013)
May 31 15:56:28 volumio kernel: ACPI: APIC 0x0000000072D8C000 0001DC (v05 ALASKA A M I 01072009 AMI 01000013)
May 31 15:56:28 volumio kernel: ACPI: MCFG 0x0000000072D8B000 00003C (v01 ALASKA A M I 01072009 AMI 01000013)
May 31 15:56:28 volumio kernel: ACPI: SSDT 0x0000000072D89000 001FFD (v02 ALASKA Ther_Rvp 00001000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: UEFI 0x00000000731F4000 000048 (v01 ALASKA A M I 01072009 AMI 01000013)
May 31 15:56:28 volumio kernel: ACPI: PSDS 0x0000000072D88000 000052 (v01 INTEL EDK2 00000005 INTL 0100000D)
May 31 15:56:28 volumio kernel: ACPI: NHLT 0x0000000072D87000 00002D (v00 ALASKA A M I 01072009 AMI 01000013)
May 31 15:56:28 volumio kernel: ACPI: LPIT 0x0000000072D86000 0000CC (v01 ALASKA A M I 01072009 AMI 01000013)
May 31 15:56:28 volumio kernel: ACPI: SSDT 0x0000000072D82000 002A83 (v02 ALASKA PtidDevc 00001000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: SSDT 0x0000000072D7F000 002357 (v02 ALASKA TbtTypeC 00000000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: DBGP 0x0000000072D7E000 000034 (v01 ALASKA A M I 01072009 AMI 01000013)
May 31 15:56:28 volumio kernel: ACPI: DBG2 0x0000000072D7D000 000054 (v00 ALASKA A M I 01072009 AMI 01000013)
May 31 15:56:28 volumio kernel: ACPI: DMAR 0x0000000072D7C000 000088 (v02 INTEL EDK2 00000002 01000013)
May 31 15:56:28 volumio kernel: ACPI: FPDT 0x0000000072D7B000 000044 (v01 ALASKA A M I 01072009 AMI 01000013)
May 31 15:56:28 volumio kernel: ACPI: SSDT 0x0000000072D7A000 00073A (v02 INTEL xh_adl_N 00000000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: SSDT 0x0000000072D76000 003AEA (v02 SocGpe SocGpe 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: SSDT 0x0000000072D72000 0039DA (v02 SocCmn SocCmn 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: SSDT 0x0000000072D71000 000144 (v02 Intel ADebTabl 00001000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: PHAT 0x0000000072D70000 000691 (v01 ALASKA A M I 00000005 MSFT 0100000D)
May 31 15:56:28 volumio kernel: ACPI: TPM2 0x0000000072D6F000 00004C (v04 ALASKA A M I 00000001 AMI 00000000)
May 31 15:56:28 volumio kernel: ACPI: WSMT 0x0000000072D85000 000028 (v01 ALASKA A M I 01072009 AMI 00010013)
May 31 15:56:28 volumio kernel: ACPI: Reserving FACP table memory at [mem 0x72e12000-0x72e12113]
May 31 15:56:28 volumio kernel: ACPI: Reserving DSDT table memory at [mem 0x72d9b000-0x72e1128e]
May 31 15:56:28 volumio kernel: ACPI: Reserving FACS table memory at [mem 0x73261000-0x7326103f]
May 31 15:56:28 volumio kernel: ACPI: Reserving FIDT table memory at [mem 0x72d9a000-0x72d9a09b]
May 31 15:56:28 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x72e14000-0x72e1438b]
May 31 15:56:28 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x72d94000-0x72d99d0a]
May 31 15:56:28 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x72d91000-0x72d93a44]
May 31 15:56:28 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x72d8d000-0x72d90338]
May 31 15:56:28 volumio kernel: ACPI: Reserving HPET table memory at [mem 0x72e13000-0x72e13037]
May 31 15:56:28 volumio kernel: ACPI: Reserving APIC table memory at [mem 0x72d8c000-0x72d8c1db]
May 31 15:56:28 volumio kernel: ACPI: Reserving MCFG table memory at [mem 0x72d8b000-0x72d8b03b]
May 31 15:56:28 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x72d89000-0x72d8affc]
May 31 15:56:28 volumio kernel: ACPI: Reserving UEFI table memory at [mem 0x731f4000-0x731f4047]
May 31 15:56:28 volumio kernel: ACPI: Reserving PSDS table memory at [mem 0x72d88000-0x72d88051]
May 31 15:56:28 volumio kernel: ACPI: Reserving NHLT table memory at [mem 0x72d87000-0x72d8702c]
May 31 15:56:28 volumio kernel: ACPI: Reserving LPIT table memory at [mem 0x72d86000-0x72d860cb]
May 31 15:56:28 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x72d82000-0x72d84a82]
May 31 15:56:28 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x72d7f000-0x72d81356]
May 31 15:56:28 volumio kernel: ACPI: Reserving DBGP table memory at [mem 0x72d7e000-0x72d7e033]
May 31 15:56:28 volumio kernel: ACPI: Reserving DBG2 table memory at [mem 0x72d7d000-0x72d7d053]
May 31 15:56:28 volumio kernel: ACPI: Reserving DMAR table memory at [mem 0x72d7c000-0x72d7c087]
May 31 15:56:28 volumio kernel: ACPI: Reserving FPDT table memory at [mem 0x72d7b000-0x72d7b043]
May 31 15:56:28 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x72d7a000-0x72d7a739]
May 31 15:56:28 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x72d76000-0x72d79ae9]
May 31 15:56:28 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x72d72000-0x72d759d9]
May 31 15:56:28 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x72d71000-0x72d71143]
May 31 15:56:28 volumio kernel: ACPI: Reserving PHAT table memory at [mem 0x72d70000-0x72d70690]
May 31 15:56:28 volumio kernel: ACPI: Reserving TPM2 table memory at [mem 0x72d6f000-0x72d6f04b]
May 31 15:56:28 volumio kernel: ACPI: Reserving WSMT table memory at [mem 0x72d85000-0x72d85027]
May 31 15:56:28 volumio kernel: Zone ranges:
May 31 15:56:28 volumio kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff]
May 31 15:56:28 volumio kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff]
May 31 15:56:28 volumio kernel: Normal [mem 0x0000000100000000-0x000000047fbfffff]
May 31 15:56:28 volumio kernel: Movable zone start for each node
May 31 15:56:28 volumio kernel: Early memory node ranges
May 31 15:56:28 volumio kernel: node 0: [mem 0x0000000000001000-0x000000000005dfff]
May 31 15:56:28 volumio kernel: node 0: [mem 0x000000000005f000-0x000000000009ffff]
May 31 15:56:28 volumio kernel: node 0: [mem 0x0000000000100000-0x000000006f15bfff]
May 31 15:56:28 volumio kernel: node 0: [mem 0x000000006f15d000-0x000000006f192fff]
May 31 15:56:28 volumio kernel: node 0: [mem 0x000000006f194000-0x000000006fc44fff]
May 31 15:56:28 volumio kernel: node 0: [mem 0x0000000073eff000-0x0000000073efffff]
May 31 15:56:28 volumio kernel: node 0: [mem 0x0000000100000000-0x000000047fbfffff]
May 31 15:56:28 volumio kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000047fbfffff]
May 31 15:56:28 volumio kernel: On node 0, zone DMA: 1 pages in unavailable ranges
May 31 15:56:28 volumio kernel: On node 0, zone DMA: 1 pages in unavailable ranges
May 31 15:56:28 volumio kernel: On node 0, zone DMA: 96 pages in unavailable ranges
May 31 15:56:28 volumio kernel: On node 0, zone DMA32: 1 pages in unavailable ranges
May 31 15:56:28 volumio kernel: On node 0, zone DMA32: 1 pages in unavailable ranges
May 31 15:56:28 volumio kernel: On node 0, zone DMA32: 17082 pages in unavailable ranges
May 31 15:56:28 volumio kernel: On node 0, zone Normal: 16640 pages in unavailable ranges
May 31 15:56:28 volumio kernel: On node 0, zone Normal: 1024 pages in unavailable ranges
May 31 15:56:28 volumio kernel: Reserving Intel graphics memory at [mem 0x7c800000-0x803fffff]
May 31 15:56:28 volumio kernel: ACPI: PM-Timer IO Port: 0x1808
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x02] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x03] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x04] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x05] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x06] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x07] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x08] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x09] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x0a] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x0b] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x0c] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x0d] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x0e] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x0f] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x10] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x11] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x12] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x13] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x14] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x15] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x16] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x17] high edge lint[0x1])
May 31 15:56:28 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1])
May 31 15:56:28 volumio kernel: IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-119
May 31 15:56:28 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
May 31 15:56:28 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
May 31 15:56:28 volumio kernel: ACPI: Using ACPI (MADT) for SMP configuration information
May 31 15:56:28 volumio kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000
May 31 15:56:28 volumio kernel: TSC deadline timer available
May 31 15:56:28 volumio kernel: CPU topo: Max. logical packages: 1
May 31 15:56:28 volumio kernel: CPU topo: Max. logical dies: 1
May 31 15:56:28 volumio kernel: CPU topo: Max. dies per package: 1
May 31 15:56:28 volumio kernel: CPU topo: Max. threads per core: 1
May 31 15:56:28 volumio kernel: CPU topo: Num. cores per package: 4
May 31 15:56:28 volumio kernel: CPU topo: Num. threads per package: 4
May 31 15:56:28 volumio kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs
May 31 15:56:28 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
May 31 15:56:28 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x0005e000-0x0005efff]
May 31 15:56:28 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000fffff]
May 31 15:56:28 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x6daee000-0x6daeefff]
May 31 15:56:28 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x6f15c000-0x6f15cfff]
May 31 15:56:28 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x6f193000-0x6f193fff]
May 31 15:56:28 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x6fc45000-0x73efefff]
May 31 15:56:28 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x73f00000-0xffffffff]
May 31 15:56:28 volumio kernel: [mem 0x80400000-0xfdffffff] available for PCI devices
May 31 15:56:28 volumio kernel: Booting paravirtualized kernel on bare hardware
May 31 15:56:28 volumio kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
May 31 15:56:28 volumio kernel: setup_percpu: NR_CPUS:64 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
May 31 15:56:28 volumio kernel: percpu: Embedded 59 pages/cpu s201368 r8192 d32104 u524288
May 31 15:56:28 volumio kernel: pcpu-alloc: s201368 r8192 d32104 u524288 alloc=1*2097152
May 31 15:56:28 volumio kernel: pcpu-alloc: [0] 0 1 2 3
May 31 15:56:28 volumio kernel: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=9c5aafd3-d1f5-42ac-80ba-2722edd0150c bootpart=UUID=7C3E-4B23 datapart=UUID=57e315c1-b339-4c2e-8155-8126725033f1 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 31 15:56:28 volumio kernel: Unknown kernel command line parameters "splash bootdelay=5 biosdevname=0 imgpart=UUID=9c5aafd3-d1f5-42ac-80ba-2722edd0150c bootpart=UUID=7C3E-4B23 datapart=UUID=57e315c1-b339-4c2e-8155-8126725033f1 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh use_kmsg=no", will be passed to user space.
May 31 15:56:28 volumio kernel: random: crng init done
May 31 15:56:28 volumio kernel: Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear)
May 31 15:56:28 volumio kernel: Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear)
May 31 15:56:28 volumio kernel: Built 1 zonelists, mobility grouping on. Total pages: 4126690
May 31 15:56:28 volumio kernel: mem auto-init: stack:all(pattern), heap alloc:off, heap free:off
May 31 15:56:28 volumio kernel: software IO TLB: area num 4.
May 31 15:56:28 volumio kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
May 31 15:56:28 volumio kernel: ftrace: allocating 43851 entries in 172 pages
May 31 15:56:28 volumio kernel: ftrace: allocated 172 pages with 4 groups
May 31 15:56:28 volumio kernel: Dynamic Preempt: voluntary
May 31 15:56:28 volumio kernel: rcu: Preemptible hierarchical RCU implementation.
May 31 15:56:28 volumio kernel: rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=4.
May 31 15:56:28 volumio kernel: Trampoline variant of Tasks RCU enabled.
May 31 15:56:28 volumio kernel: Rude variant of Tasks RCU enabled.
May 31 15:56:28 volumio kernel: Tracing variant of Tasks RCU enabled.
May 31 15:56:28 volumio kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
May 31 15:56:28 volumio kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
May 31 15:56:28 volumio kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
May 31 15:56:28 volumio kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
May 31 15:56:28 volumio kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
May 31 15:56:28 volumio kernel: NR_IRQS: 4352, nr_irqs: 1024, preallocated irqs: 16
May 31 15:56:28 volumio kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
May 31 15:56:28 volumio kernel: Console: colour dummy device 80x25
May 31 15:56:28 volumio kernel: printk: legacy console [tty0] enabled
May 31 15:56:28 volumio kernel: ACPI: Core revision 20240827
May 31 15:56:28 volumio kernel: hpet: HPET dysfunctional in PC10. Force disabled.
May 31 15:56:28 volumio kernel: APIC: Switch to symmetric I/O mode setup
May 31 15:56:28 volumio kernel: x2apic: IRQ remapping doesn't support X2APIC mode
May 31 15:56:28 volumio kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0xb9fb05486c, max_idle_ns: 440795231721 ns
May 31 15:56:28 volumio kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 1612.80 BogoMIPS (lpj=3225600)
May 31 15:56:28 volumio kernel: CPU0: Thermal monitoring enabled (TM1)
May 31 15:56:28 volumio kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated
May 31 15:56:28 volumio kernel: CET detected: Indirect Branch Tracking enabled
May 31 15:56:28 volumio kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
May 31 15:56:28 volumio kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
May 31 15:56:28 volumio kernel: process: using mwait in idle threads
May 31 15:56:28 volumio kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
May 31 15:56:28 volumio kernel: Spectre V2 : Mitigation: Enhanced / Automatic IBRS
May 31 15:56:28 volumio kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
May 31 15:56:28 volumio kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl
May 31 15:56:28 volumio kernel: Register File Data Sampling: Vulnerable: No microcode
May 31 15:56:28 volumio kernel: VMSCAPE: Mitigation: IBPB before exit to userspace
May 31 15:56:28 volumio kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
May 31 15:56:28 volumio kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
May 31 15:56:28 volumio kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
May 31 15:56:28 volumio kernel: x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'
May 31 15:56:28 volumio kernel: x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'
May 31 15:56:28 volumio kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256
May 31 15:56:28 volumio kernel: x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8
May 31 15:56:28 volumio kernel: x86/fpu: xstate_offset[11]: 840, xstate_sizes[11]: 16
May 31 15:56:28 volumio kernel: x86/fpu: Enabled xstate features 0xa07, context size is 856 bytes, using 'compacted' format.
May 31 15:56:28 volumio kernel: Freeing SMP alternatives memory: 36K
May 31 15:56:28 volumio kernel: pid_max: default: 32768 minimum: 301
May 31 15:56:28 volumio kernel: LSM: initializing lsm=capability,yama
May 31 15:56:28 volumio kernel: Yama: becoming mindful.
May 31 15:56:28 volumio kernel: Mount-cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
May 31 15:56:28 volumio kernel: Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
May 31 15:56:28 volumio kernel: smpboot: CPU0: Intel(R) N100 (family: 0x6, model: 0xbe, stepping: 0x0)
May 31 15:56:28 volumio kernel: Performance Events: XSAVE Architectural LBR, PEBS fmt4+-baseline, PEBS-via-PT, AnyThread deprecated, Gracemont events, 32-deep LBR, full-width counters, Intel PMU driver.
May 31 15:56:28 volumio kernel: ... version: 5
May 31 15:56:28 volumio kernel: ... bit width: 48
May 31 15:56:28 volumio kernel: ... generic registers: 6
May 31 15:56:28 volumio kernel: ... value mask: 0000ffffffffffff
May 31 15:56:28 volumio kernel: ... max period: 00007fffffffffff
May 31 15:56:28 volumio kernel: ... fixed-purpose events: 3
May 31 15:56:28 volumio kernel: ... event mask: 000000070000003f
May 31 15:56:28 volumio kernel: signal: max sigframe size: 3632
May 31 15:56:28 volumio kernel: Estimated ratio of average max frequency by base frequency (times 1024): 3712
May 31 15:56:28 volumio kernel: rcu: Hierarchical SRCU implementation.
May 31 15:56:28 volumio kernel: rcu: Max phase no-delay instances is 1000.
May 31 15:56:28 volumio kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
May 31 15:56:28 volumio kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter.
May 31 15:56:28 volumio kernel: smp: Bringing up secondary CPUs ...
May 31 15:56:28 volumio kernel: smpboot: x86: Booting SMP configuration:
May 31 15:56:28 volumio kernel: .... node #0, CPUs: #1 #2 #3
May 31 15:56:28 volumio kernel: smp: Brought up 1 node, 4 CPUs
May 31 15:56:28 volumio kernel: smpboot: Total of 4 processors activated (6451.20 BogoMIPS)
May 31 15:56:28 volumio kernel: Memory: 16036924K/16506760K available (16384K kernel code, 2032K rwdata, 5320K rodata, 3128K init, 840K bss, 462032K reserved, 0K cma-reserved)
May 31 15:56:28 volumio kernel: devtmpfs: initialized
May 31 15:56:28 volumio kernel: x86/mm: Memory block size: 128MB
May 31 15:56:28 volumio kernel: ACPI: PM: Registering ACPI NVS region [mem 0x72e15000-0x73261fff] (4509696 bytes)
May 31 15:56:28 volumio kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
May 31 15:56:28 volumio kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
May 31 15:56:28 volumio kernel: pinctrl core: initialized pinctrl subsystem
May 31 15:56:28 volumio kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
May 31 15:56:28 volumio kernel: audit: initializing netlink subsys (disabled)
May 31 15:56:28 volumio kernel: audit: type=2000 audit(1780217775.004:1): state=initialized audit_enabled=0 res=1
May 31 15:56:28 volumio kernel: thermal_sys: Registered thermal governor 'fair_share'
May 31 15:56:28 volumio kernel: thermal_sys: Registered thermal governor 'bang_bang'
May 31 15:56:28 volumio kernel: thermal_sys: Registered thermal governor 'step_wise'
May 31 15:56:28 volumio kernel: thermal_sys: Registered thermal governor 'user_space'
May 31 15:56:28 volumio kernel: cpuidle: using governor ladder
May 31 15:56:28 volumio kernel: cpuidle: using governor menu
May 31 15:56:28 volumio kernel: ACPI FADT declares the system doesn't support PCIe ASPM, so disable it
May 31 15:56:28 volumio kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
May 31 15:56:28 volumio kernel: PCI: ECAM [mem 0xc0000000-0xcfffffff] (base 0xc0000000) for domain 0000 [bus 00-ff]
May 31 15:56:28 volumio kernel: PCI: Using configuration type 1 for base access
May 31 15:56:28 volumio kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
May 31 15:56:28 volumio kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
May 31 15:56:28 volumio kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
May 31 15:56:28 volumio kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
May 31 15:56:28 volumio kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
May 31 15:56:28 volumio kernel: ACPI: Added _OSI(Module Device)
May 31 15:56:28 volumio kernel: ACPI: Added _OSI(Processor Device)
May 31 15:56:28 volumio kernel: ACPI: Added _OSI(Processor Aggregator Device)
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.PC00.TXHC.RHUB.SS01], AE_NOT_FOUND (20240827/dswload2-162)
May 31 15:56:28 volumio kernel: ACPI Error: AE_NOT_FOUND, During name lookup/catalog (20240827/psobject-220)
May 31 15:56:28 volumio kernel: ACPI: Skipping parse of AML opcode: OpcodeName unavailable (0x0010)
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.PC00.TXHC.RHUB.SS02], AE_NOT_FOUND (20240827/dswload2-162)
May 31 15:56:28 volumio kernel: ACPI Error: AE_NOT_FOUND, During name lookup/catalog (20240827/psobject-220)
May 31 15:56:28 volumio kernel: ACPI: Skipping parse of AML opcode: OpcodeName unavailable (0x0010)
May 31 15:56:28 volumio kernel: ACPI: 12 ACPI AML tables successfully acquired and loaded
May 31 15:56:28 volumio kernel: ACPI: Dynamic OEM Table Load:
May 31 15:56:28 volumio kernel: ACPI: SSDT 0xFFFF888100D25C00 000394 (v02 PmRef Cpu0Cst 00003001 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: Dynamic OEM Table Load:
May 31 15:56:28 volumio kernel: ACPI: SSDT 0xFFFF888100D62C00 0001A3 (v02 PmRef Cpu0Ist 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: Dynamic OEM Table Load:
May 31 15:56:28 volumio kernel: ACPI: SSDT 0xFFFF888100D62E00 0001AB (v02 PmRef Cpu0Psd 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: Dynamic OEM Table Load:
May 31 15:56:28 volumio kernel: ACPI: SSDT 0xFFFF888100DEB000 0004B5 (v02 PmRef Cpu0Hwp 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: Dynamic OEM Table Load:
May 31 15:56:28 volumio kernel: ACPI: SSDT 0xFFFF8881009C2000 001BAF (v02 PmRef ApIst 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: Dynamic OEM Table Load:
May 31 15:56:28 volumio kernel: ACPI: SSDT 0xFFFF8881009C4000 001038 (v02 PmRef ApHwp 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: Dynamic OEM Table Load:
May 31 15:56:28 volumio kernel: ACPI: SSDT 0xFFFF8881009C6000 001349 (v02 PmRef ApPsd 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: Dynamic OEM Table Load:
May 31 15:56:28 volumio kernel: ACPI: SSDT 0xFFFF888100DE1000 000FBB (v02 PmRef ApCst 00003000 INTL 20200717)
May 31 15:56:28 volumio kernel: ACPI: Interpreter enabled
May 31 15:56:28 volumio kernel: ACPI: PM: (supports S0 S3 S4 S5)
May 31 15:56:28 volumio kernel: ACPI: Using IOAPIC for interrupt routing
May 31 15:56:28 volumio kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
May 31 15:56:28 volumio kernel: PCI: Ignoring E820 reservations for host bridge windows
May 31 15:56:28 volumio kernel: ACPI: Enabled 7 GPEs in block 00 to 7F
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.UBTC.RUCC], AE_NOT_FOUND (20240827/psargs-332)
May 31 15:56:28 volumio kernel: ACPI Error: Aborting method \_SB.PC00.XHCI.RHUB.HS01._PLD due to previous error (AE_NOT_FOUND) (20240827/psparse-529)
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.UBTC.RUCC], AE_NOT_FOUND (20240827/psargs-332)
May 31 15:56:28 volumio kernel: ACPI Error: Aborting method \_SB.PC00.XHCI.RHUB.HS02._PLD due to previous error (AE_NOT_FOUND) (20240827/psparse-529)
May 31 15:56:28 volumio kernel: ACPI: \_SB_.PC00.XHCI.RHUB.HS10.BTRT: New power resource
May 31 15:56:28 volumio kernel: ACPI: \_SB_.PC00.CNVW.WRST: New power resource
May 31 15:56:28 volumio kernel: ACPI: \_TZ_.FN00: New power resource
May 31 15:56:28 volumio kernel: ACPI: \_TZ_.FN01: New power resource
May 31 15:56:28 volumio kernel: ACPI: \_TZ_.FN02: New power resource
May 31 15:56:28 volumio kernel: ACPI: \_TZ_.FN03: New power resource
May 31 15:56:28 volumio kernel: ACPI: \_TZ_.FN04: New power resource
May 31 15:56:28 volumio kernel: ACPI: \PIN_: New power resource
May 31 15:56:28 volumio kernel: ACPI: PCI Root Bridge [PC00] (domain 0000 [bus 00-fe])
May 31 15:56:28 volumio kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
May 31 15:56:28 volumio kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug SHPCHotplug PME]
May 31 15:56:28 volumio kernel: acpi PNP0A08:00: _OSC: OS now controls [AER PCIeCapability LTR]
May 31 15:56:28 volumio kernel: acpi PNP0A08:00: FADT indicates ASPM is unsupported, using BIOS configuration
May 31 15:56:28 volumio kernel: PCI host bridge to bus 0000:00
May 31 15:56:28 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
May 31 15:56:28 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
May 31 15:56:28 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
May 31 15:56:28 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x80400000-0xbfffffff window]
May 31 15:56:28 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x4000000000-0x7fffffffff window]
May 31 15:56:28 volumio kernel: pci_bus 0000:00: root bus resource [bus 00-fe]
May 31 15:56:28 volumio kernel: pci 0000:00:00.0: [8086:461c] type 00 class 0x060000 conventional PCI endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: [8086:46d1] type 00 class 0x030000 PCIe Root Complex Integrated Endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: BAR 0 [mem 0x6000000000-0x6000ffffff 64bit]
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: BAR 2 [mem 0x4000000000-0x400fffffff 64bit pref]
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: BAR 4 [io 0x3000-0x303f]
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: DMAR: Skip IOMMU disabling for graphics
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: VF BAR 0 [mem 0x00000000-0x00ffffff 64bit]
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: VF BAR 0 [mem 0x00000000-0x06ffffff 64bit]: contains BAR 0 for 7 VFs
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: VF BAR 2 [mem 0x00000000-0x1fffffff 64bit pref]
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: VF BAR 2 [mem 0x00000000-0xdfffffff 64bit pref]: contains BAR 2 for 7 VFs
May 31 15:56:28 volumio kernel: pci 0000:00:0d.0: [8086:464e] type 00 class 0x0c0330 conventional PCI endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:0d.0: BAR 0 [mem 0x6001110000-0x600111ffff 64bit]
May 31 15:56:28 volumio kernel: pci 0000:00:0d.0: PME# supported from D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:14.0: [8086:54ed] type 00 class 0x0c0330 conventional PCI endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:14.0: BAR 0 [mem 0x6001100000-0x600110ffff 64bit]
May 31 15:56:28 volumio kernel: pci 0000:00:14.0: PME# supported from D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:14.2: [8086:54ef] type 00 class 0x050000 conventional PCI endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:14.2: BAR 0 [mem 0x6001128000-0x600112bfff 64bit]
May 31 15:56:28 volumio kernel: pci 0000:00:14.2: BAR 2 [mem 0x600112e000-0x600112efff 64bit]
May 31 15:56:28 volumio kernel: pci 0000:00:14.3: [8086:54f0] type 00 class 0x028000 PCIe Root Complex Integrated Endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:14.3: BAR 0 [mem 0x6001124000-0x6001127fff 64bit]
May 31 15:56:28 volumio kernel: pci 0000:00:14.3: PME# supported from D0 D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:16.0: [8086:54e0] type 00 class 0x078000 conventional PCI endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:16.0: BAR 0 [mem 0x600112d000-0x600112dfff 64bit]
May 31 15:56:28 volumio kernel: pci 0000:00:16.0: PME# supported from D3hot
May 31 15:56:28 volumio kernel: pci 0000:00:17.0: [8086:54d3] type 00 class 0x010601 conventional PCI endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:17.0: BAR 0 [mem 0x80c00000-0x80c01fff]
May 31 15:56:28 volumio kernel: pci 0000:00:17.0: BAR 1 [mem 0x80c03000-0x80c030ff]
May 31 15:56:28 volumio kernel: pci 0000:00:17.0: BAR 2 [io 0x3090-0x3097]
May 31 15:56:28 volumio kernel: pci 0000:00:17.0: BAR 3 [io 0x3080-0x3083]
May 31 15:56:28 volumio kernel: pci 0000:00:17.0: BAR 4 [io 0x3060-0x307f]
May 31 15:56:28 volumio kernel: pci 0000:00:17.0: BAR 5 [mem 0x80c02000-0x80c027ff]
May 31 15:56:28 volumio kernel: pci 0000:00:17.0: PME# supported from D3hot
May 31 15:56:28 volumio kernel: pci 0000:00:1c.0: [8086:54ba] type 01 class 0x060400 PCIe Root Port
May 31 15:56:28 volumio kernel: pci 0000:00:1c.0: PCI bridge to [bus 01]
May 31 15:56:28 volumio kernel: pci 0000:00:1c.0: bridge window [mem 0x80a00000-0x80bfffff]
May 31 15:56:28 volumio kernel: pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:1c.3: [8086:54bb] type 01 class 0x060400 PCIe Root Port
May 31 15:56:28 volumio kernel: pci 0000:00:1c.3: PCI bridge to [bus 02]
May 31 15:56:28 volumio kernel: pci 0000:00:1c.3: bridge window [mem 0x80800000-0x809fffff]
May 31 15:56:28 volumio kernel: pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:1c.6: [8086:54be] type 01 class 0x060400 PCIe Root Port
May 31 15:56:28 volumio kernel: pci 0000:00:1c.6: PCI bridge to [bus 03]
May 31 15:56:28 volumio kernel: pci 0000:00:1c.6: bridge window [mem 0x80600000-0x807fffff]
May 31 15:56:28 volumio kernel: pci 0000:00:1c.6: PME# supported from D0 D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:1d.0: [8086:54b3] type 01 class 0x060400 PCIe Root Port
May 31 15:56:28 volumio kernel: pci 0000:00:1d.0: PCI bridge to [bus 04]
May 31 15:56:28 volumio kernel: pci 0000:00:1d.0: bridge window [mem 0x80400000-0x805fffff]
May 31 15:56:28 volumio kernel: pci 0000:00:1d.0: PME# supported from D0 D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:1f.0: [8086:5481] type 00 class 0x060100 conventional PCI endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:1f.3: [8086:54c8] type 00 class 0x040100 conventional PCI endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:1f.3: BAR 0 [mem 0x6001120000-0x6001123fff 64bit]
May 31 15:56:28 volumio kernel: pci 0000:00:1f.3: BAR 4 [mem 0x6001000000-0x60010fffff 64bit]
May 31 15:56:28 volumio kernel: pci 0000:00:1f.3: PME# supported from D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:1f.4: [8086:54a3] type 00 class 0x0c0500 conventional PCI endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:1f.4: BAR 0 [mem 0x600112c000-0x600112c0ff 64bit]
May 31 15:56:28 volumio kernel: pci 0000:00:1f.4: BAR 4 [io 0xefa0-0xefbf]
May 31 15:56:28 volumio kernel: pci 0000:00:1f.5: [8086:54a4] type 00 class 0x0c8000 conventional PCI endpoint
May 31 15:56:28 volumio kernel: pci 0000:00:1f.5: BAR 0 [mem 0xfe010000-0xfe010fff]
May 31 15:56:28 volumio kernel: pci 0000:01:00.0: [8086:125c] type 00 class 0x020000 PCIe Endpoint
May 31 15:56:28 volumio kernel: pci 0000:01:00.0: BAR 0 [mem 0x80a00000-0x80afffff]
May 31 15:56:28 volumio kernel: pci 0000:01:00.0: BAR 3 [mem 0x80b00000-0x80b03fff]
May 31 15:56:28 volumio kernel: pci 0000:01:00.0: PME# supported from D0 D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:1c.0: PCI bridge to [bus 01]
May 31 15:56:28 volumio kernel: pci 0000:02:00.0: [8086:125c] type 00 class 0x020000 PCIe Endpoint
May 31 15:56:28 volumio kernel: pci 0000:02:00.0: BAR 0 [mem 0x80800000-0x808fffff]
May 31 15:56:28 volumio kernel: pci 0000:02:00.0: BAR 3 [mem 0x80900000-0x80903fff]
May 31 15:56:28 volumio kernel: pci 0000:02:00.0: PME# supported from D0 D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:1c.3: PCI bridge to [bus 02]
May 31 15:56:28 volumio kernel: pci 0000:03:00.0: [8086:125c] type 00 class 0x020000 PCIe Endpoint
May 31 15:56:28 volumio kernel: pci 0000:03:00.0: BAR 0 [mem 0x80600000-0x806fffff]
May 31 15:56:28 volumio kernel: pci 0000:03:00.0: BAR 3 [mem 0x80700000-0x80703fff]
May 31 15:56:28 volumio kernel: pci 0000:03:00.0: PME# supported from D0 D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:1c.6: PCI bridge to [bus 03]
May 31 15:56:28 volumio kernel: pci 0000:04:00.0: [8086:125c] type 00 class 0x020000 PCIe Endpoint
May 31 15:56:28 volumio kernel: pci 0000:04:00.0: BAR 0 [mem 0x80400000-0x804fffff]
May 31 15:56:28 volumio kernel: pci 0000:04:00.0: BAR 3 [mem 0x80500000-0x80503fff]
May 31 15:56:28 volumio kernel: pci 0000:04:00.0: PME# supported from D0 D3hot D3cold
May 31 15:56:28 volumio kernel: pci 0000:00:1d.0: PCI bridge to [bus 04]
May 31 15:56:28 volumio kernel: pci_bus 0000:00: on NUMA node 0
May 31 15:56:28 volumio kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 0
May 31 15:56:28 volumio kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 1
May 31 15:56:28 volumio kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 0
May 31 15:56:28 volumio kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 0
May 31 15:56:28 volumio kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 0
May 31 15:56:28 volumio kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 0
May 31 15:56:28 volumio kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 0
May 31 15:56:28 volumio kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 0
May 31 15:56:28 volumio kernel: iommu: Default domain type: Translated
May 31 15:56:28 volumio kernel: iommu: DMA domain TLB invalidation policy: lazy mode
May 31 15:56:28 volumio kernel: SCSI subsystem initialized
May 31 15:56:28 volumio kernel: libata version 3.00 loaded.
May 31 15:56:28 volumio kernel: ACPI: bus type USB registered
May 31 15:56:28 volumio kernel: usbcore: registered new interface driver usbfs
May 31 15:56:28 volumio kernel: usbcore: registered new interface driver hub
May 31 15:56:28 volumio kernel: usbcore: registered new device driver usb
May 31 15:56:28 volumio kernel: efivars: Registered efivars operations
May 31 15:56:28 volumio kernel: PCI: Using ACPI for IRQ routing
May 31 15:56:28 volumio kernel: PCI: pci_cache_line_size set to 64 bytes
May 31 15:56:28 volumio kernel: pci 0000:00:1f.5: BAR 0 [mem 0xfe010000-0xfe010fff]: can't claim; no compatible bridge window
May 31 15:56:28 volumio kernel: e820: reserve RAM buffer [mem 0x0005e000-0x0005ffff]
May 31 15:56:28 volumio kernel: e820: reserve RAM buffer [mem 0x6daee000-0x6fffffff]
May 31 15:56:28 volumio kernel: e820: reserve RAM buffer [mem 0x6f15c000-0x6fffffff]
May 31 15:56:28 volumio kernel: e820: reserve RAM buffer [mem 0x6f193000-0x6fffffff]
May 31 15:56:28 volumio kernel: e820: reserve RAM buffer [mem 0x6fc45000-0x6fffffff]
May 31 15:56:28 volumio kernel: e820: reserve RAM buffer [mem 0x73f00000-0x73ffffff]
May 31 15:56:28 volumio kernel: e820: reserve RAM buffer [mem 0x47fc00000-0x47fffffff]
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: vgaarb: bridge control possible
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
May 31 15:56:28 volumio kernel: vgaarb: loaded
May 31 15:56:28 volumio kernel: clocksource: Switched to clocksource tsc-early
May 31 15:56:28 volumio kernel: VFS: Disk quotas dquot_6.6.0
May 31 15:56:28 volumio kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
May 31 15:56:28 volumio kernel: pnp: PnP ACPI init
May 31 15:56:28 volumio kernel: system 00:00: [io 0x0a00-0x0a0f] has been reserved
May 31 15:56:28 volumio kernel: system 00:00: [io 0x0a10-0x0a1f] has been reserved
May 31 15:56:28 volumio kernel: system 00:00: [io 0x0a20-0x0a2f] has been reserved
May 31 15:56:28 volumio kernel: system 00:00: [io 0x0a30-0x0a3f] has been reserved
May 31 15:56:28 volumio kernel: system 00:00: [io 0x0a40-0x0a4f] has been reserved
May 31 15:56:28 volumio kernel: pnp 00:01: [dma 0 disabled]
May 31 15:56:28 volumio kernel: system 00:02: [io 0x0680-0x069f] has been reserved
May 31 15:56:28 volumio kernel: system 00:02: [io 0x164e-0x164f] has been reserved
May 31 15:56:28 volumio kernel: pnp 00:03: disabling [mem 0xc0000000-0xcfffffff] because it overlaps 0000:00:02.0 BAR 9 [mem 0x00000000-0xdfffffff 64bit pref]
May 31 15:56:28 volumio kernel: system 00:03: [mem 0xfedc0000-0xfedc7fff] has been reserved
May 31 15:56:28 volumio kernel: system 00:03: [mem 0xfeda0000-0xfeda0fff] has been reserved
May 31 15:56:28 volumio kernel: system 00:03: [mem 0xfeda1000-0xfeda1fff] has been reserved
May 31 15:56:28 volumio kernel: system 00:03: [mem 0xfed20000-0xfed7ffff] could not be reserved
May 31 15:56:28 volumio kernel: system 00:03: [mem 0xfed90000-0xfed93fff] has been reserved
May 31 15:56:28 volumio kernel: system 00:03: [mem 0xfed45000-0xfed8ffff] could not be reserved
May 31 15:56:28 volumio kernel: system 00:03: [mem 0xfee00000-0xfeefffff] could not be reserved
May 31 15:56:28 volumio kernel: system 00:04: [io 0x2000-0x20fe] has been reserved
May 31 15:56:28 volumio kernel: pnp: PnP ACPI: found 6 devices
May 31 15:56:28 volumio kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
May 31 15:56:28 volumio kernel: NET: Registered PF_INET protocol family
May 31 15:56:28 volumio kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear)
May 31 15:56:28 volumio kernel: tcp_listen_portaddr_hash hash table entries: 8192 (order: 5, 131072 bytes, linear)
May 31 15:56:28 volumio kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
May 31 15:56:28 volumio kernel: TCP established hash table entries: 131072 (order: 8, 1048576 bytes, linear)
May 31 15:56:28 volumio kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear)
May 31 15:56:28 volumio kernel: TCP: Hash tables configured (established 131072 bind 65536)
May 31 15:56:28 volumio kernel: UDP hash table entries: 8192 (order: 6, 262144 bytes, linear)
May 31 15:56:28 volumio kernel: UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes, linear)
May 31 15:56:28 volumio kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
May 31 15:56:28 volumio kernel: pci_bus 0000:00: max bus depth: 1 pci_try_num: 2
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: VF BAR 2 [mem 0x4020000000-0x40ffffffff 64bit pref]: assigned
May 31 15:56:28 volumio kernel: pci 0000:00:02.0: VF BAR 0 [mem 0x4010000000-0x4016ffffff 64bit]: assigned
May 31 15:56:28 volumio kernel: pci 0000:00:1f.5: BAR 0 [mem 0x80c04000-0x80c04fff]: assigned
May 31 15:56:28 volumio kernel: pci 0000:00:1c.0: PCI bridge to [bus 01]
May 31 15:56:28 volumio kernel: pci 0000:00:1c.0: bridge window [mem 0x80a00000-0x80bfffff]
May 31 15:56:28 volumio kernel: pci 0000:00:1c.3: PCI bridge to [bus 02]
May 31 15:56:28 volumio kernel: pci 0000:00:1c.3: bridge window [mem 0x80800000-0x809fffff]
May 31 15:56:28 volumio kernel: pci 0000:00:1c.6: PCI bridge to [bus 03]
May 31 15:56:28 volumio kernel: pci 0000:00:1c.6: bridge window [mem 0x80600000-0x807fffff]
May 31 15:56:28 volumio kernel: pci 0000:00:1d.0: PCI bridge to [bus 04]
May 31 15:56:28 volumio kernel: pci 0000:00:1d.0: bridge window [mem 0x80400000-0x805fffff]
May 31 15:56:28 volumio kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
May 31 15:56:28 volumio kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
May 31 15:56:28 volumio kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
May 31 15:56:28 volumio kernel: pci_bus 0000:00: resource 7 [mem 0x80400000-0xbfffffff window]
May 31 15:56:28 volumio kernel: pci_bus 0000:00: resource 8 [mem 0x4000000000-0x7fffffffff window]
May 31 15:56:28 volumio kernel: pci_bus 0000:01: resource 1 [mem 0x80a00000-0x80bfffff]
May 31 15:56:28 volumio kernel: pci_bus 0000:02: resource 1 [mem 0x80800000-0x809fffff]
May 31 15:56:28 volumio kernel: pci_bus 0000:03: resource 1 [mem 0x80600000-0x807fffff]
May 31 15:56:28 volumio kernel: pci_bus 0000:04: resource 1 [mem 0x80400000-0x805fffff]
May 31 15:56:28 volumio kernel: PCI: CLS 64 bytes, default 64
May 31 15:56:28 volumio kernel: DMAR: Host address width 39
May 31 15:56:28 volumio kernel: DMAR: DRHD base: 0x000000fed90000 flags: 0x0
May 31 15:56:28 volumio kernel: DMAR: dmar0: reg_base_addr fed90000 ver 4:0 cap 1c0000c40660462 ecap 29a00f0505e
May 31 15:56:28 volumio kernel: DMAR: DRHD base: 0x000000fed91000 flags: 0x1
May 31 15:56:28 volumio kernel: DMAR: dmar1: reg_base_addr fed91000 ver 5:0 cap d2008c40660462 ecap f050da
May 31 15:56:28 volumio kernel: DMAR: RMRR base: 0x0000007c000000 end: 0x000000803fffff
May 31 15:56:28 volumio kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
May 31 15:56:28 volumio kernel: software IO TLB: mapped [mem 0x0000000065c0d000-0x0000000069c0d000] (64MB)
May 31 15:56:28 volumio kernel: Trying to unpack rootfs image as initramfs...
May 31 15:56:28 volumio kernel: RAPL PMU: API unit is 2^-32 Joules, 3 fixed counters, 655360 ms ovfl timer
May 31 15:56:28 volumio kernel: RAPL PMU: hw unit of domain pp0-core 2^-14 Joules
May 31 15:56:28 volumio kernel: RAPL PMU: hw unit of domain package 2^-14 Joules
May 31 15:56:28 volumio kernel: RAPL PMU: hw unit of domain pp1-gpu 2^-14 Joules
May 31 15:56:28 volumio kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0xb9fb05486c, max_idle_ns: 440795231721 ns
May 31 15:56:28 volumio kernel: clocksource: Switched to clocksource tsc
May 31 15:56:28 volumio kernel: platform rtc_cmos: registered platform RTC device (no PNP device found)
May 31 15:56:28 volumio kernel: Initialise system trusted keyrings
May 31 15:56:28 volumio kernel: workingset: timestamp_bits=46 max_order=22 bucket_order=0
May 31 15:56:28 volumio kernel: Key type asymmetric registered
May 31 15:56:28 volumio kernel: Asymmetric key parser 'x509' registered
May 31 15:56:28 volumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
May 31 15:56:28 volumio kernel: io scheduler mq-deadline registered
May 31 15:56:28 volumio kernel: io scheduler kyber registered
May 31 15:56:28 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs
May 31 15:56:28 volumio kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
May 31 15:56:28 volumio kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input0
May 31 15:56:28 volumio kernel: ACPI: button: Sleep Button [SLPB]
May 31 15:56:28 volumio kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input1
May 31 15:56:28 volumio kernel: ACPI: button: Power Button [PWRB]
May 31 15:56:28 volumio kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2
May 31 15:56:28 volumio kernel: ACPI: button: Power Button [PWRF]
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.PC00.LPCB.ITE8.GETT], AE_NOT_FOUND (20240827/psargs-332)
May 31 15:56:28 volumio kernel: ACPI Error: Aborting method \_TZ.TZ00._TMP due to previous error (AE_NOT_FOUND) (20240827/psparse-529)
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.PC00.LPCB.ITE8.GETT], AE_NOT_FOUND (20240827/psargs-332)
May 31 15:56:28 volumio kernel: ACPI Error: Aborting method \_TZ.TZ00._TMP due to previous error (AE_NOT_FOUND) (20240827/psparse-529)
May 31 15:56:28 volumio kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
May 31 15:56:28 volumio kernel: 00:01: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
May 31 15:56:28 volumio kernel: serial8250: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
May 31 15:56:28 volumio kernel: hpet_acpi_add: no address or irqs in _CRS
May 31 15:56:28 volumio kernel: Linux agpgart interface v0.103
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:0d.0: xHCI Host Controller
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:0d.0: new USB bus registered, assigned bus number 1
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:0d.0: hcc params 0x20007fc1 hci version 0x120 quirks 0x0000000200009810
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:0d.0: xHCI Host Controller
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:0d.0: new USB bus registered, assigned bus number 2
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:0d.0: Host supports USB 3.2 Enhanced SuperSpeed
May 31 15:56:28 volumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12
May 31 15:56:28 volumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
May 31 15:56:28 volumio kernel: usb usb1: Product: xHCI Host Controller
May 31 15:56:28 volumio kernel: usb usb1: Manufacturer: Linux 6.12.57-volumio xhci-hcd
May 31 15:56:28 volumio kernel: usb usb1: SerialNumber: 0000:00:0d.0
May 31 15:56:28 volumio kernel: hub 1-0:1.0: USB hub found
May 31 15:56:28 volumio kernel: hub 1-0:1.0: 1 port detected
May 31 15:56:28 volumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.12
May 31 15:56:28 volumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
May 31 15:56:28 volumio kernel: usb usb2: Product: xHCI Host Controller
May 31 15:56:28 volumio kernel: usb usb2: Manufacturer: Linux 6.12.57-volumio xhci-hcd
May 31 15:56:28 volumio kernel: usb usb2: SerialNumber: 0000:00:0d.0
May 31 15:56:28 volumio kernel: hub 2-0:1.0: USB hub found
May 31 15:56:28 volumio kernel: hub 2-0:1.0: 2 ports detected
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 3
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:14.0: hcc params 0x20007fc1 hci version 0x120 quirks 0x0000100200009810
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 4
May 31 15:56:28 volumio kernel: xhci_hcd 0000:00:14.0: Host supports USB 3.1 Enhanced SuperSpeed
May 31 15:56:28 volumio kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12
May 31 15:56:28 volumio kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
May 31 15:56:28 volumio kernel: usb usb3: Product: xHCI Host Controller
May 31 15:56:28 volumio kernel: usb usb3: Manufacturer: Linux 6.12.57-volumio xhci-hcd
May 31 15:56:28 volumio kernel: usb usb3: SerialNumber: 0000:00:14.0
May 31 15:56:28 volumio kernel: hub 3-0:1.0: USB hub found
May 31 15:56:28 volumio kernel: hub 3-0:1.0: 12 ports detected
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.UBTC.RUCC], AE_NOT_FOUND (20240827/psargs-332)
May 31 15:56:28 volumio kernel: ACPI Error: Aborting method \_SB.PC00.XHCI.RHUB.HS01._PLD due to previous error (AE_NOT_FOUND) (20240827/psparse-529)
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.UBTC.RUCC], AE_NOT_FOUND (20240827/psargs-332)
May 31 15:56:28 volumio kernel: ACPI Error: Aborting method \_SB.PC00.XHCI.RHUB.HS01._UPC due to previous error (AE_NOT_FOUND) (20240827/psparse-529)
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.UBTC.RUCC], AE_NOT_FOUND (20240827/psargs-332)
May 31 15:56:28 volumio kernel: ACPI Error: Aborting method \_SB.PC00.XHCI.RHUB.HS01._PLD due to previous error (AE_NOT_FOUND) (20240827/psparse-529)
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.UBTC.RUCC], AE_NOT_FOUND (20240827/psargs-332)
May 31 15:56:28 volumio kernel: ACPI Error: Aborting method \_SB.PC00.XHCI.RHUB.HS02._PLD due to previous error (AE_NOT_FOUND) (20240827/psparse-529)
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.UBTC.RUCC], AE_NOT_FOUND (20240827/psargs-332)
May 31 15:56:28 volumio kernel: ACPI Error: Aborting method \_SB.PC00.XHCI.RHUB.HS02._UPC due to previous error (AE_NOT_FOUND) (20240827/psparse-529)
May 31 15:56:28 volumio kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.UBTC.RUCC], AE_NOT_FOUND (20240827/psargs-332)
May 31 15:56:28 volumio kernel: ACPI Error: Aborting method \_SB.PC00.XHCI.RHUB.HS02._PLD due to previous error (AE_NOT_FOUND) (20240827/psparse-529)
May 31 15:56:28 volumio kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.12
May 31 15:56:28 volumio kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
May 31 15:56:28 volumio kernel: usb usb4: Product: xHCI Host Controller
May 31 15:56:28 volumio kernel: usb usb4: Manufacturer: Linux 6.12.57-volumio xhci-hcd
May 31 15:56:28 volumio kernel: usb usb4: SerialNumber: 0000:00:14.0
May 31 15:56:28 volumio kernel: hub 4-0:1.0: USB hub found
May 31 15:56:28 volumio kernel: hub 4-0:1.0: 4 ports detected
May 31 15:56:28 volumio kernel: usbcore: registered new interface driver usb-storage
May 31 15:56:28 volumio kernel: i8042: PNP: No PS/2 controller found.
May 31 15:56:28 volumio kernel: i8042: Probing ports directly.
May 31 15:56:28 volumio kernel: i8042: No controller found
May 31 15:56:28 volumio kernel: mousedev: PS/2 mouse device common for all mice
May 31 15:56:28 volumio kernel: rtc_cmos rtc_cmos: RTC can wake from S4
May 31 15:56:28 volumio kernel: rtc_cmos rtc_cmos: registered as rtc0
May 31 15:56:28 volumio kernel: rtc_cmos rtc_cmos: setting system clock to 2026-05-31T08:56:15 UTC (1780217775)
May 31 15:56:28 volumio kernel: rtc_cmos rtc_cmos: alarms up to one month, y3k, 114 bytes nvram
May 31 15:56:28 volumio kernel: i2c_dev: i2c /dev entries driver
May 31 15:56:28 volumio kernel: intel_pstate: Intel P-state driver initializing
May 31 15:56:28 volumio kernel: intel_pstate: HWP enabled
May 31 15:56:28 volumio kernel: hid: raw HID events driver (C) Jiri Kosina
May 31 15:56:28 volumio kernel: NET: Registered PF_INET6 protocol family
May 31 15:56:28 volumio kernel: Segment Routing with IPv6
May 31 15:56:28 volumio kernel: In-situ OAM (IOAM) with IPv6
May 31 15:56:28 volumio kernel: mip6: Mobile IPv6
May 31 15:56:28 volumio kernel: NET: Registered PF_PACKET protocol family
May 31 15:56:28 volumio kernel: mpls_gso: MPLS GSO support
May 31 15:56:28 volumio kernel: ENERGY_PERF_BIAS: Set to 'normal', was 'performance'
May 31 15:56:28 volumio kernel: microcode: Current revision: 0x00000012
May 31 15:56:28 volumio kernel: IPI shorthand broadcast: enabled
May 31 15:56:28 volumio kernel: sched_clock: Marking stable (362298458, 3738604)->(381361570, -15324508)
May 31 15:56:28 volumio kernel: Loading compiled-in X.509 certificates
May 31 15:56:28 volumio kernel: clk: Disabling unused clocks
May 31 15:56:28 volumio kernel: PM: genpd: Disabling unused power domains
May 31 15:56:28 volumio kernel: usb 3-7: new high-speed USB device number 2 using xhci_hcd
May 31 15:56:28 volumio kernel: usb 3-7: New USB device found, idVendor=06cb, idProduct=1595, bcdDevice= 0.00
May 31 15:56:28 volumio kernel: usb 3-7: New USB device strings: Mfr=1, Product=2, SerialNumber=0
May 31 15:56:28 volumio kernel: usb 3-7: Product: CX31993 384Khz HIFI AUDIO
May 31 15:56:28 volumio kernel: usb 3-7: Manufacturer: Synaptics
May 31 15:56:28 volumio kernel: Freeing initrd memory: 80732K
May 31 15:56:28 volumio kernel: Freeing unused kernel image (initmem) memory: 3128K
May 31 15:56:28 volumio kernel: Write protecting the kernel read-only data: 22528k
May 31 15:56:28 volumio kernel: Freeing unused kernel image (rodata/data gap) memory: 824K
May 31 15:56:28 volumio kernel: Run /init as init process
May 31 15:56:28 volumio kernel: with arguments:
May 31 15:56:28 volumio kernel: /init
May 31 15:56:28 volumio kernel: splash
May 31 15:56:28 volumio kernel: with environment:
May 31 15:56:28 volumio kernel: HOME=/
May 31 15:56:28 volumio kernel: TERM=linux
May 31 15:56:28 volumio kernel: bootdelay=5
May 31 15:56:28 volumio kernel: biosdevname=0
May 31 15:56:28 volumio kernel: imgpart=UUID=9c5aafd3-d1f5-42ac-80ba-2722edd0150c
May 31 15:56:28 volumio kernel: bootpart=UUID=7C3E-4B23
May 31 15:56:28 volumio kernel: datapart=UUID=57e315c1-b339-4c2e-8155-8126725033f1
May 31 15:56:28 volumio kernel: hwdevice=x86
May 31 15:56:28 volumio kernel: uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg
May 31 15:56:28 volumio kernel: imgfile=/volumio_current.sqsh
May 31 15:56:28 volumio kernel: use_kmsg=no
May 31 15:56:28 volumio kernel: usb 3-10: new full-speed USB device number 3 using xhci_hcd
May 31 15:56:28 volumio kernel: ahci 0000:00:17.0: version 3.0
May 31 15:56:28 volumio kernel: ahci 0000:00:17.0: AHCI vers 0001.0301, 32 command slots, 6 Gbps, SATA mode
May 31 15:56:28 volumio kernel: ahci 0000:00:17.0: 1/1 ports implemented (port mask 0x2)
May 31 15:56:28 volumio kernel: ahci 0000:00:17.0: flags: 64bit ncq sntf pm clo only pio slum part deso sadm sds
May 31 15:56:28 volumio kernel: scsi host0: ahci
May 31 15:56:28 volumio kernel: i801_smbus 0000:00:1f.4: enabling device (0000 -> 0003)
May 31 15:56:28 volumio kernel: i801_smbus 0000:00:1f.4: SPD Write Disable is set
May 31 15:56:28 volumio kernel: i801_smbus 0000:00:1f.4: SMBus using PCI interrupt
May 31 15:56:28 volumio kernel: ACPI: bus type drm_connector registered
May 31 15:56:28 volumio kernel: scsi host1: ahci
May 31 15:56:28 volumio kernel: Intel(R) 2.5G Ethernet Linux Driver
May 31 15:56:28 volumio kernel: Copyright(c) 2018 Intel Corporation.
May 31 15:56:28 volumio kernel: igc 0000:01:00.0: enabling device (0000 -> 0002)
May 31 15:56:28 volumio kernel: igc 0000:01:00.0: PCIe PTM not supported by PCIe bus/controller
May 31 15:56:28 volumio kernel: igc 0000:01:00.0: can't disable ASPM; OS doesn't have ASPM control
May 31 15:56:28 volumio kernel: ata1: DUMMY
May 31 15:56:28 volumio kernel: ata2: SATA max UDMA/133 abar m2048@0x80c02000 port 0x80c02180 irq 126 lpm-pol 3
May 31 15:56:28 volumio kernel: i2c i2c-0: Successfully instantiated SPD at 0x50
May 31 15:56:28 volumio kernel: usb 3-10: New USB device found, idVendor=8087, idProduct=0aaa, bcdDevice= 0.02
May 31 15:56:28 volumio kernel: usb 3-10: New USB device strings: Mfr=0, Product=0, SerialNumber=0
May 31 15:56:28 volumio kernel: usbcore: registered new interface driver usbhid
May 31 15:56:28 volumio kernel: usbhid: USB HID core driver
May 31 15:56:28 volumio kernel: igc 0000:01:00.0: 4.000 Gb/s available PCIe bandwidth (5.0 GT/s PCIe x1 link)
May 31 15:56:28 volumio kernel: igc 0000:01:00.0 eth0: MAC: 00:f1:f7:a0:d0:76
May 31 15:56:28 volumio kernel: igc 0000:02:00.0: enabling device (0000 -> 0002)
May 31 15:56:28 volumio kernel: igc 0000:02:00.0: PCIe PTM not supported by PCIe bus/controller
May 31 15:56:28 volumio kernel: igc 0000:02:00.0: can't disable ASPM; OS doesn't have ASPM control
May 31 15:56:28 volumio kernel: igc 0000:02:00.0: 4.000 Gb/s available PCIe bandwidth (5.0 GT/s PCIe x1 link)
May 31 15:56:28 volumio kernel: igc 0000:02:00.0 eth1: MAC: 00:f1:f7:a0:d0:77
May 31 15:56:28 volumio kernel: igc 0000:03:00.0: enabling device (0000 -> 0002)
May 31 15:56:28 volumio kernel: igc 0000:03:00.0: PCIe PTM not supported by PCIe bus/controller
May 31 15:56:28 volumio kernel: igc 0000:03:00.0: can't disable ASPM; OS doesn't have ASPM control
May 31 15:56:28 volumio kernel: igc 0000:03:00.0: 4.000 Gb/s available PCIe bandwidth (5.0 GT/s PCIe x1 link)
May 31 15:56:28 volumio kernel: igc 0000:03:00.0 eth2: MAC: 00:f1:f7:a0:d0:78
May 31 15:56:28 volumio kernel: igc 0000:04:00.0: enabling device (0000 -> 0002)
May 31 15:56:28 volumio kernel: igc 0000:04:00.0: PCIe PTM not supported by PCIe bus/controller
May 31 15:56:28 volumio kernel: igc 0000:04:00.0: can't disable ASPM; OS doesn't have ASPM control
May 31 15:56:28 volumio kernel: igc 0000:04:00.0: 4.000 Gb/s available PCIe bandwidth (5.0 GT/s PCIe x1 link)
May 31 15:56:28 volumio kernel: igc 0000:04:00.0 eth3: MAC: 00:f1:f7:a0:d0:79
May 31 15:56:28 volumio kernel: ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
May 31 15:56:28 volumio kernel: ata2.00: ATA-9: EX280471RUS, W0814B0, max UDMA/133
May 31 15:56:28 volumio kernel: ata2.00: 250069680 sectors, multi 1: LBA48 NCQ (depth 32), AA
May 31 15:56:28 volumio kernel: ata2.00: configured for UDMA/133
May 31 15:56:28 volumio kernel: scsi 1:0:0:0: Direct-Access ATA EX280471RUS 4B0 PQ: 0 ANSI: 5
May 31 15:56:28 volumio kernel: sd 1:0:0:0: [sda] 250069680 512-byte logical blocks: (128 GB/119 GiB)
May 31 15:56:28 volumio kernel: sd 1:0:0:0: [sda] Write Protect is off
May 31 15:56:28 volumio kernel: sd 1:0:0:0: [sda] Mode Sense: 00 3a 00 00
May 31 15:56:28 volumio kernel: sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
May 31 15:56:28 volumio kernel: sd 1:0:0:0: [sda] Preferred minimum I/O size 512 bytes
May 31 15:56:28 volumio kernel: sda: sda1 sda2 sda3
May 31 15:56:28 volumio kernel: sd 1:0:0:0: [sda] Attached SCSI disk
May 31 15:56:28 volumio kernel: input: Synaptics CX31993 384Khz HIFI AUDIO Consumer Control as /devices/pci0000:00/0000:00:14.0/usb3/3-7/3-7:1.2/0003:06CB:1595.0001/input/input3
May 31 15:56:28 volumio kernel: snd_hda_intel 0000:00:1f.3: enabling device (0000 -> 0002)
May 31 15:56:28 volumio kernel: hid-generic 0003:06CB:1595.0001: input,hidraw0: USB HID v1.11 Device [Synaptics CX31993 384Khz HIFI AUDIO] on usb-0000:00:14.0-7/input2
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] Found ALDERLAKE_P/ADL-N (device ID 46d1) display version 13.00 stepping D0
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: vgaarb: deactivate vga console
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] Using Transparent Hugepages
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: vgaarb: VGA decodes changed: olddecodes=io+mem,decodes=io+mem:owns=io+mem
May 31 15:56:28 volumio kernel: ------------[ cut here ]------------
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] Platform does not support port C
May 31 15:56:28 volumio kernel: WARNING: CPU: 3 PID: 122 at drivers/gpu/drm/i915/display/intel_display.c:7783 assert_port_valid+0x61/0x80 [i915]
May 31 15:56:28 volumio kernel: Modules linked in: i915(+) snd_hda_intel snd_intel_dspcfg drm_buddy snd_hda_codec drm_display_helper snd_hwdep snd_hda_core ttm cec snd_pcm rc_core snd_timer hid_generic drm_kms_helper usbhid snd i2c_i801 i2c_mux crc32c_intel soundcore i2c_smbus igc drm ahci libahci video wmi pinctrl_alderlake
May 31 15:56:28 volumio kernel: CPU: 3 UID: 0 PID: 122 Comm: (udev-worker) Not tainted 6.12.57-volumio #2
May 31 15:56:28 volumio kernel: Hardware name: Firebat_Computer ZY-R1/ZYR1-SC, BIOS 5.26 08/23/2024
May 31 15:56:28 volumio kernel: RIP: 0010:assert_port_valid+0x61/0x80 [i915]
May 31 15:56:28 volumio kernel: Code: 44 8d 66 41 4c 8b 6f 50 4d 85 ed 75 03 4c 8b 2f e8 74 f3 3e e1 44 89 e1 4c 89 ea 48 c7 c7 20 89 64 a0 48 89 c6 e8 7f ac c5 e0 <0f> 0b 89 d8 5b 41 5c 83 e0 01 41 5d 5d c3 cc cc cc cc 66 66 2e 0f
May 31 15:56:28 volumio kernel: RSP: 0018:ffffc90000413820 EFLAGS: 00010286
May 31 15:56:28 volumio kernel: RAX: 0000000000000000 RBX: 000000000000001e RCX: 00000000ffffefff
May 31 15:56:28 volumio kernel: RDX: 0000000000000000 RSI: 00000000ffffefff RDI: 0000000000000001
May 31 15:56:28 volumio kernel: RBP: ffffc90000413838 R08: 00000000ffffefff R09: ffffffff82650760
May 31 15:56:28 volumio kernel: R10: 0000000000000003 R11: ffffffff82650760 R12: 0000000000000043
May 31 15:56:28 volumio kernel: R13: ffff88810101e9d0 R14: ffff888103758618 R15: 0000000000000002
May 31 15:56:28 volumio kernel: FS: 00007f10256158c0(0000) GS:ffff88846fb80000(0000) knlGS:0000000000000000
May 31 15:56:28 volumio kernel: CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
May 31 15:56:28 volumio kernel: CR2: 00005639050dd908 CR3: 0000000100272006 CR4: 0000000000f70ef0
May 31 15:56:28 volumio kernel: PKRU: 55555554
May 31 15:56:28 volumio kernel: Call Trace:
May 31 15:56:28 volumio kernel:
May 31 15:56:28 volumio kernel: ? __pfx_intel_ddi_init+0x10/0x10 [i915]
May 31 15:56:28 volumio kernel: intel_ddi_init+0x6d/0x1130 [i915]
May 31 15:56:28 volumio kernel: ? __pfx_intel_ddi_init+0x10/0x10 [i915]
May 31 15:56:28 volumio kernel: intel_bios_for_each_encoder+0x3a/0x60 [i915]
May 31 15:56:28 volumio kernel: intel_setup_outputs+0x4ed/0xc20 [i915]
May 31 15:56:28 volumio kernel: intel_display_driver_probe_nogem+0x170/0x220 [i915]
May 31 15:56:28 volumio kernel: i915_driver_probe+0x683/0xc30 [i915]
May 31 15:56:28 volumio kernel: ? drm_privacy_screen_get+0x168/0x190 [drm]
May 31 15:56:28 volumio kernel: ? acpi_dev_found+0x68/0x80
May 31 15:56:28 volumio kernel: i915_pci_probe+0xcd/0x150 [i915]
May 31 15:56:28 volumio kernel: pci_device_probe+0xa9/0x170
May 31 15:56:28 volumio kernel: really_probe+0xdc/0x3a0
May 31 15:56:28 volumio kernel: __driver_probe_device+0x7d/0x160
May 31 15:56:28 volumio kernel: driver_probe_device+0x24/0xa0
May 31 15:56:28 volumio kernel: __driver_attach+0xdd/0x1d0
May 31 15:56:28 volumio kernel: ? __pfx___driver_attach+0x10/0x10
May 31 15:56:28 volumio kernel: bus_for_each_dev+0x90/0xf0
May 31 15:56:28 volumio kernel: driver_attach+0x22/0x30
May 31 15:56:28 volumio kernel: bus_add_driver+0x118/0x240
May 31 15:56:28 volumio kernel: driver_register+0x62/0x120
May 31 15:56:28 volumio kernel: __pci_register_driver+0x62/0x70
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] Finished loading DMC firmware i915/adlp_dmc.bin (v2.20)
May 31 15:56:28 volumio kernel: i915_pci_register_driver+0x27/0x30 [i915]
May 31 15:56:28 volumio kernel: i915_init+0x27/0xd0 [i915]
May 31 15:56:28 volumio kernel: ? __pfx_i915_init+0x10/0x10 [i915]
May 31 15:56:28 volumio kernel: do_one_initcall+0x75/0x250
May 31 15:56:28 volumio kernel: do_init_module+0x68/0x250
May 31 15:56:28 volumio kernel: load_module+0x1e19/0x1f20
May 31 15:56:28 volumio kernel: init_module_from_file+0x97/0xd0
May 31 15:56:28 volumio kernel: ? init_module_from_file+0x97/0xd0
May 31 15:56:28 volumio kernel: idempotent_init_module+0x143/0x330
May 31 15:56:28 volumio kernel: __x64_sys_finit_module+0x64/0xc0
May 31 15:56:28 volumio kernel: x64_sys_call+0x200c/0x2060
May 31 15:56:28 volumio kernel: do_syscall_64+0x4b/0x110
May 31 15:56:28 volumio kernel: entry_SYSCALL_64_after_hwframe+0x76/0x7e
May 31 15:56:28 volumio kernel: RIP: 0033:0x7f1025d28819
May 31 15:56:28 volumio kernel: Code: 08 89 e8 5b 5d c3 66 2e 0f 1f 84 00 00 00 00 00 90 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d b7 15 0d 00 f7 d8 64 89 01 48
May 31 15:56:28 volumio kernel: RSP: 002b:00007ffc1d2610b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139
May 31 15:56:28 volumio kernel: RAX: ffffffffffffffda RBX: 00005639050b02a0 RCX: 00007f1025d28819
May 31 15:56:28 volumio kernel: RDX: 0000000000000000 RSI: 00007f1025ebcefd RDI: 0000000000000011
May 31 15:56:28 volumio kernel: RBP: 00007f1025ebcefd R08: 0000000000000000 R09: 0000000000000000
May 31 15:56:28 volumio kernel: R10: 0000000000000011 R11: 0000000000000246 R12: 0000000000020000
May 31 15:56:28 volumio kernel: R13: 0000000000000000 R14: 00005639050b3150 R15: 00007ffc1d2612f0
May 31 15:56:28 volumio kernel:
May 31 15:56:28 volumio kernel: ---[ end trace 0000000000000000 ]---
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] GT0: GuC firmware i915/tgl_guc_70.bin version 70.44.1
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] GT0: HuC firmware i915/tgl_huc.bin version 7.9.3
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] GT0: HuC: authenticated for all workloads
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] GT0: GUC: submission enabled
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] GT0: GUC: SLPC enabled
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] GT0: GUC: RC enabled
May 31 15:56:28 volumio kernel: [drm] Initialized i915 1.6.0 for 0000:00:02.0 on minor 0
May 31 15:56:28 volumio kernel: ACPI: video: Video Device [GFX0] (multi-head: yes rom: no post: no)
May 31 15:56:28 volumio kernel: input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input4
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes
May 31 15:56:28 volumio kernel: snd_hda_intel 0000:00:1f.3: bound 0000:00:02.0 (ops __SCT__tp_func_intel_frontbuffer_flush [i915])
May 31 15:56:28 volumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
May 31 15:56:28 volumio kernel: fuse: init (API version 7.41)
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes
May 31 15:56:28 volumio kernel: input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1f.3/sound/card0/input5
May 31 15:56:28 volumio kernel: input: HDA Intel PCH HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:1f.3/sound/card0/input6
May 31 15:56:28 volumio kernel: input: HDA Intel PCH HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:1f.3/sound/card0/input7
May 31 15:56:28 volumio kernel: input: HDA Intel PCH HDMI/DP,pcm=9 as /devices/pci0000:00/0000:00:1f.3/sound/card0/input8
May 31 15:56:28 volumio kernel: sdhci: Secure Digital Host Controller Interface driver
May 31 15:56:28 volumio kernel: sdhci: Copyright(c) Pierre Ossman
May 31 15:56:28 volumio kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes
May 31 15:56:28 volumio kernel: usbcore: registered new interface driver uas
May 31 15:56:28 volumio kernel: [drm] radeon kernel modesetting enabled.
May 31 15:56:28 volumio kernel: [drm] amdgpu kernel modesetting enabled.
May 31 15:56:28 volumio kernel: genirq: Flags mismatch irq 14. 00000008 (platform[pata_legacy.0]) vs. 00010088 (INTC1057:00)
May 31 15:56:28 volumio kernel: scsi host2: pata_legacy
May 31 15:56:28 volumio kernel: ata3: PATA max PIO4 cmd 0x170 ctl 0x376 irq 15 lpm-pol 0
May 31 15:56:28 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
May 31 15:56:28 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
May 31 15:56:28 volumio kernel: EXT4-fs (sda2): recovery complete
May 31 15:56:28 volumio kernel: EXT4-fs (sda2): mounted filesystem 9c5aafd3-d1f5-42ac-80ba-2722edd0150c r/w with ordered data mode. Quota mode: none.
May 31 15:56:28 volumio kernel: loop: module loaded
May 31 15:56:28 volumio kernel: block device autoloading is deprecated and will be removed.
May 31 15:56:28 volumio kernel: loop0: detected capacity change from 0 to 2331568
May 31 15:56:28 volumio kernel: EXT4-fs (sda3): 2 orphan inodes deleted
May 31 15:56:28 volumio kernel: EXT4-fs (sda3): recovery complete
May 31 15:56:28 volumio kernel: EXT4-fs (sda3): mounted filesystem 57e315c1-b339-4c2e-8155-8126725033f1 r/w with ordered data mode. Quota mode: none.
May 31 15:56:28 volumio systemd[1]: Inserted module 'autofs4'
May 31 15:56:28 volumio 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 31 15:56:28 volumio systemd[1]: Detected architecture x86-64.
May 31 15:56:28 volumio systemd[1]: Hostname set to .
May 31 15:56:28 volumio systemd-gpt-auto-generator[514]: EFI loader partition unknown, exiting.
May 31 15:56:28 volumio systemd-gpt-auto-generator[514]: (The boot loader did not set EFI variable LoaderDevicePartUUID.)
May 31 15:56:28 volumio systemd[1]: Queued start job for default target graphical.target.
May 31 15:56:28 volumio systemd[1]: Created slice system-getty.slice - Slice /system/getty.
May 31 15:56:28 volumio systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
May 31 15:56:28 volumio systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
May 31 15:56:28 volumio systemd[1]: Created slice user.slice - User and Session Slice.
May 31 15:56:28 volumio systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
May 31 15:56:28 volumio systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
May 31 15:56:28 volumio systemd[1]: Expecting device dev-disk-by\x2duuid-7C3E\x2d4B23.device - /dev/disk/by-uuid/7C3E-4B23...
May 31 15:56:28 volumio systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
May 31 15:56:28 volumio systemd[1]: Reached target slices.target - Slice Units.
May 31 15:56:28 volumio systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
May 31 15:56:28 volumio systemd[1]: Listening on rpcbind.socket - RPCbind Server Activation Socket.
May 31 15:56:28 volumio systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket.
May 31 15:56:28 volumio systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe.
May 31 15:56:28 volumio systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket.
May 31 15:56:28 volumio systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
May 31 15:56:28 volumio systemd[1]: Listening on systemd-journald.socket - Journal Socket.
May 31 15:56:28 volumio systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 31 15:56:28 volumio systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 31 15:56:28 volumio systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
May 31 15:56:28 volumio systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
May 31 15:56:28 volumio systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
May 31 15:56:28 volumio systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
May 31 15:56:28 volumio systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab).
May 31 15:56:28 volumio systemd[1]: Started dynamicswap.service - dynamicswap service.
May 31 15:56:28 volumio systemd[1]: Reached target swap.target - Swaps.
May 31 15:56:28 volumio systemd[1]: Starting fake-hwclock.service - Restore / save the current clock...
May 31 15:56:28 volumio systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 31 15:56:28 volumio systemd[1]: Starting systemd-journald.service - Journal Service...
May 31 15:56:28 volumio kernel: pstore: Using crash dump compression: deflate
May 31 15:56:28 volumio kernel: pstore: Registered efi_pstore as persistent store backend
May 31 15:56:28 volumio systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 31 15:56:28 volumio systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
May 31 15:56:28 volumio systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 31 15:56:28 volumio systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
May 31 15:56:28 volumio systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
May 31 15:56:28 volumio systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
May 31 15:56:28 volumio systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
May 31 15:56:28 volumio systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 31 15:56:28 volumio systemd[1]: modprobe@configfs.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
May 31 15:56:28 volumio systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 31 15:56:28 volumio systemd[1]: modprobe@drm.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 31 15:56:28 volumio systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 31 15:56:28 volumio systemd[1]: modprobe@fuse.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
May 31 15:56:28 volumio systemd[1]: modprobe@loop.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 31 15:56:28 volumio systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
May 31 15:56:28 volumio systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
May 31 15:56:28 volumio systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 31 15:56:28 volumio systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
May 31 15:56:28 volumio systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
May 31 15:56:28 volumio systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
May 31 15:56:28 volumio systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes).
May 31 15:56:28 volumio systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 31 15:56:28 volumio systemd[1]: Starting systemd-random-seed.service - Load/Save Random Seed...
May 31 15:56:28 volumio systemd[1]: Starting systemd-sysusers.service - Create System Users...
May 31 15:56:28 volumio systemd[1]: Finished fake-hwclock.service - Restore / save the current clock.
May 31 15:56:28 volumio systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 31 15:56:28 volumio systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 31 15:56:28 volumio systemd[1]: Finished systemd-random-seed.service - Load/Save Random Seed.
May 31 15:56:28 volumio systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes).
May 31 15:56:28 volumio systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 31 15:56:28 volumio systemd[1]: Finished systemd-sysusers.service - Create System Users.
May 31 15:56:28 volumio systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 31 15:56:28 volumio systemd[1]: dynamicswap.service: Deactivated successfully.
May 31 15:56:28 volumio systemd-journald[541]: Journal started
May 31 15:56:28 volumio systemd-journald[541]: Runtime Journal (/run/log/journal/30175a60cf76629f74f78d9769c2cd99) is 3.7M, max 30.0M, 26.2M free.
May 31 15:56:28 volumio fake-hwclock[532]: Current system time: 2026-05-31 08:56:28
May 31 15:56:28 volumio fake-hwclock[532]: fake-hwclock saved clock information is in the past: 2026-03-24 17:44:34
May 31 15:56:28 volumio fake-hwclock[532]: To set system time to this saved clock anyway, use "force"
May 31 15:56:28 volumio systemd[1]: Started systemd-journald.service - Journal Service.
May 31 15:56:28 volumio systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 31 15:56:28 volumio systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
May 31 15:56:28 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
May 31 15:56:28 volumio systemd[1]: Mounting tmp.mount - /tmp...
May 31 15:56:28 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway.
May 31 15:56:28 volumio systemd[1]: Mounting var-log.mount - /var/log...
May 31 15:56:28 volumio systemd[1]: Mounting var-spool-cups.mount - /var/spool/cups...
May 31 15:56:28 volumio systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 31 15:56:28 volumio systemd[1]: Mounted tmp.mount - /tmp.
May 31 15:56:28 volumio systemd[1]: Mounted var-log.mount - /var/log.
May 31 15:56:28 volumio systemd[1]: Mounted var-spool-cups.mount - /var/spool/cups.
May 31 15:56:28 volumio systemd[1]: Mounting var-spool-cups-tmp.mount - /var/spool/cups/tmp...
May 31 15:56:28 volumio systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage...
May 31 15:56:28 volumio systemd[1]: Mounted var-spool-cups-tmp.mount - /var/spool/cups/tmp.
May 31 15:56:28 volumio systemd-journald[541]: Runtime Journal (/run/log/journal/30175a60cf76629f74f78d9769c2cd99) is 3.7M, max 30.0M, 26.2M free.
May 31 15:56:28 volumio systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage.
May 31 15:56:28 volumio systemd-journald[541]: Received client request to flush runtime journal.
May 31 15:56:28 volumio systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 31 15:56:28 volumio systemd-udevd[567]: Using default interface naming scheme 'v252'.
May 31 15:56:28 volumio systemd[1]: Starting ifupdown-pre.service - Helper to synchronize boot up for ifupdown...
May 31 15:56:28 volumio systemd[1]: Finished ifupdown-pre.service - Helper to synchronize boot up for ifupdown.
May 31 15:56:28 volumio systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 31 15:56:28 volumio kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0
May 31 15:56:28 volumio (udev-worker)[591]: Network interface NamePolicy= disabled on kernel command line.
May 31 15:56:28 volumio (udev-worker)[596]: Network interface NamePolicy= disabled on kernel command line.
May 31 15:56:28 volumio (udev-worker)[586]: Network interface NamePolicy= disabled on kernel command line.
May 31 15:56:28 volumio (udev-worker)[590]: Network interface NamePolicy= disabled on kernel command line.
May 31 15:56:28 volumio systemd[1]: Found device dev-disk-by\x2duuid-7C3E\x2d4B23.device - EX280471RUS boot.
May 31 15:56:28 volumio systemd[1]: Starting systemd-fsck@dev-disk-by\x2duuid-7C3E\x2d4B23.service - File System Check on /dev/disk/by-uuid/7C3E-4B23...
May 31 15:56:28 volumio systemd[1]: Expecting device sys-subsystem-net-devices-eth0.device - /sys/subsystem/net/devices/eth0...
May 31 15:56:28 volumio systemd[1]: Started systemd-fsckd.service - File System Check Daemon to report status.
May 31 15:56:28 volumio systemd[1]: Found device sys-subsystem-net-devices-eth0.device - Ethernet Controller I226-V.
May 31 15:56:28 volumio systemd-fsck[647]: fsck.fat 4.2 (2021-01-31)
May 31 15:56:28 volumio systemd-fsck[647]: /dev/sda1: 18 files, 23294/93500 clusters
May 31 15:56:28 volumio systemd[1]: Finished systemd-fsck@dev-disk-by\x2duuid-7C3E\x2d4B23.service - File System Check on /dev/disk/by-uuid/7C3E-4B23.
May 31 15:56:28 volumio kernel: intel_pmc_core INT33A1:00: initialized
May 31 15:56:28 volumio kernel: mei_me 0000:00:16.0: enabling device (0000 -> 0002)
May 31 15:56:28 volumio rfkill[649]: unblock set for type bluetooth
May 31 15:56:28 volumio kernel: mei_me 0000:00:16.0: hbm: dma setup response: failure = 3 REJECTED
May 31 15:56:28 volumio kernel: cryptd: max_cpu_qlen set to 1000
May 31 15:56:28 volumio kernel: AES CTR mode by8 optimization enabled
May 31 15:56:28 volumio systemd[1]: Listening on systemd-rfkill.socket - Load/Save RF Kill Switch Status /dev/rfkill Watch.
May 31 15:56:28 volumio (udev-worker)[587]: controlC0: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 0' failed with exit code 99.
May 31 15:56:28 volumio kernel: usbcore: registered new interface driver snd-usb-audio
May 31 15:56:28 volumio kernel: Bluetooth: Core ver 2.22
May 31 15:56:28 volumio kernel: NET: Registered PF_BLUETOOTH protocol family
May 31 15:56:28 volumio kernel: Bluetooth: HCI device and connection manager initialized
May 31 15:56:28 volumio kernel: Bluetooth: HCI socket layer initialized
May 31 15:56:28 volumio kernel: Bluetooth: L2CAP socket layer initialized
May 31 15:56:28 volumio kernel: Bluetooth: SCO socket layer initialized
May 31 15:56:28 volumio systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 31 15:56:28 volumio systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes).
May 31 15:56:28 volumio systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes).
May 31 15:56:28 volumio systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 31 15:56:28 volumio systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 31 15:56:28 volumio systemd[1]: modprobe@loop.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 31 15:56:28 volumio systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 31 15:56:28 volumio systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 31 15:56:28 volumio (udev-worker)[586]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 99.
May 31 15:56:28 volumio systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 31 15:56:28 volumio systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes).
May 31 15:56:28 volumio systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes).
May 31 15:56:28 volumio systemd[1]: modprobe@loop.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 31 15:56:28 volumio systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 31 15:56:28 volumio systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 31 15:56:28 volumio systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 31 15:56:28 volumio systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 31 15:56:28 volumio (udev-worker)[578]: pcmC5D0p: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7.
May 31 15:56:28 volumio kernel: usbcore: registered new interface driver btusb
May 31 15:56:28 volumio kernel: Bluetooth: hci0: Device revision is 2
May 31 15:56:28 volumio kernel: Bluetooth: hci0: Secure boot is enabled
May 31 15:56:28 volumio kernel: Bluetooth: hci0: OTP lock is enabled
May 31 15:56:28 volumio kernel: Bluetooth: hci0: API lock is enabled
May 31 15:56:28 volumio kernel: Bluetooth: hci0: Debug lock is disabled
May 31 15:56:28 volumio kernel: Bluetooth: hci0: Minimum firmware build 1 week 10 2014
May 31 15:56:28 volumio kernel: Bluetooth: hci0: Bootloader timestamp 2019.40 buildtype 1 build 38
May 31 15:56:28 volumio kernel: Bluetooth: hci0: DSM reset method type: 0x00
May 31 15:56:28 volumio (udev-worker)[596]: hci0: Process '/usr/bin/hciconfig hci0 up' failed with exit code 1.
May 31 15:56:28 volumio rfkill[786]: unblock set for type bluetooth
May 31 15:56:28 volumio kernel: Bluetooth: hci0: Found device firmware: intel/ibt-0040-2120.sfi
May 31 15:56:28 volumio kernel: Bluetooth: hci0: Boot Address: 0x100800
May 31 15:56:28 volumio kernel: Bluetooth: hci0: Firmware Version: 151-5.24
May 31 15:56:28 volumio systemd[1]: Starting systemd-rfkill.service - Load/Save RF Kill Switch Status...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 31 15:56:28 volumio systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 31 15:56:28 volumio systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes).
May 31 15:56:28 volumio systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes).
May 31 15:56:28 volumio systemd[1]: Started systemd-rfkill.service - Load/Save RF Kill Switch Status.
May 31 15:56:28 volumio systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 31 15:56:28 volumio systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 31 15:56:28 volumio systemd[1]: modprobe@loop.service: Deactivated successfully.
May 31 15:56:28 volumio systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 31 15:56:28 volumio systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 31 15:56:28 volumio systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 31 15:56:29 volumio systemd[1]: Mounting boot.mount - /boot...
May 31 15:56:29 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
May 31 15:56:29 volumio systemd[1]: Mounted boot.mount - /boot.
May 31 15:56:29 volumio systemd[1]: Reached target local-fs.target - Local File Systems.
May 31 15:56:29 volumio systemd[1]: Started ifup@eth0.service - ifup for eth0.
May 31 15:56:29 volumio systemd[1]: Starting networking.service - Raise network interfaces...
May 31 15:56:29 volumio systemd[1]: Starting plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data...
May 31 15:56:29 volumio systemd[1]: Starting plymouth-rotation.service - Plymouth rotation detection for shutdown/reboot...
May 31 15:56:29 volumio systemd[1]: Starting systemd-binfmt.service - Set Up Additional Binary Formats...
May 31 15:56:29 volumio 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 31 15:56:29 volumio systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 31 15:56:29 volumio systemd[1]: Finished plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data.
May 31 15:56:29 volumio systemd[1]: Received SIGRTMIN+20 from PID 402 (plymouthd).
May 31 15:56:29 volumio systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 806 (systemd-binfmt)
May 31 15:56:29 volumio systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System...
May 31 15:56:29 volumio systemd[1]: Finished plymouth-rotation.service - Plymouth rotation detection for shutdown/reboot.
May 31 15:56:29 volumio systemd[1]: Starting plymouth-start.service - Show Plymouth Boot Screen...
May 31 15:56:29 volumio systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System.
May 31 15:56:29 volumio systemd[1]: Finished systemd-binfmt.service - Set Up Additional Binary Formats.
May 31 15:56:29 volumio systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 31 15:56:29 volumio systemd[1]: Mounting run-rpc_pipefs.mount - RPC Pipe File System...
May 31 15:56:29 volumio systemd[1]: Started haveged.service - Entropy Daemon based on the HAVEGE algorithm.
May 31 15:56:29 volumio systemd[1]: Starting rpcbind.service - RPC bind portmap service...
May 31 15:56:29 volumio systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
May 31 15:56:29 volumio systemd[1]: Started plymouth-start.service - Show Plymouth Boot Screen.
May 31 15:56:29 volumio 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 31 15:56:29 volumio systemd[1]: Started systemd-ask-password-plymouth.path - Forward Password Requests to Plymouth Directory Watch.
May 31 15:56:29 volumio systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 31 15:56:29 volumio systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
May 31 15:56:29 volumio systemd[1]: Reached target sysinit.target - System Initialization.
May 31 15:56:29 volumio systemd[1]: Started acpid.path - ACPI Events Check.
May 31 15:56:29 volumio systemd[1]: Started apt-daily.timer - Daily apt download activities.
May 31 15:56:29 volumio systemd[1]: Started apt-daily-upgrade.timer - Daily apt upgrade and clean activities.
May 31 15:56:29 volumio systemd[1]: Started dpkg-db-backup.timer - Daily dpkg database backup timer.
May 31 15:56:29 volumio systemd[1]: Started e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems.
May 31 15:56:29 volumio systemd[1]: Started fstrim.timer - Discard unused blocks once a week.
May 31 15:56:29 volumio systemd[1]: Started man-db.timer - Daily man-db regeneration.
May 31 15:56:29 volumio systemd[1]: Started ntpsec-rotate-stats.timer - Rotate ntpd stats daily.
May 31 15:56:29 volumio systemd[1]: Started setdatetime-helper.timer - Volumio Time Sync Watchdog Timer.
May 31 15:56:29 volumio systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories.
May 31 15:56:29 volumio systemd[1]: Reached target paths.target - Path Units.
May 31 15:56:29 volumio systemd[1]: Reached target timers.target - Timer Units.
May 31 15:56:29 volumio systemd[1]: Listening on acpid.socket - ACPID Listen Socket.
May 31 15:56:29 volumio systemd[1]: Listening on avahi-daemon.socket - Avahi mDNS/DNS-SD Stack Activation Socket.
May 31 15:56:29 volumio systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket.
May 31 15:56:29 volumio systemd[1]: Reached target sockets.target - Socket Units.
May 31 15:56:29 volumio 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 31 15:56:29 volumio systemd[1]: Reached target basic.target - Basic System.
May 31 15:56:29 volumio systemd[1]: Started acpid.service - ACPI event daemon.
May 31 15:56:29 volumio 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 31 15:56:29 volumio systemd[1]: Starting alsa-restore.service - Save/Restore Sound Card State...
May 31 15:56:29 volumio systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack...
May 31 15:56:29 volumio acpid[833]: starting up with netlink and the input layer
May 31 15:56:29 volumio systemd[1]: Starting bluetooth.service - Bluetooth service...
May 31 15:56:29 volumio systemd[1]: Starting dbus.service - D-Bus System Message Bus...
May 31 15:56:29 volumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
May 31 15:56:29 volumio systemd[1]: Starting e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots...
May 31 15:56:29 volumio acpid[833]: 3 rules loaded
May 31 15:56:29 volumio acpid[833]: waiting for events: event logging is off
May 31 15:56:29 volumio 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 31 15:56:29 volumio systemd[1]: headless_wireless.service - Copy user wpa_supplicant.conf was skipped because of an unmet condition check (ConditionPathExists=/boot/wpa_supplicant.conf).
May 31 15:56:29 volumio systemd[1]: Starting dhcpcd.service - DHCP Client Daemon on all interfaces...
May 31 15:56:29 volumio systemd[1]: Started iptables.service - Volumio Iptables Module.
May 31 15:56:29 volumio systemd[1]: Starting systemd-logind.service - User Login Management...
May 31 15:56:29 volumio systemd[1]: Starting triggerhappy.service - triggerhappy global hotkey daemon...
May 31 15:56:29 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 15:56:29 volumio systemd[1]: Started volumio-remote-updater.service - Volumio Remote OTA Updater.
May 31 15:56:29 volumio systemd[1]: volumiossh.service - Volumio SSH enabler was skipped because of an unmet condition check (ConditionPathExistsGlob=/boot/ssh{,.txt}).
May 31 15:56:29 volumio systemd[1]: Starting wireless.service - Wireless Services...
May 31 15:56:29 volumio systemd[1]: Started rpcbind.service - RPC bind portmap service.
May 31 15:56:29 volumio systemd[1]: Reached target rpcbind.target - RPC Port Mapper.
May 31 15:56:29 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats.
May 31 15:56:29 volumio kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
May 31 15:56:29 volumio kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
May 31 15:56:29 volumio thd[845]: Unable to parse trigger line:
May 31 15:56:29 volumio thd[845]: Unable to parse trigger line:
May 31 15:56:29 volumio systemd[1]: Started triggerhappy.service - triggerhappy global hotkey daemon.
May 31 15:56:29 volumio systemd[1]: Starting th-udev-rebind.service - Late rebind of input devices to triggerhappy...
May 31 15:56:29 volumio sh[820]: command failed: No such device (-19)
May 31 15:56:29 volumio ifup[819]: command failed: No such device (-19)
May 31 15:56:29 volumio th-udev-rebind.sh[859]: Rebinding /dev/input/event0 to thd using --add...
May 31 15:56:29 volumio kernel: RPC: Registered named UNIX socket transport module.
May 31 15:56:29 volumio kernel: RPC: Registered udp transport module.
May 31 15:56:29 volumio kernel: RPC: Registered tcp transport module.
May 31 15:56:29 volumio kernel: RPC: Registered tcp-with-tls transport module.
May 31 15:56:29 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
May 31 15:56:29 volumio alsactl[863]: No state is present for card PCH
May 31 15:56:29 volumio alsactl[863]: Found hardware: "HDA-Intel" "Intel Alderlake-P HDMI" "HDA:8086281c,80860101,00100000" "0x8086" "0x7270"
May 31 15:56:29 volumio alsactl[863]: Hardware is initialized using a generic method
May 31 15:56:29 volumio alsactl[863]: No state is present for card PCH
May 31 15:56:29 volumio alsactl[863]: No state is present for card AUDIO
May 31 15:56:29 volumio alsactl[863]: Found hardware: "USB-Audio" "USB Mixer" "USB06cb:1595" "" ""
May 31 15:56:29 volumio alsactl[863]: Hardware is initialized using a generic method
May 31 15:56:29 volumio alsactl[863]: No state is present for card AUDIO
May 31 15:56:29 volumio systemd[1]: Mounted run-rpc_pipefs.mount - RPC Pipe File System.
May 31 15:56:29 volumio systemd[1]: Reached target rpc_pipefs.target.
May 31 15:56:29 volumio 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 31 15:56:29 volumio systemd[1]: Reached target nfs-client.target - NFS client services.
May 31 15:56:29 volumio systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
May 31 15:56:29 volumio th-udev-rebind.sh[859]: Rebinding /dev/input/event1 to thd using --add...
May 31 15:56:29 volumio th-udev-rebind.sh[859]: Rebinding /dev/input/event2 to thd using --add...
May 31 15:56:29 volumio th-udev-rebind.sh[859]: Rebinding /dev/input/event3 to thd using --add...
May 31 15:56:29 volumio th-udev-rebind.sh[859]: Rebinding /dev/input/event4 to thd using --add...
May 31 15:56:29 volumio th-udev-rebind.sh[859]: Rebinding /dev/input/event5 to thd using --add...
May 31 15:56:29 volumio th-udev-rebind.sh[859]: Rebinding /dev/input/event6 to thd using --add...
May 31 15:56:29 volumio th-udev-rebind.sh[859]: Rebinding /dev/input/event7 to thd using --add...
May 31 15:56:29 volumio th-udev-rebind.sh[859]: Rebinding /dev/input/event8 to thd using --add...
May 31 15:56:29 volumio systemd[1]: Finished alsa-restore.service - Save/Restore Sound Card State.
May 31 15:56:29 volumio systemd[1]: th-udev-rebind.service: Deactivated successfully.
May 31 15:56:29 volumio systemd[1]: Finished th-udev-rebind.service - Late rebind of input devices to triggerhappy.
May 31 15:56:29 volumio systemd[1]: Reached target sound.target - Sound Card.
May 31 15:56:29 volumio systemd[1]: e2scrub_reap.service: Deactivated successfully.
May 31 15:56:29 volumio systemd[1]: Finished e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots.
May 31 15:56:29 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully.
May 31 15:56:29 volumio avahi-daemon[835]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109).
May 31 15:56:29 volumio avahi-daemon[835]: Successfully dropped root privileges.
May 31 15:56:29 volumio avahi-daemon[835]: avahi-daemon 0.8 starting up.
May 31 15:56:29 volumio haveged[830]: haveged: command socket is listening at fd 3
May 31 15:56:29 volumio systemd-logind[844]: New seat seat0.
May 31 15:56:29 volumio sh[896]: dhcpcd-9.4.1 starting
May 31 15:56:29 volumio dhcpcd[896]: dhcpcd-9.4.1 starting
May 31 15:56:29 volumio dhcpcd[842]: dhcpcd-9.4.1 starting
May 31 15:56:29 volumio systemd-logind[844]: Watching system buttons on /dev/input/event2 (Power Button)
May 31 15:56:29 volumio systemd-logind[844]: Watching system buttons on /dev/input/event1 (Power Button)
May 31 15:56:29 volumio systemd-logind[844]: Watching system buttons on /dev/input/event0 (Sleep Button)
May 31 15:56:29 volumio dhcpcd[912]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09
May 31 15:56:29 volumio sh[896]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09
May 31 15:56:29 volumio ifup[909]: command failed: No such device (-19)
May 31 15:56:29 volumio dhcpcd[906]: dev: loaded udev
May 31 15:56:29 volumio dhcpcd[906]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09
May 31 15:56:29 volumio kernel: 8021q: 802.1Q VLAN Support v1.8
May 31 15:56:29 volumio bluetoothd[836]: Bluetooth daemon 5.83
May 31 15:56:29 volumio systemd[1]: Started dhcpcd.service - DHCP Client Daemon on all interfaces.
May 31 15:56:29 volumio volumio-remote-updater[848]: Volumio OTA Client: 1.7.0
May 31 15:56:29 volumio volumio-remote-updater[848]: Error: No active session
May 31 15:56:29 volumio volumio-remote-updater[848]: [2026-05-31 15:56:29] [info] asio async_connect error: asio.system:111 (Connection refused)
May 31 15:56:29 volumio volumio-remote-updater[848]: [2026-05-31 15:56:29] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected)
May 31 15:56:29 volumio volumio-remote-updater[848]: [2026-05-31 15:56:29] [error] handle_connect error: Connection refused
May 31 15:56:29 volumio upmpdcli[846]: Could not open config: /tmp/upmpdcli.conf
May 31 15:56:29 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
May 31 15:56:29 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
May 31 15:56:29 volumio systemd[1]: Started dbus.service - D-Bus System Message Bus.
May 31 15:56:29 volumio avahi-daemon[835]: Successfully called chroot().
May 31 15:56:29 volumio avahi-daemon[835]: Successfully dropped remaining capabilities.
May 31 15:56:29 volumio bluetoothd[836]: Starting SDP server
May 31 15:56:29 volumio bluetoothd[836]: Excluding (cli) sap
May 31 15:56:29 volumio bluetoothd[836]: Excluding (cli) scanparam
May 31 15:56:29 volumio bluetoothd[836]: Excluding (cli) midi
May 31 15:56:29 volumio bluetoothd[836]: Excluding (cli) battery
May 31 15:56:29 volumio avahi-daemon[835]: No service file found in /etc/avahi/services.
May 31 15:56:29 volumio dbus-daemon[838]: [system] Successfully activated service 'org.freedesktop.systemd1'
May 31 15:56:29 volumio avahi-daemon[835]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1.
May 31 15:56:29 volumio avahi-daemon[835]: New relevant interface lo.IPv4 for mDNS.
May 31 15:56:29 volumio avahi-daemon[835]: Network interface enumeration completed.
May 31 15:56:29 volumio avahi-daemon[835]: Registering new address record for 127.0.0.1 on lo.IPv4.
May 31 15:56:29 volumio systemd[1]: Started systemd-logind.service - User Login Management.
May 31 15:56:29 volumio systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack.
May 31 15:56:29 volumio systemd[1]: Started bluetooth.service - Bluetooth service.
May 31 15:56:29 volumio systemd[1]: Starting bluealsa.service - BlueALSA service...
May 31 15:56:29 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
May 31 15:56:29 volumio kernel: Bluetooth: BNEP filters: protocol multicast
May 31 15:56:29 volumio kernel: Bluetooth: BNEP socket layer initialized
May 31 15:56:29 volumio systemd[1]: iptables.service: Deactivated successfully.
May 31 15:56:29 volumio bluetoothd[836]: Bluetooth management interface 1.23 initialized
May 31 15:56:29 volumio dbus-daemon[838]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=0 pid=836 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap,b")
May 31 15:56:29 volumio systemd[1]: Starting systemd-hostnamed.service - Hostname Service...
May 31 15:56:29 volumio sh[896]: eth0: waiting for carrier
May 31 15:56:29 volumio dhcpcd[912]: eth0: waiting for carrier
May 31 15:56:29 volumio dhcpcd[906]: eth0: waiting for carrier
May 31 15:56:29 volumio haveged[830]: haveged: ver: 1.9.14; arch: x86; vend: GenuineIntel; build: (gcc 12.2.0 ITV); collect: 128K
May 31 15:56:29 volumio haveged[830]: haveged: cpu: (L4 VC); data: 32K (L4 V); inst: 64K (L4 V); idx: 39/40; sz: 53875/53875
May 31 15:56:29 volumio haveged[830]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99979
May 31 15:56:29 volumio haveged[830]: haveged: fills: 0, generated: 0
May 31 15:56:29 volumio dbus-daemon[838]: [system] Successfully activated service 'org.freedesktop.hostname1'
May 31 15:56:29 volumio systemd[1]: Started systemd-hostnamed.service - Hostname Service.
May 31 15:56:29 volumio systemd[1]: Finished networking.service - Raise network interfaces.
May 31 15:56:29 volumio systemd[1]: Reached target network.target - Network.
May 31 15:56:29 volumio systemd[1]: Reached target network-online.target - Network is Online.
May 31 15:56:29 volumio systemd[1]: Starting nmbd.service - Samba NMB Daemon...
May 31 15:56:29 volumio systemd[1]: Starting ntpsec.service - Network Time Service...
May 31 15:56:29 volumio systemd[1]: Starting rc-local.service - /etc/rc.local Compatibility...
May 31 15:56:29 volumio systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart...
May 31 15:56:29 volumio systemd[1]: Starting samba-ad-dc.service - Samba AD Daemon...
May 31 15:56:29 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
May 31 15:56:29 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
May 31 15:56:29 volumio sm-notify[995]: Version 2.6.2 starting
May 31 15:56:29 volumio systemd[1]: Starting ssh.service - OpenBSD Secure Shell server...
May 31 15:56:29 volumio systemd[1]: Started volumio-ipchange.service - Volumio IP Change Monitor.
May 31 15:56:29 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
May 31 15:56:29 volumio systemd[1]: Started rc-local.service - /etc/rc.local Compatibility.
May 31 15:56:29 volumio systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart.
May 31 15:56:29 volumio ntpd[1000]: INIT: ntpd ntpsec-1.2.2: Starting
May 31 15:56:29 volumio ntpd[1000]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec
May 31 15:56:29 volumio ntp-systemd-wrapper[1000]: 2026-05-31T15:56:29 ntpd[1000]: INIT: ntpd ntpsec-1.2.2: Starting
May 31 15:56:29 volumio ntp-systemd-wrapper[1000]: 2026-05-31T15:56:29 ntpd[1000]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec
May 31 15:56:29 volumio systemd[1]: Started ntpsec.service - Network Time Service.
May 31 15:56:29 volumio ntpd[1018]: INIT: precision = 0.085 usec (-23)
May 31 15:56:29 volumio welcome[1007]: Resolved ip:[0]
May 31 15:56:29 volumio ntpd[1018]: INIT: successfully locked into RAM
May 31 15:56:29 volumio ntpd[1018]: CONFIG: readconfig: parsing file: /etc/ntpsec/ntp.conf
May 31 15:56:29 volumio ntpd[1018]: CONFIG: restrict nopeer ignored
May 31 15:56:29 volumio ntpd[1018]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
May 31 15:56:29 volumio ntpd[1018]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2026-06-28T00:00Z last=2017-01-01T00:00Z ofs=37
May 31 15:56:29 volumio ntpd[1018]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): will expire in less than 28 days
May 31 15:56:29 volumio ntpd[1018]: INIT: Using SO_TIMESTAMPNS(ns)
May 31 15:56:29 volumio ntpd[1018]: IO: Listen and drop on 0 v6wildcard [::]:123
May 31 15:56:29 volumio ntpd[1018]: IO: Listen and drop on 1 v4wildcard 0.0.0.0:123
May 31 15:56:29 volumio ntpd[1018]: IO: Listen normally on 2 lo 127.0.0.1:123
May 31 15:56:29 volumio ntpd[1018]: IO: Listening on routing socket on fd #19 for interface updates
May 31 15:56:29 volumio ntpd[1018]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes
May 31 15:56:29 volumio ntpd[1018]: INIT: Built with OpenSSL 3.0.9 30 May 2023, 30000090
May 31 15:56:29 volumio ntpd[1018]: INIT: Running with OpenSSL 3.0.18 30 Sep 2025, 30000120
May 31 15:56:29 volumio ntpd[1018]: NTSc: Using system default root certificates.
May 31 15:56:30 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
May 31 15:56:30 volumio sshd[1031]: Server listening on 0.0.0.0 port 22.
May 31 15:56:30 volumio sshd[1031]: Server listening on :: port 22.
May 31 15:56:30 volumio systemd[1]: Started ssh.service - OpenBSD Secure Shell server.
May 31 15:56:30 volumio ntpd[1018]: statistics directory /var/log/ntpsec/ does not exist or is unwriteable, error No such file or directory
May 31 15:56:30 volumio bluealsa[951]: ../src/storage.c:90: Initializing persistent storage: /var/lib/bluealsa
May 31 15:56:30 volumio bluealsa[951]: main.c:663: Starting main dispatching loop
May 31 15:56:30 volumio bluealsa[951]: main.c:118: Acquired D-Bus service name: org.bluealsa
May 31 15:56:30 volumio bluealsa[951]: bluealsa-dbus.c:358: Registering BlueALSA D-Bus manager: /org/bluealsa
May 31 15:56:30 volumio systemd[1]: Started bluealsa.service - BlueALSA service.
May 31 15:56:30 volumio systemd[1]: Reached target bluetooth.target - Bluetooth Support.
May 31 15:56:30 volumio systemd[1]: Mounting mnt-music.mount - /mnt/music...
May 31 15:56:30 volumio systemd[1]: samba-ad-dc.service: Skipped due to 'exec-condition'.
May 31 15:56:30 volumio systemd[1]: Condition check resulted in samba-ad-dc.service - Samba AD Daemon being skipped.
May 31 15:56:30 volumio kernel: netfs: FS-Cache loaded
May 31 15:56:30 volumio kernel: Key type dns_resolver registered
May 31 15:56:30 volumio nmbd[1068]: [2026/05/31 15:56:30.566418, 0] ../../source3/nmbd/nmbd.c:901(main)
May 31 15:56:30 volumio nmbd[1068]: nmbd version 4.17.12-Debian started.
May 31 15:56:30 volumio nmbd[1068]: Copyright Andrew Tridgell and the Samba Team 1992-2022
May 31 15:56:30 volumio nmbd[1068]: [2026/05/31 15:56:30.571261, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns)
May 31 15:56:30 volumio nmbd[1068]: started asyncdns process 1078
May 31 15:56:30 volumio nmbd[1068]: [2026/05/31 15:56:30.571748, 0] ../../lib/util/become_daemon.c:150(daemon_status)
May 31 15:56:30 volumio nmbd[1068]: daemon_status: daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
May 31 15:56:30 volumio nmbd[1068]: [2026/05/31 15:56:30.571771, 0] ../../source3/nmbd/nmbd_subnetdb.c:252(create_subnets)
May 31 15:56:30 volumio nmbd[1068]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
May 31 15:56:30 volumio mount[1059]: mount error(101): Network is unreachable
May 31 15:56:30 volumio mount[1059]: Refer to the mount.cifs(8) manual page (e.g. man mount.cifs) and kernel log messages (dmesg)
May 31 15:56:30 volumio systemd[1]: mnt-music.mount: Mount process exited, code=exited, status=32/n/a
May 31 15:56:30 volumio systemd[1]: mnt-music.mount: Failed with result 'exit-code'.
May 31 15:56:30 volumio kernel: Key type cifs.spnego registered
May 31 15:56:30 volumio kernel: Key type cifs.idmap registered
May 31 15:56:30 volumio kernel: CIFS: enabling forceuid mount option implicitly because uid= option is specified
May 31 15:56:30 volumio kernel: CIFS: enabling forcegid mount option implicitly because gid= option is specified
May 31 15:56:30 volumio kernel: CIFS: Attempting to mount //192.168.1.100/data/media/music
May 31 15:56:30 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
May 31 15:56:30 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101
May 31 15:56:30 volumio systemd[1]: Failed to mount mnt-music.mount - /mnt/music.
May 31 15:56:30 volumio systemd[1]: Dependency failed for remote-fs.target - Remote File Systems.
May 31 15:56:30 volumio systemd[1]: remote-fs.target: Job remote-fs.target/start failed with result 'dependency'.
May 31 15:56:30 volumio wireless.js[849]: WIRELESS.JS - INFO: Single Network Mode enabled (default) - only one network device can be active at a time between ethernet and wireless
May 31 15:56:30 volumio wireless.js[849]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow
May 31 15:56:30 volumio systemd[1]: Starting ifplugd.service - LSB: Brings up/down network automatically...
May 31 15:56:30 volumio systemd[1]: Starting loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling...
May 31 15:56:30 volumio 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 31 15:56:30 volumio systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions...
May 31 15:56:30 volumio wireless.js[849]: WIRELESS.JS - INFO: ERROR: wlan0 does not exist, exiting...
May 31 15:56:30 volumio systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions.
May 31 15:56:30 volumio avahi-daemon[835]: Server startup complete. Host name is volumio.local. Local service cookie is 3783343436.
May 31 15:56:30 volumio systemd[1]: Starting plymouth-quit-wait.service - Hold until boot process finishes up...
May 31 15:56:30 volumio systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen...
May 31 15:56:30 volumio systemd[1]: wireless.service: Main process exited, code=exited, status=1/FAILURE
May 31 15:56:30 volumio systemd[1]: wireless.service: Killing process 1089 (sh) with signal SIGKILL.
May 31 15:56:30 volumio systemd[1]: wireless.service: Killing process 1098 (pkill) with signal SIGKILL.
May 31 15:56:30 volumio systemd[1]: wireless.service: Failed with result 'exit-code'.
May 31 15:56:30 volumio systemd[1]: Failed to start wireless.service - Wireless Services.
May 31 15:56:30 volumio systemd[1]: Started volumio.service - Volumio Backend Module.
May 31 15:56:30 volumio systemd[1]: Started screenshot.service - Process screenshots triggered by PrtSc-button.
May 31 15:56:30 volumio systemd[1]: Started soundcard-init.service - Intel SST and HDA soundcard init service.
May 31 15:56:30 volumio systemd[1]: Started volumio-kiosk.service - Start Volumio Kiosk.
May 31 15:56:30 volumio systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker.
May 31 15:56:30 volumio systemd[1]: Received SIGRTMIN+21 from PID 402 (plymouthd).
May 31 15:56:30 volumio systemd[1]: Received SIGRTMIN+21 from PID 402 (plymouthd).
May 31 15:56:30 volumio systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up.
May 31 15:56:30 volumio systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen.
May 31 15:56:30 volumio systemd[1]: Started getty@tty1.service - Getty on tty1.
May 31 15:56:30 volumio systemd[1]: Reached target getty.target - Login Prompts.
May 31 15:56:30 volumio ifplugd(eth0)[1149]: ifplugd 0.28 initializing.
May 31 15:56:30 volumio ifplugd(eth0)[1149]: Using interface eth0/00:F1:F7:A0:D0:76 with driver (version: 6.12.57-volumio)
May 31 15:56:30 volumio ifplugd(eth0)[1149]: Using detection mode: SIOCETHTOOL
May 31 15:56:30 volumio ifplugd(eth0)[1149]: Initialization complete, link beat not detected.
May 31 15:56:30 volumio volumio-cpu-tweak[1116]: Setting RT Priority for mpd
May 31 15:56:30 volumio volumio-cpu-tweak[1162]: pid 35's current scheduling policy: SCHED_OTHER
May 31 15:56:30 volumio volumio-cpu-tweak[1162]: pid 35's current scheduling priority: 0
May 31 15:56:30 volumio volumio-cpu-tweak[1116]: Setting MPD Affinity
May 31 15:56:30 volumio volumio-cpu-tweak[1171]: pid 3's current affinity mask: f
May 31 15:56:30 volumio volumio-cpu-tweak[1116]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
May 31 15:56:30 volumio systemd[1]: volumio_cpu_tweak.service: Deactivated successfully.
May 31 15:56:30 volumio loadcpufreq[1090]: Loading cpufreq kernel modules...done (acpi-cpufreq).
May 31 15:56:30 volumio systemd[1]: Started loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling.
May 31 15:56:30 volumio systemd[1]: Starting cpufrequtils.service - LSB: set CPUFreq kernel parameters...
May 31 15:56:30 volumio kernel: Bluetooth: hci0: Waiting for firmware download to complete
May 31 15:56:30 volumio kernel: Bluetooth: hci0: Firmware loaded in 1724605 usecs
May 31 15:56:30 volumio kernel: Bluetooth: hci0: Waiting for device to boot
May 31 15:56:30 volumio soundcard-init.sh[1229]: Card 0 Chip Intel Alderlake-P HDMI Name HDA Intel PCH
May 31 15:56:30 volumio soundcard-init.sh[1248]: amixer: Unable to find simple control 'Master',0
May 31 15:56:30 volumio cpufrequtils[1216]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done.
May 31 15:56:30 volumio systemd[1]: Started cpufrequtils.service - LSB: set CPUFreq kernel parameters.
May 31 15:56:30 volumio kernel: Bluetooth: hci0: Device booted in 16605 usecs
May 31 15:56:30 volumio ifplugd[1087]: Network Interface Plugging Daemon...start eth0...done.
May 31 15:56:30 volumio systemd[1]: Started ifplugd.service - LSB: Brings up/down network automatically.
May 31 15:56:30 volumio soundcard-init.sh[1229]: Card 5 Chip USB Mixer Name CX31993 384Khz HIFI AUDIO
May 31 15:56:30 volumio systemd[1]: soundcard-init.service: Deactivated successfully.
May 31 15:56:30 volumio kernel: Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-0040-2120.ddc
May 31 15:56:30 volumio kernel: Bluetooth: hci0: Applying Intel DDC parameters completed
May 31 15:56:30 volumio kernel: Bluetooth: hci0: Firmware timestamp 2024.5 buildtype 1 build 151
May 31 15:56:30 volumio kernel: Bluetooth: hci0: Firmware SHA1: 0x00000000
May 31 15:56:30 volumio kernel: Bluetooth: hci0: Fseq status: Success (0x00)
May 31 15:56:30 volumio kernel: Bluetooth: hci0: Fseq executed: 00.00.02.36
May 31 15:56:30 volumio kernel: Bluetooth: hci0: Fseq BT Top: 00.00.02.36
May 31 15:56:30 volumio startx[1222]: X.Org X Server 1.21.1.7
May 31 15:56:30 volumio startx[1222]: X Protocol Version 11, Revision 0
May 31 15:56:30 volumio startx[1222]: Current Operating System: Linux volumio 6.12.57-volumio #2 SMP PREEMPT_DYNAMIC Thu Nov 13 17:08:37 CET 2025 x86_64
May 31 15:56:30 volumio startx[1222]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=9c5aafd3-d1f5-42ac-80ba-2722edd0150c bootpart=UUID=7C3E-4B23 datapart=UUID=57e315c1-b339-4c2e-8155-8126725033f1 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 31 15:56:30 volumio startx[1222]: xorg-server 2:21.1.7-3+deb12u11 (https://www.debian.org/support)
May 31 15:56:30 volumio startx[1222]: Current version of pixman: 0.42.2
May 31 15:56:30 volumio startx[1222]: Before reporting problems, check http://wiki.x.org
May 31 15:56:30 volumio startx[1222]: to make sure that you have the latest version.
May 31 15:56:30 volumio startx[1222]: Markers: (--) probed, (**) from config file, (==) default setting,
May 31 15:56:30 volumio startx[1222]: (++) from command line, (!!) notice, (II) informational,
May 31 15:56:30 volumio startx[1222]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
May 31 15:56:30 volumio startx[1222]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun May 31 15:56:30 2026
May 31 15:56:30 volumio startx[1222]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
May 31 15:56:30 volumio bluetoothd[836]: Battery Provider Manager created
May 31 15:56:30 volumio kernel: Bluetooth: MGMT ver 1.23
May 31 15:56:30 volumio kernel: NET: Registered PF_ALG protocol family
May 31 15:56:30 volumio bluetoothd[836]: profiles/audio/bap.c:bap_adapter_probe() BAP requires ISO Socket which is not enabled
May 31 15:56:30 volumio bluetoothd[836]: bap: Operation not supported (95)
May 31 15:56:30 volumio bluetoothd[836]: Adv Monitor Manager created with supported features:0x00000000, enabled features:0x00000000, max number of supported monitors:32, max number of supported patterns:16
May 31 15:56:30 volumio bluealsa[951]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0, ...)
May 31 15:56:30 volumio bluealsa[951]: bluez.c:153: Registering media application: /org/bluez/hci0
May 31 15:56:30 volumio bluealsa[951]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/source/1
May 31 15:56:30 volumio bluealsa[951]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/source/2
May 31 15:56:30 volumio bluealsa[951]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/sink/1
May 31 15:56:30 volumio bluealsa[951]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/sink/2
May 31 15:56:30 volumio bluealsa[951]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0, ...)
May 31 15:56:30 volumio bluetoothd[836]: Endpoint registered: sender=:1.5 path=/org/bluez/hci0/A2DP/SBC/source/1
May 31 15:56:30 volumio bluetoothd[836]: Endpoint registered: sender=:1.5 path=/org/bluez/hci0/A2DP/SBC/sink/2
May 31 15:56:30 volumio bluetoothd[836]: Endpoint registered: sender=:1.5 path=/org/bluez/hci0/A2DP/SBC/source/2
May 31 15:56:30 volumio bluetoothd[836]: Endpoint registered: sender=:1.5 path=/org/bluez/hci0/A2DP/SBC/sink/1
May 31 15:56:31 volumio ntpd[1018]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101
May 31 15:56:31 volumio ntpd[1018]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101
May 31 15:56:31 volumio ntpd[1018]: DNS: dns_check: DNS error: -11, System error
May 31 15:56:31 volumio ntpd[1018]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12
May 31 15:56:31 volumio volumio[1106]: info: -------------------------------------------
May 31 15:56:31 volumio volumio[1106]: info: ----- Volumio3 ----
May 31 15:56:31 volumio volumio[1106]: info: -------------------------------------------
May 31 15:56:31 volumio volumio[1106]: info: ----- System startup ----
May 31 15:56:31 volumio volumio[1106]: info: -------------------------------------------
May 31 15:56:31 volumio volumio[1106]: info: MYVOLUMIO Environment detected
May 31 15:56:31 volumio volumio[1106]: info: Plugin folders cleanup
May 31 15:56:31 volumio volumio[1106]: info: Scanning into folder /volumio/app/plugins/
May 31 15:56:31 volumio volumio[1106]: info: Scanning category audio_interface
May 31 15:56:31 volumio volumio[1106]: info: Scanning category miscellanea
May 31 15:56:31 volumio volumio[1106]: info: Scanning category music_service
May 31 15:56:31 volumio volumio[1106]: info: Scanning category plugins.json
May 31 15:56:31 volumio volumio[1106]: info: Scanning category system_controller
May 31 15:56:31 volumio volumio[1106]: info: Scanning category user_interface
May 31 15:56:31 volumio volumio[1106]: info: Scanning into folder /data/plugins/
May 31 15:56:31 volumio volumio[1106]: info: Scanning category music_service
May 31 15:56:31 volumio volumio[1106]: info: Plugin folders cleanup completed
May 31 15:56:31 volumio volumio[1106]: info: -------------------------------------------
May 31 15:56:31 volumio volumio[1106]: info: ----- Core plugins startup ----
May 31 15:56:31 volumio volumio[1106]: info: -------------------------------------------
May 31 15:56:31 volumio volumio[1106]: info: Loading plugins from folder /volumio/app/plugins/
May 31 15:56:31 volumio volumio[1106]: info: Adding plugin upnp to MyMusic Plugins
May 31 15:56:31 volumio volumio[1106]: info: Adding plugin airplay_emulation to MyMusic Plugins
May 31 15:56:31 volumio volumio[1106]: info: Adding plugin upnp_browser to MyMusic Plugins
May 31 15:56:31 volumio volumio[1106]: info: Loading plugins from folder /data/plugins/
May 31 15:56:31 volumio volumio[1106]: info: Loading plugin "system"...
May 31 15:56:31 volumio volumio[1106]: info: Loading plugin "appearance"...
May 31 15:56:32 volumio ntpd[1018]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101
May 31 15:56:32 volumio ntpd[1018]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101
May 31 15:56:32 volumio ntpd[1018]: DNS: dns_check: DNS error: -11, System error
May 31 15:56:32 volumio ntpd[1018]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12
May 31 15:56:32 volumio volumio[1106]: info: Loading plugin "network"...
May 31 15:56:32 volumio volumio[1106]: info: Refreshing Cached IP Addresses
May 31 15:56:32 volumio volumio[1106]: info: Loading plugin "services"...
May 31 15:56:32 volumio volumio[1106]: info: Loading plugin "volumio5onboarding"...
May 31 15:56:32 volumio volumio[1106]: info: Loading plugin "alsa_controller"...
May 31 15:56:32 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 31 15:56:32 volumio volumio[1106]: info: Loading plugin "wizard"...
May 31 15:56:32 volumio sudo[1393]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 31 15:56:32 volumio sudo[1384]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 31 15:56:32 volumio sudo[1386]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 31 15:56:32 volumio sudo[1386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:32 volumio sudo[1393]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:32 volumio volumio[1106]: info: Loading plugin "networkfs"...
May 31 15:56:32 volumio sudo[1384]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:32 volumio sudo[1384]: pam_unix(sudo:session): session closed for user root
May 31 15:56:32 volumio sudo[1386]: pam_unix(sudo:session): session closed for user root
May 31 15:56:32 volumio sudo[1393]: pam_unix(sudo:session): session closed for user root
May 31 15:56:32 volumio volumio[1106]: info: Starting Udev Watcher for removable devices
May 31 15:56:32 volumio volumio[1106]: info: Ignoring mount for partition: boot
May 31 15:56:32 volumio volumio[1106]: info: Ignoring mount for partition: volumio
May 31 15:56:32 volumio volumio[1106]: info: Ignoring mount for partition: volumio_data
May 31 15:56:32 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 31 15:56:32 volumio volumio[1106]: info: Loading plugin "volumio_command_line_client"...
May 31 15:56:32 volumio volumio[1106]: info: Loading plugin "upnp"...
May 31 15:56:32 volumio volumio[1106]: info: [1780217792720] Starting Upmpd Daemon
May 31 15:56:32 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 31 15:56:32 volumio volumio[1106]: info: Loading plugin "my_music"...
May 31 15:56:32 volumio volumio[1106]: info: Loading plugin "mpd"...
May 31 15:56:32 volumio dhcpcd[912]: eth0: carrier acquired
May 31 15:56:32 volumio sh[896]: eth0: carrier acquired
May 31 15:56:32 volumio dhcpcd[906]: eth0: carrier acquired
May 31 15:56:32 volumio dhcpcd[912]: eth0: IAID f7:a0:d0:76
May 31 15:56:32 volumio sh[896]: eth0: IAID f7:a0:d0:76
May 31 15:56:32 volumio dhcpcd[906]: eth0: IAID f7:a0:d0:76
May 31 15:56:32 volumio dhcpcd[906]: eth0: adding address fe80::ff89:b56a:ce34:f481
May 31 15:56:32 volumio sh[896]: eth0: adding address fe80::ff89:b56a:ce34:f481
May 31 15:56:32 volumio dhcpcd[912]: eth0: adding address fe80::ff89:b56a:ce34:f481
May 31 15:56:32 volumio dhcpcd[906]: ipv6_addaddr1: Permission denied
May 31 15:56:32 volumio dhcpcd[912]: ipv6_addaddr1: Permission denied
May 31 15:56:32 volumio sh[896]: ipv6_addaddr1: Permission denied
May 31 15:56:32 volumio kernel: igc 0000:01:00.0 eth0: NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX
May 31 15:56:32 volumio volumio[1106]: info: Loading plugin "upnp_browser"...
May 31 15:56:33 volumio ntpd[1018]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101
May 31 15:56:33 volumio ntpd[1018]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101
May 31 15:56:33 volumio ntpd[1018]: DNS: dns_check: DNS error: -11, System error
May 31 15:56:33 volumio ntpd[1018]: DNS: dns_take_status: 2.debian.pool.ntp.org=>error, 12
May 31 15:56:33 volumio volumio[1106]: info: Starting UPNP Browser
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "alarm-clock"...
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "airplay_emulation"...
May 31 15:56:33 volumio volumio[1106]: info: Starting Shairport Sync
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "last_100"...
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "webradio"...
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "i2s_dacs"...
May 31 15:56:33 volumio volumio[1106]: info: I2S DAC not set, start Auto-detection
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "volumiodiscovery"...
May 31 15:56:33 volumio volumio[1106]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 31 15:56:33 volumio volumio[1106]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 31 15:56:33 volumio volumio[1106]: *** WARNING *** For more information see
May 31 15:56:33 volumio volumio[1106]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 31 15:56:33 volumio volumio[1106]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 31 15:56:33 volumio volumio[1106]: *** WARNING *** For more information see
May 31 15:56:33 volumio node[1106]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 31 15:56:33 volumio node[1106]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 31 15:56:33 volumio node[1106]: *** WARNING *** For more information see
May 31 15:56:33 volumio node[1106]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 31 15:56:33 volumio node[1106]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 31 15:56:33 volumio node[1106]: *** WARNING *** For more information see
May 31 15:56:33 volumio volumio[1106]: info: Applying required configuration parameters for plugin volumiodiscovery
May 31 15:56:33 volumio volumio[1106]: info: Discovery: Started advertising with name: Volumio
May 31 15:56:33 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "spop"...
May 31 15:56:33 volumio dhcpcd[912]: eth0: soliciting a DHCP lease
May 31 15:56:33 volumio sh[896]: eth0: soliciting a DHCP lease
May 31 15:56:33 volumio dhcpcd[906]: eth0: soliciting an IPv6 router
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "outputs"...
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "albumart"...
May 31 15:56:33 volumio volumio[1106]: info: Plugin example_plugin is not enabled
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "inputs"...
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "updater_comm"...
May 31 15:56:33 volumio volumio[1473]: Forking 3 albumart workers
May 31 15:56:33 volumio volumio[1106]: info: Plugin mpdemulation is not enabled
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "rest_api"...
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "websocket"...
May 31 15:56:33 volumio volumio[1106]: info: Starting Socket.io Server version 1.7.4
May 31 15:56:33 volumio volumio[1106]: info: Loading plugin "minidlna"...
May 31 15:56:33 volumio ifplugd(eth0)[1149]: Link beat detected.
May 31 15:56:33 volumio dhcpcd[912]: eth0: soliciting an IPv6 router
May 31 15:56:33 volumio sh[896]: eth0: soliciting an IPv6 router
May 31 15:56:33 volumio ifplugd(eth0)[1149]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
May 31 15:56:33 volumio volumio[1106]: info: Applying required configuration parameters for plugin minidlna
May 31 15:56:33 volumio ifplugd(eth0)[1149]: client: ifup: waiting for lock on /run/network/ifstate.eth0
May 31 15:56:33 volumio volumio[1493]: Starting albumart workers
May 31 15:56:33 volumio volumio[1494]: Starting albumart workers
May 31 15:56:33 volumio systemd[1]: systemd-rfkill.service: Deactivated successfully.
May 31 15:56:34 volumio volumio[1492]: Starting albumart workers
May 31 15:56:34 volumio ntpd[1018]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101
May 31 15:56:34 volumio ntpd[1018]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101
May 31 15:56:34 volumio ntpd[1018]: DNS: dns_check: DNS error: -11, System error
May 31 15:56:34 volumio ntpd[1018]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12
May 31 15:56:34 volumio volumio[1106]: info: Loading plugin "volusonic"...
May 31 15:56:34 volumio volumio[1106]: info: Applying required configuration parameters for plugin volusonic
May 31 15:56:34 volumio volumio[1106]: info: Loading i18n strings for locale en
May 31 15:56:34 volumio volumio[1106]: Updating browse sources language
May 31 15:56:34 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 31 15:56:34 volumio volumio-remote-updater[848]: [2026-05-31 15:56:34] [connect] Successful connection
May 31 15:56:34 volumio dhcpcd[906]: eth0: soliciting a DHCP lease
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::initPlayerControls
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 31 15:56:35 volumio volumio[1106]: Express server listening on port 3000
May 31 15:56:35 volumio volumio[1106]: [Metrics] WebUI: 3s 935.61ms
May 31 15:56:35 volumio volumio[1106]: info: Setting Device type: x86
May 31 15:56:35 volumio volumio[1106]: info: CoreStateMachine::resetVolumioState
May 31 15:56:35 volumio volumio[1106]: info: CoreStateMachine::getcurrentVolume
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::volumioRetrievevolume
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 31 15:56:35 volumio volumio[1106]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
May 31 15:56:35 volumio volumio[1106]: info: Completed loading Core Plugins
May 31 15:56:35 volumio volumio[1106]: info: Preparing to generate the ALSA configuration file
May 31 15:56:35 volumio volumio[1106]: info: Volumio Network Manager: Network status updated: 0
May 31 15:56:35 volumio volumio[1106]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
May 31 15:56:35 volumio volumio[1106]: wlan0 Interface doesn't support scanning.
May 31 15:56:35 volumio volumio[1106]: info: Cannot use regular scanning, forcing with ap-force
May 31 15:56:35 volumio sudo[1660]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
May 31 15:56:35 volumio sudo[1660]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:35 volumio sudo[1660]: pam_unix(sudo:session): session closed for user root
May 31 15:56:35 volumio volumio[1106]: command failed: No such device (-19)
May 31 15:56:35 volumio volumio[1106]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
May 31 15:56:35 volumio volumio[1106]: command failed: No such device (-19)
May 31 15:56:35 volumio volumio[1106]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
May 31 15:56:35 volumio volumio[1106]: info: Reloading queue from file
May 31 15:56:35 volumio volumio[1106]: info: Asound.conf file unchanged, so no further update is needed
May 31 15:56:35 volumio volumio[1106]: info: Output device has changed, restarting MPD
May 31 15:56:35 volumio volumio[1106]: info: Output device has changed, restarting Shairport Sync
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 31 15:56:35 volumio sudo[1672]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 31 15:56:35 volumio sudo[1672]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:35 volumio sudo[1672]: pam_unix(sudo:session): session closed for user root
May 31 15:56:35 volumio sudo[1674]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 31 15:56:35 volumio sudo[1674]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:35 volumio volumio[1106]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 31 15:56:35 volumio volumio[1106]: info: ___________ START PLUGINS ___________
May 31 15:56:35 volumio volumio[1106]: info: ControllerMpd::onStart: Initializing MPD
May 31 15:56:35 volumio volumio[1106]: info: Creating MPD Configuration file
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 31 15:56:35 volumio sudo[1684]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
May 31 15:56:35 volumio sudo[1684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 31 15:56:35 volumio volumio[1106]: info: [1780217795438] CoreMusicLibrary::Adding element Media Servers
May 31 15:56:35 volumio sudo[1685]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 31 15:56:35 volumio sudo[1685]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 31 15:56:35 volumio volumio[1106]: info: UPNP Browser: Client initialized successfully
May 31 15:56:35 volumio sudo[1685]: pam_unix(sudo:session): session closed for user root
May 31 15:56:35 volumio sudo[1687]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 31 15:56:35 volumio sudo[1687]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 31 15:56:35 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
May 31 15:56:35 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
May 31 15:56:35 volumio volumio[1106]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 31 15:56:35 volumio systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server.
May 31 15:56:35 volumio systemd[1]: mpd.service: Deactivated successfully.
May 31 15:56:35 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
May 31 15:56:35 volumio volumio[1106]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 31 15:56:35 volumio systemd[1]: mpd.socket: Deactivated successfully.
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 31 15:56:35 volumio sudo[1684]: pam_unix(sudo:session): session closed for user root
May 31 15:56:35 volumio volumio[1106]: info: [1780217795478] CoreMusicLibrary::Adding element Last_100
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 31 15:56:35 volumio volumio[1106]: info: [1780217795479] CoreMusicLibrary::Adding element Webradio
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 31 15:56:35 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
May 31 15:56:35 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 31 15:56:35 volumio volumio[1106]: info: Initializing BBC Radios
May 31 15:56:35 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
May 31 15:56:35 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: Creating Spotify config file
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio sudo[1704]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 31 15:56:35 volumio sudo[1704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
May 31 15:56:35 volumio volumio[1106]: info: Loading i18n strings for locale en
May 31 15:56:35 volumio sudo[1716]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
May 31 15:56:35 volumio sudo[1704]: pam_unix(sudo:session): session closed for user root
May 31 15:56:35 volumio volumio[1106]: info: Loading i18n strings for locale en
May 31 15:56:35 volumio volumio[1106]: Updating browse sources language
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 31 15:56:35 volumio volumio[1106]: info: [1780217795563] CoreMusicLibrary::Adding element Volusonic
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 31 15:56:35 volumio volumio[1106]: Cannot find translation for source Volusonic
May 31 15:56:35 volumio volumio[1106]: info: Volumio Calling Home
May 31 15:56:35 volumio volumio[1106]: info: CoreStateMachine::setRepeat null single undefined
May 31 15:56:35 volumio volumio[1106]: info: CoreStateMachine::pushState
May 31 15:56:35 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::volumioPushState
May 31 15:56:35 volumio volumio[1106]: info: CoreStateMachine::setRandom true
May 31 15:56:35 volumio volumio[1106]: info: CoreStateMachine::pushState
May 31 15:56:35 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::volumioPushState
May 31 15:56:35 volumio bash[999]: setdatetime-helper: all HTTPS Date fallbacks failed
May 31 15:56:35 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
May 31 15:56:35 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
May 31 15:56:35 volumio volumio[1106]: info: VolumeController:: Volume=43 Mute =false
May 31 15:56:35 volumio volumio[1106]: info: CoreStateMachine::pushState
May 31 15:56:35 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::volumioPushState
May 31 15:56:35 volumio volumio[1106]: info: CoreStateMachine::updateTrackBlock
May 31 15:56:35 volumio volumio[1106]: info: CorePlayQueue::getTrackBlock
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::volumioRetrievevolume
May 31 15:56:35 volumio volumio[1106]: Unhandled rejection Error: No sockets available, cannot start.
May 31 15:56:35 volumio volumio[1106]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11)
May 31 15:56:35 volumio volumio[1106]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10)
May 31 15:56:35 volumio volumio[1106]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10
May 31 15:56:35 volumio volumio[1106]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9)
May 31 15:56:35 volumio volumio[1106]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18)
May 31 15:56:35 volumio volumio[1106]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10)
May 31 15:56:35 volumio volumio[1106]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10)
May 31 15:56:35 volumio volumio[1106]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17)
May 31 15:56:35 volumio volumio[1106]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14)
May 31 15:56:35 volumio volumio[1106]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24)
May 31 15:56:35 volumio volumio[1106]: at HashMap. (/volumio/app/pluginmanager.js:496:31)
May 31 15:56:35 volumio volumio[1106]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
May 31 15:56:35 volumio volumio[1106]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
May 31 15:56:35 volumio volumio[1106]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20)
May 31 15:56:35 volumio volumio[1106]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29)
May 31 15:56:35 volumio volumio[1106]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
May 31 15:56:35 volumio volumio-remote-updater[848]: [2026-05-31 15:56:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1780217794 101
May 31 15:56:35 volumio volumio[1106]: 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: 1
May 31 15:56:35 volumio volumio[1106]: info: MPD Permissions set
May 31 15:56:35 volumio volumio[1106]: info: MPD Permissions set
May 31 15:56:35 volumio volumio[1106]: info: Spotify config file written
May 31 15:56:35 volumio volumio[1106]: info: Discovery: adding 71c46669-deb2-4143-aedb-b4d027494509
May 31 15:56:35 volumio volumio[1106]: info: Discovery: Found device Volumio
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:35 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:35 volumio volumio[1106]: 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 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio5-onboarding[1700]: time=2026-05-31T15:56:35.859+07:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z
May 31 15:56:35 volumio sudo[1738]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
May 31 15:56:35 volumio sudo[1738]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 31 15:56:35 volumio 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 31 15:56:35 volumio 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 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 31 15:56:35 volumio go-librespot[1749]: go-librespot daemon starting...
May 31 15:56:35 volumio sudo[1738]: pam_unix(sudo:session): session closed for user root
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 31 15:56:35 volumio volumio[1106]: info: No need to fix Spotify hosts
May 31 15:56:35 volumio volumio[1106]: info: VolumeController:: Volume=43 Mute =false
May 31 15:56:35 volumio volumio[1106]: info: CoreStateMachine::pushState
May 31 15:56:35 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:35 volumio volumio[1106]: info: CoreCommandRouter::volumioPushState
May 31 15:56:35 volumio volumio[1106]: info: Starting Shairport Sync
May 31 15:56:35 volumio volumio[1106]: info: Starting Shairport Sync
May 31 15:56:35 volumio volumio[1106]: info: Starting Shairport Sync
May 31 15:56:35 volumio go-librespot[1756]: time="2026-05-31T15:56:35+07:00" level=info msg="running go-librespot 0.7.1"
May 31 15:56:35 volumio go-librespot[1756]: time="2026-05-31T15:56:35+07:00" level=debug msg="app state loaded"
May 31 15:56:35 volumio go-librespot[1756]: time="2026-05-31T15:56:35+07:00" level=debug msg="stored credentials not found"
May 31 15:56:36 volumio sudo[1768]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 31 15:56:36 volumio sudo[1766]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 31 15:56:36 volumio sudo[1770]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 31 15:56:36 volumio sudo[1770]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:36 volumio sudo[1768]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:36 volumio go-librespot[1756]: time="2026-05-31T15:56:36+07:00" level=info msg="api server listening on 127.0.0.1:9879"
May 31 15:56:36 volumio volumio[1106]: 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: 3
May 31 15:56:36 volumio go-librespot[1756]: time="2026-05-31T15:56:36+07:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy"
May 31 15:56:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
May 31 15:56:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
May 31 15:56:36 volumio sudo[1766]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:36 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
May 31 15:56:36 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
May 31 15:56:36 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
May 31 15:56:36 volumio systemd[1]: shairport-sync.service: Consumed 1.638s CPU time.
May 31 15:56:36 volumio volumio[1106]: 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: 3
May 31 15:56:36 volumio volumio[1106]: info: Received Get System Info
May 31 15:56:36 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 31 15:56:36 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 31 15:56:36 volumio volumio[1106]: info: Discovery: Getting this device information
May 31 15:56:36 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:36 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:36 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 31 15:56:36 volumio volumio5-onboarding[1700]: time=2026-05-31T15:56:36.078+07:00 level=INFO msg="system info for 02ba6f71eeb7ca4c382387f2dfd3fdff" deviceName=Volumio deviceVariant=volumio deviceModel= softwareVersion=4.119
May 31 15:56:36 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
May 31 15:56:36 volumio sudo[1768]: pam_unix(sudo:session): session closed for user root
May 31 15:56:36 volumio sudo[1766]: pam_unix(sudo:session): session closed for user root
May 31 15:56:36 volumio volumio5-onboarding[1700]: time=2026-05-31T15:56:36.087+07:00 level=INFO msg="bootstrapping state" hasInternet=false
May 31 15:56:36 volumio sudo[1770]: pam_unix(sudo:session): session closed for user root
May 31 15:56:36 volumio volumio[1106]: info: Received Get System Info
May 31 15:56:36 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 31 15:56:36 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 31 15:56:36 volumio volumio[1106]: info: Discovery: Getting this device information
May 31 15:56:36 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:36 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:36 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 31 15:56:36 volumio volumio[1106]: info: Shairport-Sync Started
May 31 15:56:36 volumio volumio[1106]: Error adding Membership: Error: addMembership EINVAL
May 31 15:56:36 volumio volumio[1106]: info: Shairport-Sync Started
May 31 15:56:36 volumio volumio[1106]: info: Shairport-Sync Started
May 31 15:56:36 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 31 15:56:36 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 31 15:56:36 volumio volumio5-onboarding[1700]: time=2026-05-31T15:56:36.133+07:00 level=INFO msg="enabling local network discovery"
May 31 15:56:36 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:36 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:36 volumio volumio5-onboarding[1700]: time=2026-05-31T15:56:36.145+07:00 level=INFO msg="enabling BLE discovery"
May 31 15:56:36 volumio volumio[1106]: info: minidlna: Found miniDLNA version 1.3.0
May 31 15:56:36 volumio volumio[1106]: info: minidlna: Starting minidlna.service
May 31 15:56:36 volumio sudo[1799]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service
May 31 15:56:36 volumio sudo[1799]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:36 volumio systemd[1]: Started minidlna.service - MiniDLNA lightweight DLNA/UPnP-AV server.
May 31 15:56:36 volumio sudo[1799]: pam_unix(sudo:session): session closed for user root
May 31 15:56:36 volumio dhcpcd[912]: eth0: offered 192.168.1.249 from 192.168.1.1
May 31 15:56:36 volumio sh[896]: eth0: offered 192.168.1.249 from 192.168.1.1
May 31 15:56:36 volumio sh[896]: eth0: probing address 192.168.1.249/24
May 31 15:56:36 volumio dhcpcd[906]: eth0: offered 192.168.1.249 from 192.168.1.1
May 31 15:56:36 volumio dhcpcd[912]: eth0: probing address 192.168.1.249/24
May 31 15:56:36 volumio dhcpcd[906]: eth0: probing address 192.168.1.249/24
May 31 15:56:36 volumio volumio[1106]: info: minidlna: systemctl start minidlna.service succeeded.
May 31 15:56:36 volumio mpd[1717]: 2026-05-31T15:56:36 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 31 15:56:36 volumio systemd[1]: Started mpd.service - Music Player Daemon.
May 31 15:56:36 volumio sudo[1674]: pam_unix(sudo:session): session closed for user root
May 31 15:56:36 volumio sudo[1687]: pam_unix(sudo:session): session closed for user root
May 31 15:56:37 volumio volumio[1106]: info: Completed starting Core Plugins
May 31 15:56:37 volumio volumio[1106]: info: -------------------------------------------
May 31 15:56:37 volumio volumio[1106]: info: ----- MyVolumio plugins startup ----
May 31 15:56:37 volumio volumio[1106]: info: -------------------------------------------
May 31 15:56:37 volumio volumio[1106]: info: [MyVolumio PluginManager] Fetching plans data....
May 31 15:56:37 volumio volumio[1106]: error: MPD error: The expression evaluated to a falsy value:
May 31 15:56:37 volumio volumio[1106]: assert.ok(self.idling)
May 31 15:56:37 volumio volumio[1106]: error: The expression evaluated to a falsy value:
May 31 15:56:37 volumio volumio[1106]: assert.ok(self.idling)
May 31 15:56:37 volumio volumio[1106]: info: MPD running with PID1717
May 31 15:56:37 volumio volumio[1106]: ,establishing connection
May 31 15:56:37 volumio volumio[1106]: error: updateQueue error: null
May 31 15:56:37 volumio volumio[1106]: error: updateQueue error: null
May 31 15:56:37 volumio volumio5-onboarding[1700]: time=2026-05-31T15:56:37.125+07:00 level=INFO msg="service successfully established" component=discovery/localnet
May 31 15:56:37 volumio volumio[1106]: 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 31 15:56:37 volumio volumio[1106]: 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: 5
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::volumioGetVisibleSources
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:38 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::volumioGetQueue
May 31 15:56:38 volumio volumio[1106]: info: CoreStateMachine::getQueue
May 31 15:56:38 volumio volumio[1106]: info: CorePlayQueue::getQueue
May 31 15:56:38 volumio volumio[1106]: info: Listing playlists
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 31 15:56:38 volumio volumio[1106]: info: Received Get System Info
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 31 15:56:38 volumio volumio[1106]: info: Discovery: Getting this device information
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:38 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:38 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 31 15:56:38 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 31 15:56:38 volumio volumio[1106]: info: go-librespot daemon successfully initialized
May 31 15:56:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1.
May 31 15:56:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
May 31 15:56:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
May 31 15:56:39 volumio go-librespot[1817]: go-librespot daemon starting...
May 31 15:56:39 volumio go-librespot[1818]: time="2026-05-31T15:56:39+07:00" level=info msg="running go-librespot 0.7.1"
May 31 15:56:39 volumio go-librespot[1818]: time="2026-05-31T15:56:39+07:00" level=debug msg="app state loaded"
May 31 15:56:39 volumio go-librespot[1818]: time="2026-05-31T15:56:39+07:00" level=debug msg="stored credentials not found"
May 31 15:56:39 volumio go-librespot[1818]: time="2026-05-31T15:56:39+07:00" level=info msg="api server listening on 127.0.0.1:9879"
May 31 15:56:39 volumio go-librespot[1818]: time="2026-05-31T15:56:39+07:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy"
May 31 15:56:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
May 31 15:56:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
May 31 15:56:39 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 31 15:56:39 volumio volumio[1106]: info: Received Get System Info
May 31 15:56:39 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 31 15:56:39 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 31 15:56:39 volumio volumio[1106]: info: Discovery: Getting this device information
May 31 15:56:39 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:39 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:39 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 31 15:56:40 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 31 15:56:41 volumio dhcpcd[912]: eth0: leased 192.168.1.249 for 43200 seconds
May 31 15:56:41 volumio sh[896]: eth0: leased 192.168.1.249 for 43200 seconds
May 31 15:56:41 volumio sh[896]: eth0: adding route to 192.168.1.0/24
May 31 15:56:41 volumio avahi-daemon[835]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.249.
May 31 15:56:41 volumio sh[896]: eth0: adding default route via 192.168.1.1
May 31 15:56:41 volumio avahi-daemon[835]: New relevant interface eth0.IPv4 for mDNS.
May 31 15:56:41 volumio avahi-daemon[835]: Registering new address record for 192.168.1.249 on eth0.IPv4.
May 31 15:56:41 volumio dhcpcd[912]: eth0: adding route to 192.168.1.0/24
May 31 15:56:41 volumio dhcpcd[912]: eth0: adding default route via 192.168.1.1
May 31 15:56:41 volumio systemd[1]: welcome.service: Deactivated successfully.
May 31 15:56:41 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
May 31 15:56:41 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
May 31 15:56:41 volumio sh[896]: forked to background, child pid 902
May 31 15:56:41 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
May 31 15:56:41 volumio welcome[1844]: Resolved ip:[1] 192.168.1.249
May 31 15:56:41 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
May 31 15:56:41 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
May 31 15:56:41 volumio ifplugd(eth0)[1149]: client: ifup: interface eth0 already configured
May 31 15:56:41 volumio sh[1881]: eth0=eth0
May 31 15:56:41 volumio ifplugd(eth0)[1149]: Program executed successfully.
May 31 15:56:41 volumio systemd[1]: Started nmbd.service - Samba NMB Daemon.
May 31 15:56:41 volumio nmbd[1068]: [2026/05/31 15:56:41.357837, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
May 31 15:56:41 volumio nmbd[1068]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.249 for name WORKGROUP<1d>.
May 31 15:56:41 volumio nmbd[1068]: This response was from IP 192.168.1.100, reporting an IP address of 192.168.1.100.
May 31 15:56:41 volumio systemd[1]: Starting winbind.service - Samba Winbind Daemon...
May 31 15:56:41 volumio winbindd[1886]: [2026/05/31 15:56:41.477143, 0] ../../source3/winbindd/winbindd.c:1440(main)
May 31 15:56:41 volumio winbindd[1886]: winbindd version 4.17.12-Debian started.
May 31 15:56:41 volumio winbindd[1886]: Copyright Andrew Tridgell and the Samba Team 1992-2022
May 31 15:56:41 volumio winbindd[1886]: [2026/05/31 15:56:41.479817, 0] ../../source3/winbindd/winbindd_cache.c:3117(initialize_winbindd_cache)
May 31 15:56:41 volumio winbindd[1886]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
May 31 15:56:41 volumio systemd[1]: Started winbind.service - Samba Winbind Daemon.
May 31 15:56:41 volumio systemd[1]: Starting smbd.service - Samba SMB Daemon...
May 31 15:56:41 volumio smbd[1902]: [2026/05/31 15:56:41.581970, 0] ../../source3/smbd/server.c:1741(main)
May 31 15:56:41 volumio smbd[1902]: smbd version 4.17.12-Debian started.
May 31 15:56:41 volumio smbd[1902]: Copyright Andrew Tridgell and the Samba Team 1992-2022
May 31 15:56:41 volumio volumio[1106]: info: Received Get System Info
May 31 15:56:41 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 31 15:56:41 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 31 15:56:41 volumio volumio[1106]: info: Discovery: Getting this device information
May 31 15:56:41 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:41 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:41 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 31 15:56:41 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 31 15:56:41 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 31 15:56:41 volumio systemd[1]: Started smbd.service - Samba SMB Daemon.
May 31 15:56:41 volumio systemd[1]: Reached target multi-user.target - Multi-User System.
May 31 15:56:41 volumio systemd[1]: Reached target graphical.target - Graphical Interface.
May 31 15:56:41 volumio systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP...
May 31 15:56:41 volumio systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully.
May 31 15:56:41 volumio systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP.
May 31 15:56:41 volumio systemd[1]: Startup finished in 8.318s (firmware) + 2.153s (loader) + 12.939s (kernel) + 13.634s (userspace) = 37.047s.
May 31 15:56:41 volumio dhcpcd[906]: eth0: leased 192.168.1.249 for 43200 seconds
May 31 15:56:41 volumio dhcpcd[906]: eth0: adding route to 192.168.1.0/24
May 31 15:56:41 volumio dhcpcd[906]: eth0: adding default route via 192.168.1.1
May 31 15:56:41 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
May 31 15:56:41 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
May 31 15:56:41 volumio systemd[1]: welcome.service: Deactivated successfully.
May 31 15:56:41 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
May 31 15:56:41 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
May 31 15:56:41 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
May 31 15:56:41 volumio welcome[1926]: Resolved ip:[1] 192.168.1.249
May 31 15:56:41 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
May 31 15:56:41 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
May 31 15:56:41 volumio volumio[1106]: info: Initializing connection to go-librespot Websocket
May 31 15:56:41 volumio volumio[1106]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
May 31 15:56:42 volumio volumio[1106]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
May 31 15:56:42 volumio volumio[1106]: info: Discovery: this is already registered, 71c46669-deb2-4143-aedb-b4d027494509
May 31 15:56:42 volumio volumio[1106]: info: Discovery: Found device Volumio
May 31 15:56:42 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:42 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:42 volumio volumio[1106]: info: Received Get System Info
May 31 15:56:42 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 31 15:56:42 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 31 15:56:42 volumio volumio[1106]: info: Discovery: Getting this device information
May 31 15:56:42 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:42 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:42 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 31 15:56:42 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 31 15:56:42 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 31 15:56:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2.
May 31 15:56:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
May 31 15:56:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
May 31 15:56:42 volumio go-librespot[1938]: go-librespot daemon starting...
May 31 15:56:42 volumio go-librespot[1939]: time="2026-05-31T15:56:42+07:00" level=info msg="running go-librespot 0.7.1"
May 31 15:56:42 volumio go-librespot[1939]: time="2026-05-31T15:56:42+07:00" level=debug msg="app state loaded"
May 31 15:56:42 volumio go-librespot[1939]: time="2026-05-31T15:56:42+07:00" level=debug msg="stored credentials not found"
May 31 15:56:42 volumio go-librespot[1939]: time="2026-05-31T15:56:42+07:00" level=info msg="api server listening on 127.0.0.1:9879"
May 31 15:56:42 volumio volumio[1106]: info: Volumio Network Manager: Network status updated: 1
May 31 15:56:42 volumio sudo[1963]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 31 15:56:42 volumio sudo[1963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:42 volumio sudo[1965]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 31 15:56:42 volumio sudo[1965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:42 volumio sudo[1963]: pam_unix(sudo:session): session closed for user root
May 31 15:56:42 volumio sudo[1968]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 31 15:56:42 volumio sudo[1968]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:42 volumio sudo[1965]: pam_unix(sudo:session): session closed for user root
May 31 15:56:43 volumio ntpd[1018]: IO: Listen normally on 3 eth0 192.168.1.249:123
May 31 15:56:43 volumio ntpd[1018]: IO: new interface(s) found: waking up resolver
May 31 15:56:43 volumio ntpd[1018]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101
May 31 15:56:43 volumio ntpd[1018]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101
May 31 15:56:43 volumio ntpd[1018]: DNS: Pool taking: 92.255.126.18
May 31 15:56:43 volumio ntpd[1018]: DNS: Pool taking: 46.160.198.122
May 31 15:56:43 volumio ntpd[1018]: DNS: Pool taking: 162.159.200.123
May 31 15:56:43 volumio ntpd[1018]: DNS: Pool taking: 83.243.68.157
May 31 15:56:43 volumio ntpd[1018]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8
May 31 15:56:43 volumio volumio5-onboarding[1700]: time=2026-05-31T15:56:43.645+07:00 level=INFO msg="service successfully established" component=discovery/localnet
May 31 15:56:44 volumio ntpd[1018]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101
May 31 15:56:44 volumio ntpd[1018]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101
May 31 15:56:44 volumio ntpd[1018]: DNS: Pool taking: 46.188.16.150
May 31 15:56:44 volumio ntpd[1018]: DNS: Pool taking: 195.161.69.241
May 31 15:56:44 volumio ntpd[1018]: DNS: Pool taking: 93.95.100.85
May 31 15:56:44 volumio ntpd[1018]: DNS: Pool taking: 195.54.177.84
May 31 15:56:44 volumio ntpd[1018]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8
May 31 15:56:44 volumio volumio[1106]: info: Initializing connection to go-librespot Websocket
May 31 15:56:44 volumio go-librespot[1939]: time="2026-05-31T15:56:44+07:00" level=debug msg="new websocket client"
May 31 15:56:44 volumio volumio[1106]: info: Connection to go-librespot Websocket established
May 31 15:56:45 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1.
May 31 15:56:45 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 15:56:45 volumio ntpd[1018]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101
May 31 15:56:45 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
May 31 15:56:45 volumio sudo[1968]: pam_unix(sudo:session): session closed for user root
May 31 15:56:45 volumio volumio[1106]: info: Upmpdcli Daemon Started
May 31 15:56:45 volumio ntpd[1018]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101
May 31 15:56:45 volumio ntpd[1018]: DNS: Pool taking: 195.122.253.38
May 31 15:56:45 volumio ntpd[1018]: DNS: Pool taking: 91.206.16.3
May 31 15:56:45 volumio ntpd[1018]: DNS: Pool taking: 83.237.235.30
May 31 15:56:45 volumio ntpd[1018]: DNS: Pool taking: 51.250.35.68
May 31 15:56:45 volumio ntpd[1018]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
May 31 15:56:45 volumio volumio[1106]: info: Adding plugin bluetooth to MyMusic Plugins
May 31 15:56:45 volumio volumio[1106]: info: Adding plugin multiroom to MyMusic Plugins
May 31 15:56:45 volumio volumio[1106]: info: Adding plugin metavolumio to MyMusic Plugins
May 31 15:56:45 volumio volumio[1106]: info: Adding plugin cd_controller to MyMusic Plugins
May 31 15:56:45 volumio volumio[1106]: info: Adding plugin qobuzconnect to MyMusic Plugins
May 31 15:56:45 volumio volumio[1106]: info: Adding plugin smart_inputs to MyMusic Plugins
May 31 15:56:45 volumio volumio[1106]: info: Adding plugin tidalconnect to MyMusic Plugins
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
May 31 15:56:45 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 31 15:56:45 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 31 15:56:45 volumio volumio[1106]: info: Starting MyVolumio Remote Streaming Endpoints
May 31 15:56:45 volumio volumio[1106]: info: MyVolumio login type: Token
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
May 31 15:56:45 volumio volumio[1106]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
May 31 15:56:46 volumio ntpd[1018]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101
May 31 15:56:46 volumio ntpd[1018]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101
May 31 15:56:46 volumio ntpd[1018]: DNS: Pool taking: 91.207.136.55
May 31 15:56:46 volumio ntpd[1018]: DNS: Pool taking: 162.159.200.1
May 31 15:56:46 volumio ntpd[1018]: DNS: Pool taking: 89.179.240.219
May 31 15:56:46 volumio ntpd[1018]: DNS: Pool taking: 213.108.170.26
May 31 15:56:46 volumio ntpd[1018]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8
May 31 15:56:46 volumio volumio[1106]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
May 31 15:56:46 volumio volumio[1106]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
May 31 15:56:46 volumio volumio[1106]: info: Streaming services startup
May 31 15:56:46 volumio volumio[1106]: info: Starting Streaming Daemon
May 31 15:56:46 volumio sudo[1998]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 31 15:56:46 volumio sudo[1998]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:46 volumio volumio[1106]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
May 31 15:56:46 volumio sudo[1998]: pam_unix(sudo:session): session closed for user root
May 31 15:56:46 volumio volumio[1106]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=4.119&uuid=02ba6f71eeb7ca4c382387f2dfd3fdff" http://updates.volumio.org/downloader-v1/track-device
May 31 15:56:46 volumio volumio[1106]: % Total % Received % Xferd Average Speed Time Time Time Current
May 31 15:56:46 volumio volumio[1106]: Dload Upload Total Spent Left Speed
May 31 15:56:46 volumio volumio[1106]: [132B blob data]
May 31 15:56:46 volumio volumio[1106]: retrying in 5 seconds, trial 0
May 31 15:56:46 volumio volumio[1106]: info: Volumio Calling Home
May 31 15:56:46 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 31 15:56:46 volumio volumio[1106]: info: Received Get System Info
May 31 15:56:46 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 31 15:56:46 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 31 15:56:46 volumio volumio[1106]: info: Discovery: Getting this device information
May 31 15:56:46 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:46 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:46 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 31 15:56:46 volumio volumio[1106]: error: Cannot start Volumio Streaming Daemon
May 31 15:56:46 volumio volumio[1106]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 31 15:56:46 volumio volumio[1106]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 31 15:56:46 volumio volumio[1106]: info: Volumio called home
May 31 15:56:46 volumio upmpdcli[2007]: writing RSA key
May 31 15:56:46 volumio volumio[1106]: error: MyVolumio Custom Token format not valid, refreshing it
May 31 15:56:47 volumio volumio[1106]: info: MyVolumio login type: Token
May 31 15:56:47 volumio volumio[1106]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 31 15:56:47 volumio volumio[1106]: info: Getting Spotify volume
May 31 15:56:47 volumio volumio[1106]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
May 31 15:56:48 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:48 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:48 volumio volumio[1106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 43
May 31 15:56:48 volumio volumio[1106]: SPOTIFY: SPOTIFY VOLUME undefined
May 31 15:56:48 volumio volumio[1106]: SPOTIFY: VOLUMIO VOLUME 43
May 31 15:56:48 volumio volumio[1106]: info: Aligning Spotify Volume to Volumio Volume
May 31 15:56:48 volumio volumio[1106]: info: CoreCommandRouter::volumioGetState
May 31 15:56:48 volumio volumio[1106]: info: CorePlayQueue::getTrack 0
May 31 15:56:48 volumio volumio[1106]: info: Setting Spotify Volume from Volumio: 43
May 31 15:56:48 volumio volumio[1106]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
May 31 15:56:48 volumio volumio[1106]: info: MyVolumio token set successfully
May 31 15:56:48 volumio volumio[1106]: info: MYVOLUMIO: Adding device
May 31 15:56:48 volumio volumio[1106]: info: MYVOLUMIO: Evaluating Server
May 31 15:56:49 volumio ntpd[1018]: CLOCK: time stepped by 0.557015
May 31 15:56:49 volumio ntpd[1018]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes
May 31 15:56:49 volumio volumio[1106]: info: MyVolumio status changed
May 31 15:56:49 volumio volumio[1106]: info: Streaming services startup
May 31 15:56:49 volumio volumio[1106]: info: Starting Streaming Daemon
May 31 15:56:49 volumio volumio[1106]: info: Removing browser output: myVolumio user plan is not superstar
May 31 15:56:49 volumio volumio[1106]: info: Removing audio output:
May 31 15:56:49 volumio volumio[1106]: info: Stoppping Tunnel 1
May 31 15:56:49 volumio sudo[2039]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 31 15:56:49 volumio sudo[2039]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:49 volumio sudo[2041]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
May 31 15:56:49 volumio sudo[2041]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 31 15:56:49 volumio sudo[2039]: pam_unix(sudo:session): session closed for user root
May 31 15:56:49 volumio volumio[1106]: error: Cannot start Volumio Streaming Daemon
May 31 15:56:49 volumio volumio[1106]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 31 15:56:49 volumio volumio[1106]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 31 15:56:49 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 31 15:56:49 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 31 15:56:49 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 31 15:56:49 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 31 15:56:49 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 31 15:56:49 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 31 15:56:49 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 31 15:56:49 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 31 15:56:49 volumio sudo[2041]: pam_unix(sudo:session): session closed for user root
May 31 15:56:49 volumio volumio[1106]: info: Remote SSH Stopped
May 31 15:56:50 volumio volumio[1106]: SPOTIFY: SETTING SPOTIFY VOLUME 43
May 31 15:56:50 volumio volumio[1106]: info: Sending Spotify command with payload to local API: /player/volume
May 31 15:56:53 volumio go-librespot[1939]: time="2026-05-31T15:56:53+07:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": net/http: TLS handshake timeout"
May 31 15:56:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
May 31 15:56:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
May 31 15:56:53 volumio volumio[1106]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up
May 31 15:56:53 volumio volumio[1106]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 31 15:56:53 volumio volumio[1106]: Error: socket hang up
May 31 15:56:53 volumio volumio[1106]: at connResetException (node:internal/errors:720:14)
May 31 15:56:53 volumio volumio[1106]: at Socket.socketOnEnd (node:_http_client:519:23)
May 31 15:56:53 volumio volumio[1106]: at Socket.emit (node:events:526:35)
May 31 15:56:53 volumio volumio[1106]: at endReadableNT (node:internal/streams/readable:1376:12)
May 31 15:56:53 volumio volumio[1106]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) {
May 31 15:56:53 volumio volumio[1106]: code: 'ECONNRESET',
May 31 15:56:53 volumio volumio[1106]: response: undefined
May 31 15:56:53 volumio volumio[1106]: }
May 31 15:56:53 volumio volumio[1106]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 31 15:56:53 volumio sudo[2076]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-31 15:55'
May 31 15:56:53 volumio sudo[2076]: 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"