-- Logs begin at Thu 2024-10-17 12:25:10 CST, end at Thu 2024-10-17 12:26:19 CST. -- Oct 17 12:25:10 volumio-x86 kernel: Linux version 6.6.32-volumio (gkkpch@UbuntuVM24.04) (gcc (Ubuntu 13.2.0-23ubuntu4) 13.2.0, GNU ld (GNU Binutils for Ubuntu) 2.42) #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 Oct 17 12:25:10 volumio-x86 kernel: Command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=d0822069-d48a-490f-b8bc-9970c0b6e384 bootpart=UUID=1496-1547 datapart=UUID=a0bf3376-7b72-4c09-9fc2-d0970ff7651c hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no Oct 17 12:25:10 volumio-x86 kernel: KERNEL supported cpus: Oct 17 12:25:10 volumio-x86 kernel: Intel GenuineIntel Oct 17 12:25:10 volumio-x86 kernel: AMD AuthenticAMD Oct 17 12:25:10 volumio-x86 kernel: Hygon HygonGenuine Oct 17 12:25:10 volumio-x86 kernel: Centaur CentaurHauls Oct 17 12:25:10 volumio-x86 kernel: zhaoxin Shanghai Oct 17 12:25:10 volumio-x86 kernel: BIOS-provided physical RAM map: Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000008efff] usable Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x000000000008f000-0x000000000008ffff] ACPI NVS Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000000090000-0x000000000009ffff] usable Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000001effffff] usable Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x000000001f000000-0x000000001f0fffff] reserved Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x000000001f100000-0x000000001fffffff] usable Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000020000000-0x00000000200fffff] reserved Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000020100000-0x0000000078d5efff] usable Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000078d5f000-0x0000000078d8efff] reserved Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000078d8f000-0x0000000078d9efff] ACPI data Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000078d9f000-0x00000000798cffff] ACPI NVS Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x00000000798d0000-0x0000000079b57fff] reserved Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000079b58000-0x0000000079ba4fff] type 20 Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000079ba5000-0x0000000079ba5fff] usable Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000079ba6000-0x0000000079be7fff] reserved Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000079be8000-0x0000000079d56fff] usable Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000079d57000-0x0000000079ff9fff] reserved Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x0000000079ffa000-0x0000000079ffffff] usable Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x00000000e00f8000-0x00000000e00f8fff] reserved Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x00000000fed01000-0x00000000fed01fff] reserved Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x00000000fed08000-0x00000000fed08fff] reserved Oct 17 12:25:10 volumio-x86 kernel: BIOS-e820: [mem 0x00000000ffb00000-0x00000000ffffffff] reserved Oct 17 12:25:10 volumio-x86 kernel: NX (Execute Disable) protection: active Oct 17 12:25:10 volumio-x86 kernel: APIC: Static calls initialized Oct 17 12:25:10 volumio-x86 kernel: efi: EFI v2.3.1 by American Megatrends Oct 17 12:25:10 volumio-x86 kernel: efi: ACPI=0x78d93000 ACPI 2.0=0x78d93000 ESRT=0x79aa1f18 SMBIOS=0xf0570 Oct 17 12:25:10 volumio-x86 kernel: efi: Not removing mem34: MMIO range=[0xe00f8000-0xe00f8fff] (4KB) from e820 map Oct 17 12:25:10 volumio-x86 kernel: efi: Not removing mem35: MMIO range=[0xfed01000-0xfed01fff] (4KB) from e820 map Oct 17 12:25:10 volumio-x86 kernel: efi: Not removing mem36: MMIO range=[0xfed08000-0xfed08fff] (4KB) from e820 map Oct 17 12:25:10 volumio-x86 kernel: efi: Remove mem37: MMIO range=[0xffb00000-0xffffffff] (5MB) from e820 map Oct 17 12:25:10 volumio-x86 kernel: e820: remove [mem 0xffb00000-0xffffffff] reserved Oct 17 12:25:10 volumio-x86 kernel: SMBIOS 2.8 present. Oct 17 12:25:10 volumio-x86 kernel: DMI: To be filled by O.E.M. To be filled by O.E.M./Aptio CRB, BIOS 5.6.5 01/19/2015 Oct 17 12:25:10 volumio-x86 kernel: tsc: Detected 1583.333 MHz processor Oct 17 12:25:10 volumio-x86 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 17 12:25:10 volumio-x86 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 17 12:25:10 volumio-x86 kernel: last_pfn = 0x7a000 max_arch_pfn = 0x400000000 Oct 17 12:25:10 volumio-x86 kernel: MTRR map: 6 entries (4 fixed + 2 variable; max 20), built from 8 variable MTRRs Oct 17 12:25:10 volumio-x86 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 17 12:25:10 volumio-x86 kernel: found SMP MP-table at [mem 0x000fd7a0-0x000fd7af] Oct 17 12:25:10 volumio-x86 kernel: esrt: Reserving ESRT space from 0x0000000079aa1f18 to 0x0000000079aa1f50. Oct 17 12:25:10 volumio-x86 kernel: Secure boot could not be determined Oct 17 12:25:10 volumio-x86 kernel: RAMDISK: [mem 0x2fae9000-0x33d6bfff] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Early table checksum verification disabled Oct 17 12:25:10 volumio-x86 kernel: ACPI: RSDP 0x0000000078D93000 000024 (v02 ALASKA) Oct 17 12:25:10 volumio-x86 kernel: ACPI: XSDT 0x0000000078D93080 00007C (v01 ALASKA A M I 01072009 AMI 00010013) Oct 17 12:25:10 volumio-x86 kernel: ACPI: FACP 0x0000000078D9D100 00010C (v05 ALASKA A M I 01072009 AMI 00010013) Oct 17 12:25:10 volumio-x86 kernel: ACPI BIOS Warning (bug): 32/64X length mismatch in FADT/Gpe0Block: 128/32 (20230628/tbfadt-564) Oct 17 12:25:10 volumio-x86 kernel: ACPI: DSDT 0x0000000078D93188 009F76 (v02 ALASKA A M I 01072009 INTL 20120913) Oct 17 12:25:10 volumio-x86 kernel: ACPI: FACS 0x00000000798CFF80 000040 Oct 17 12:25:10 volumio-x86 kernel: ACPI: APIC 0x0000000078D9D210 000068 (v03 ALASKA A M I 01072009 AMI 00010013) Oct 17 12:25:10 volumio-x86 kernel: ACPI: FPDT 0x0000000078D9D278 000044 (v01 ALASKA A M I 01072009 AMI 00010013) Oct 17 12:25:10 volumio-x86 kernel: ACPI: MCFG 0x0000000078D9D2C0 00003C (v01 ALASKA A M I 01072009 MSFT 00000097) Oct 17 12:25:10 volumio-x86 kernel: ACPI: LPIT 0x0000000078D9D300 000104 (v01 ALASKA A M I 00000003 VLV2 0100000D) Oct 17 12:25:10 volumio-x86 kernel: ACPI: HPET 0x0000000078D9D408 000038 (v01 ALASKA A M I 01072009 AMI. 00000005) Oct 17 12:25:10 volumio-x86 kernel: ACPI: SSDT 0x0000000078D9D440 000763 (v01 PmRef CpuPm 00003000 INTL 20061109) Oct 17 12:25:10 volumio-x86 kernel: ACPI: SSDT 0x0000000078D9DBA8 000290 (v01 PmRef Cpu0Tst 00003000 INTL 20061109) Oct 17 12:25:10 volumio-x86 kernel: ACPI: SSDT 0x0000000078D9DE38 00017A (v01 PmRef ApTst 00003000 INTL 20061109) Oct 17 12:25:10 volumio-x86 kernel: ACPI: UEFI 0x0000000078D9DFB8 000042 (v01 ALASKA A M I 00000000 00000000) Oct 17 12:25:10 volumio-x86 kernel: ACPI: BGRT 0x0000000078D9E000 000038 (v01 ALASKA A M I 01072009 AMI 00010013) Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving FACP table memory at [mem 0x78d9d100-0x78d9d20b] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving DSDT table memory at [mem 0x78d93188-0x78d9d0fd] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving FACS table memory at [mem 0x798cff80-0x798cffbf] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving APIC table memory at [mem 0x78d9d210-0x78d9d277] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving FPDT table memory at [mem 0x78d9d278-0x78d9d2bb] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving MCFG table memory at [mem 0x78d9d2c0-0x78d9d2fb] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving LPIT table memory at [mem 0x78d9d300-0x78d9d403] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving HPET table memory at [mem 0x78d9d408-0x78d9d43f] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving SSDT table memory at [mem 0x78d9d440-0x78d9dba2] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving SSDT table memory at [mem 0x78d9dba8-0x78d9de37] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving SSDT table memory at [mem 0x78d9de38-0x78d9dfb1] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving UEFI table memory at [mem 0x78d9dfb8-0x78d9dff9] Oct 17 12:25:10 volumio-x86 kernel: ACPI: Reserving BGRT table memory at [mem 0x78d9e000-0x78d9e037] Oct 17 12:25:10 volumio-x86 kernel: Zone ranges: Oct 17 12:25:10 volumio-x86 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 17 12:25:10 volumio-x86 kernel: DMA32 [mem 0x0000000001000000-0x0000000079ffffff] Oct 17 12:25:10 volumio-x86 kernel: Normal empty Oct 17 12:25:10 volumio-x86 kernel: Movable zone start for each node Oct 17 12:25:10 volumio-x86 kernel: Early memory node ranges Oct 17 12:25:10 volumio-x86 kernel: node 0: [mem 0x0000000000001000-0x000000000008efff] Oct 17 12:25:10 volumio-x86 kernel: node 0: [mem 0x0000000000090000-0x000000000009ffff] Oct 17 12:25:10 volumio-x86 kernel: node 0: [mem 0x0000000000100000-0x000000001effffff] Oct 17 12:25:10 volumio-x86 kernel: node 0: [mem 0x000000001f100000-0x000000001fffffff] Oct 17 12:25:10 volumio-x86 kernel: node 0: [mem 0x0000000020100000-0x0000000078d5efff] Oct 17 12:25:10 volumio-x86 kernel: node 0: [mem 0x0000000079ba5000-0x0000000079ba5fff] Oct 17 12:25:10 volumio-x86 kernel: node 0: [mem 0x0000000079be8000-0x0000000079d56fff] Oct 17 12:25:10 volumio-x86 kernel: node 0: [mem 0x0000000079ffa000-0x0000000079ffffff] Oct 17 12:25:10 volumio-x86 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x0000000079ffffff] Oct 17 12:25:10 volumio-x86 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 17 12:25:10 volumio-x86 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 17 12:25:10 volumio-x86 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Oct 17 12:25:10 volumio-x86 kernel: On node 0, zone DMA32: 256 pages in unavailable ranges Oct 17 12:25:10 volumio-x86 kernel: On node 0, zone DMA32: 256 pages in unavailable ranges Oct 17 12:25:10 volumio-x86 kernel: On node 0, zone DMA32: 3654 pages in unavailable ranges Oct 17 12:25:10 volumio-x86 kernel: On node 0, zone DMA32: 66 pages in unavailable ranges Oct 17 12:25:10 volumio-x86 kernel: On node 0, zone DMA32: 675 pages in unavailable ranges Oct 17 12:25:10 volumio-x86 kernel: On node 0, zone DMA32: 24576 pages in unavailable ranges Oct 17 12:25:10 volumio-x86 kernel: x86/hpet: Will disable the HPET for this platform because it's not reliable Oct 17 12:25:10 volumio-x86 kernel: Reserving Intel graphics memory at [mem 0x7b000000-0x7effffff] Oct 17 12:25:10 volumio-x86 kernel: ACPI: PM-Timer IO Port: 0x408 Oct 17 12:25:10 volumio-x86 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1]) Oct 17 12:25:10 volumio-x86 kernel: ACPI: LAPIC_NMI (acpi_id[0x02] high edge lint[0x1]) Oct 17 12:25:10 volumio-x86 kernel: IOAPIC[0]: apic_id 1, version 32, address 0xfec00000, GSI 0-86 Oct 17 12:25:10 volumio-x86 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Oct 17 12:25:10 volumio-x86 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 17 12:25:10 volumio-x86 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 17 12:25:10 volumio-x86 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Oct 17 12:25:10 volumio-x86 kernel: e820: update [mem 0x6d802000-0x6d961fff] usable ==> reserved Oct 17 12:25:10 volumio-x86 kernel: TSC deadline timer available Oct 17 12:25:10 volumio-x86 kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x0008f000-0x0008ffff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000fffff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x1f000000-0x1f0fffff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x20000000-0x200fffff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x6d802000-0x6d961fff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x78d5f000-0x78d8efff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x78d8f000-0x78d9efff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x78d9f000-0x798cffff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x798d0000-0x79b57fff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x79b58000-0x79ba4fff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x79ba6000-0x79be7fff] Oct 17 12:25:10 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x79d57000-0x79ff9fff] Oct 17 12:25:10 volumio-x86 kernel: [mem 0x7f000000-0xe00f7fff] available for PCI devices Oct 17 12:25:10 volumio-x86 kernel: Booting paravirtualized kernel on bare hardware Oct 17 12:25:10 volumio-x86 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Oct 17 12:25:10 volumio-x86 kernel: setup_percpu: NR_CPUS:8 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Oct 17 12:25:10 volumio-x86 kernel: percpu: Embedded 56 pages/cpu s191400 r8192 d29784 u1048576 Oct 17 12:25:10 volumio-x86 kernel: pcpu-alloc: s191400 r8192 d29784 u1048576 alloc=1*2097152 Oct 17 12:25:10 volumio-x86 kernel: pcpu-alloc: [0] 0 1 Oct 17 12:25:10 volumio-x86 kernel: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=d0822069-d48a-490f-b8bc-9970c0b6e384 bootpart=UUID=1496-1547 datapart=UUID=a0bf3376-7b72-4c09-9fc2-d0970ff7651c hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no Oct 17 12:25:10 volumio-x86 kernel: Unknown kernel command line parameters "splash BOOT_IMAGE=/vmlinuz biosdevname=0 imgpart=UUID=d0822069-d48a-490f-b8bc-9970c0b6e384 bootpart=UUID=1496-1547 datapart=UUID=a0bf3376-7b72-4c09-9fc2-d0970ff7651c hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh use_kmsg=no", will be passed to user space. Oct 17 12:25:10 volumio-x86 kernel: random: crng init done Oct 17 12:25:10 volumio-x86 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: Built 1 zonelists, mobility grouping on. Total pages: 486741 Oct 17 12:25:10 volumio-x86 kernel: mem auto-init: stack:all(zero), heap alloc:off, heap free:off Oct 17 12:25:10 volumio-x86 kernel: Memory: 1589952K/1978828K available (14336K kernel code, 1878K rwdata, 4640K rodata, 2988K init, 1148K bss, 388620K reserved, 0K cma-reserved) Oct 17 12:25:10 volumio-x86 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 17 12:25:10 volumio-x86 kernel: Kernel/User page tables isolation: enabled Oct 17 12:25:10 volumio-x86 kernel: ftrace: allocating 40433 entries in 158 pages Oct 17 12:25:10 volumio-x86 kernel: ftrace: allocated 158 pages with 5 groups Oct 17 12:25:10 volumio-x86 kernel: Dynamic Preempt: voluntary Oct 17 12:25:10 volumio-x86 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 17 12:25:10 volumio-x86 kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2. Oct 17 12:25:10 volumio-x86 kernel: Trampoline variant of Tasks RCU enabled. Oct 17 12:25:10 volumio-x86 kernel: Rude variant of Tasks RCU enabled. Oct 17 12:25:10 volumio-x86 kernel: Tracing variant of Tasks RCU enabled. Oct 17 12:25:10 volumio-x86 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Oct 17 12:25:10 volumio-x86 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 17 12:25:10 volumio-x86 kernel: NR_IRQS: 4352, nr_irqs: 512, preallocated irqs: 16 Oct 17 12:25:10 volumio-x86 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 17 12:25:10 volumio-x86 kernel: Console: colour dummy device 80x25 Oct 17 12:25:10 volumio-x86 kernel: printk: console [tty0] enabled Oct 17 12:25:10 volumio-x86 kernel: ACPI: Core revision 20230628 Oct 17 12:25:10 volumio-x86 kernel: APIC: Switch to symmetric I/O mode setup Oct 17 12:25:10 volumio-x86 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x16d2a43079d, max_idle_ns: 440795226549 ns Oct 17 12:25:10 volumio-x86 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 3166.66 BogoMIPS (lpj=6333332) Oct 17 12:25:10 volumio-x86 kernel: CPU0: Thermal monitoring enabled (TM1) Oct 17 12:25:10 volumio-x86 kernel: process: using mwait in idle threads Oct 17 12:25:10 volumio-x86 kernel: Last level iTLB entries: 4KB 48, 2MB 0, 4MB 0 Oct 17 12:25:10 volumio-x86 kernel: Last level dTLB entries: 4KB 128, 2MB 16, 4MB 16, 1GB 0 Oct 17 12:25:10 volumio-x86 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 17 12:25:10 volumio-x86 kernel: Spectre V2 : Mitigation: Retpolines Oct 17 12:25:10 volumio-x86 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Oct 17 12:25:10 volumio-x86 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Oct 17 12:25:10 volumio-x86 kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Oct 17 12:25:10 volumio-x86 kernel: MMIO Stale Data: Unknown: No mitigations Oct 17 12:25:10 volumio-x86 kernel: x86/fpu: x87 FPU will use FXSAVE Oct 17 12:25:10 volumio-x86 kernel: Freeing SMP alternatives memory: 32K Oct 17 12:25:10 volumio-x86 kernel: pid_max: default: 32768 minimum: 301 Oct 17 12:25:10 volumio-x86 kernel: LSM: initializing lsm=capability,yama,integrity Oct 17 12:25:10 volumio-x86 kernel: Yama: becoming mindful. Oct 17 12:25:10 volumio-x86 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: smpboot: CPU0: Intel(R) Celeron(R) CPU N2808 @ 1.58GHz (family: 0x6, model: 0x37, stepping: 0x8) Oct 17 12:25:10 volumio-x86 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1. Oct 17 12:25:10 volumio-x86 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1. Oct 17 12:25:10 volumio-x86 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1. Oct 17 12:25:10 volumio-x86 kernel: Performance Events: PEBS fmt2+, 8-deep LBR, Silvermont events, 8-deep LBR, full-width counters, Intel PMU driver. Oct 17 12:25:10 volumio-x86 kernel: ... version: 3 Oct 17 12:25:10 volumio-x86 kernel: ... bit width: 40 Oct 17 12:25:10 volumio-x86 kernel: ... generic registers: 2 Oct 17 12:25:10 volumio-x86 kernel: ... value mask: 000000ffffffffff Oct 17 12:25:10 volumio-x86 kernel: ... max period: 0000007fffffffff Oct 17 12:25:10 volumio-x86 kernel: ... fixed-purpose events: 3 Oct 17 12:25:10 volumio-x86 kernel: ... event mask: 0000000700000003 Oct 17 12:25:10 volumio-x86 kernel: signal: max sigframe size: 1440 Oct 17 12:25:10 volumio-x86 kernel: Estimated ratio of average max frequency by base frequency (times 1024): 1024 Oct 17 12:25:10 volumio-x86 kernel: rcu: Hierarchical SRCU implementation. Oct 17 12:25:10 volumio-x86 kernel: rcu: Max phase no-delay instances is 1000. Oct 17 12:25:10 volumio-x86 kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. Oct 17 12:25:10 volumio-x86 kernel: smp: Bringing up secondary CPUs ... Oct 17 12:25:10 volumio-x86 kernel: smpboot: x86: Booting SMP configuration: Oct 17 12:25:10 volumio-x86 kernel: .... node #0, CPUs: #1 Oct 17 12:25:10 volumio-x86 kernel: smp: Brought up 1 node, 2 CPUs Oct 17 12:25:10 volumio-x86 kernel: smpboot: Max logical packages: 1 Oct 17 12:25:10 volumio-x86 kernel: smpboot: Total of 2 processors activated (6333.33 BogoMIPS) Oct 17 12:25:10 volumio-x86 kernel: devtmpfs: initialized Oct 17 12:25:10 volumio-x86 kernel: x86/mm: Memory block size: 128MB Oct 17 12:25:10 volumio-x86 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0008f000-0x0008ffff] (4096 bytes) Oct 17 12:25:10 volumio-x86 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x78d9f000-0x798cffff] (11735040 bytes) Oct 17 12:25:10 volumio-x86 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Oct 17 12:25:10 volumio-x86 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: pinctrl core: initialized pinctrl subsystem Oct 17 12:25:10 volumio-x86 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 17 12:25:10 volumio-x86 kernel: audit: initializing netlink subsys (disabled) Oct 17 12:25:10 volumio-x86 kernel: audit: type=2000 audit(1729139093.004:1): state=initialized audit_enabled=0 res=1 Oct 17 12:25:10 volumio-x86 kernel: thermal_sys: Registered thermal governor 'fair_share' Oct 17 12:25:10 volumio-x86 kernel: thermal_sys: Registered thermal governor 'bang_bang' Oct 17 12:25:10 volumio-x86 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 17 12:25:10 volumio-x86 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 17 12:25:10 volumio-x86 kernel: EISA bus registered Oct 17 12:25:10 volumio-x86 kernel: cpuidle: using governor ladder Oct 17 12:25:10 volumio-x86 kernel: cpuidle: using governor menu Oct 17 12:25:10 volumio-x86 kernel: ACPI FADT declares the system doesn't support PCIe ASPM, so disable it Oct 17 12:25:10 volumio-x86 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 17 12:25:10 volumio-x86 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Oct 17 12:25:10 volumio-x86 kernel: PCI: not using MMCONFIG Oct 17 12:25:10 volumio-x86 kernel: PCI: Using configuration type 1 for base access Oct 17 12:25:10 volumio-x86 kernel: ENERGY_PERF_BIAS: Set to 'normal', was 'performance' Oct 17 12:25:10 volumio-x86 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 17 12:25:10 volumio-x86 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 17 12:25:10 volumio-x86 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Oct 17 12:25:10 volumio-x86 kernel: ACPI: Added _OSI(Module Device) Oct 17 12:25:10 volumio-x86 kernel: ACPI: Added _OSI(Processor Device) Oct 17 12:25:10 volumio-x86 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 17 12:25:10 volumio-x86 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 17 12:25:10 volumio-x86 kernel: ACPI: 4 ACPI AML tables successfully acquired and loaded Oct 17 12:25:10 volumio-x86 kernel: ACPI: _OSC evaluated successfully for all CPUs Oct 17 12:25:10 volumio-x86 kernel: ACPI: Interpreter enabled Oct 17 12:25:10 volumio-x86 kernel: ACPI: PM: (supports S0 S3 S4 S5) Oct 17 12:25:10 volumio-x86 kernel: ACPI: Using IOAPIC for interrupt routing Oct 17 12:25:10 volumio-x86 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Oct 17 12:25:10 volumio-x86 kernel: PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved as ACPI motherboard resource Oct 17 12:25:10 volumio-x86 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 17 12:25:10 volumio-x86 kernel: PCI: Using E820 reservations for host bridge windows Oct 17 12:25:10 volumio-x86 kernel: ACPI: Enabled 9 GPEs in block 00 to 3F Oct 17 12:25:10 volumio-x86 kernel: ACPI: \_SB_.USBC: New power resource Oct 17 12:25:10 volumio-x86 kernel: ACPI: \_SB_.I2C4.CLK0: New power resource Oct 17 12:25:10 volumio-x86 kernel: ACPI: \_SB_.I2C4.CLK1: New power resource Oct 17 12:25:10 volumio-x86 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 17 12:25:10 volumio-x86 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 17 12:25:10 volumio-x86 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug SHPCHotplug PME] Oct 17 12:25:10 volumio-x86 kernel: acpi PNP0A08:00: _OSC: OS now controls [AER PCIeCapability LTR] Oct 17 12:25:10 volumio-x86 kernel: acpi PNP0A08:00: FADT indicates ASPM is unsupported, using BIOS configuration Oct 17 12:25:10 volumio-x86 kernel: PCI host bridge to bus 0000:00 Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: root bus resource [io 0x0070-0x0077] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x006f window] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: root bus resource [io 0x0078-0x0cf7 window] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000fffff window] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xd0815fff window] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:00.0: [8086:0f00] type 00 class 0x060000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:02.0: [8086:0f31] type 00 class 0x030000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xd0000000-0xd03fffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xc0000000-0xcfffffff pref] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:02.0: reg 0x20: [io 0xf080-0xf087] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:02.0: BAR 2: assigned to efifb Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:13.0: [8086:0f23] type 00 class 0x010601 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:13.0: reg 0x10: [io 0xf070-0xf077] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:13.0: reg 0x14: [io 0xf060-0xf063] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:13.0: reg 0x18: [io 0xf050-0xf057] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:13.0: reg 0x1c: [io 0xf040-0xf043] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:13.0: reg 0x20: [io 0xf020-0xf03f] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:13.0: reg 0x24: [mem 0xd0815000-0xd08157ff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:13.0: PME# supported from D3hot Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:14.0: [8086:0f35] type 00 class 0x0c0330 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:14.0: reg 0x10: [mem 0xd0800000-0xd080ffff 64bit] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:14.0: PME# supported from D3hot D3cold Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1a.0: [8086:0f18] type 00 class 0x108000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1a.0: reg 0x10: [mem 0xd0500000-0xd05fffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1a.0: reg 0x14: [mem 0xd0400000-0xd04fffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1a.0: PME# supported from D0 D3hot Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1b.0: [8086:0f04] type 00 class 0x040300 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1b.0: reg 0x10: [mem 0xd0810000-0xd0813fff 64bit] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.0: [8086:0f48] type 01 class 0x060400 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.1: [8086:0f4a] type 01 class 0x060400 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: [8086:0f4c] type 01 class 0x060400 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: [8086:0f4e] type 01 class 0x060400 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1f.0: [8086:0f1c] type 00 class 0x060100 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1f.3: [8086:0f12] type 00 class 0x0c0500 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1f.3: reg 0x10: [mem 0xd0814000-0xd081401f] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1f.3: reg 0x20: [io 0xf000-0xf01f] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:01:00.0: [10ec:8168] type 00 class 0x020000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:01:00.0: reg 0x10: [io 0xe000-0xe0ff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:01:00.0: reg 0x18: [mem 0xd0704000-0xd0704fff 64bit] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:01:00.0: reg 0x20: [mem 0xd0700000-0xd0703fff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:01:00.0: supports D1 D2 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:01:00.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.0: PCI bridge to [bus 01] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [io 0xe000-0xefff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [mem 0xd0700000-0xd07fffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:02:00.0: [1b21:0612] type 00 class 0x010601 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:02:00.0: reg 0x10: [io 0xd050-0xd057] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:02:00.0: reg 0x14: [io 0xd040-0xd043] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:02:00.0: reg 0x18: [io 0xd030-0xd037] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:02:00.0: reg 0x1c: [io 0xd020-0xd023] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:02:00.0: reg 0x20: [io 0xd000-0xd01f] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:02:00.0: reg 0x24: [mem 0xd0610000-0xd06101ff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:02:00.0: reg 0x30: [mem 0xd0600000-0xd060ffff pref] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.1: PCI bridge to [bus 02] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.1: bridge window [io 0xd000-0xdfff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.1: bridge window [mem 0xd0600000-0xd06fffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: PCI bridge to [bus 03] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: PCI bridge to [bus 04] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: on NUMA node 0 Oct 17 12:25:10 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 11 Oct 17 12:25:10 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 4 Oct 17 12:25:10 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Oct 17 12:25:10 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 10 Oct 17 12:25:10 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 5 Oct 17 12:25:10 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 0 Oct 17 12:25:10 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKF disabled Oct 17 12:25:10 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 3 Oct 17 12:25:10 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 0 Oct 17 12:25:10 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKH disabled Oct 17 12:25:10 volumio-x86 kernel: ACPI: \_SB_.LPEA.PLPE: New power resource Oct 17 12:25:10 volumio-x86 kernel: ACPI: \_SB_.LPA2.PLPE: New power resource Oct 17 12:25:10 volumio-x86 kernel: iommu: Default domain type: Translated Oct 17 12:25:10 volumio-x86 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 17 12:25:10 volumio-x86 kernel: SCSI subsystem initialized Oct 17 12:25:10 volumio-x86 kernel: libata version 3.00 loaded. Oct 17 12:25:10 volumio-x86 kernel: ACPI: bus type USB registered Oct 17 12:25:10 volumio-x86 kernel: usbcore: registered new interface driver usbfs Oct 17 12:25:10 volumio-x86 kernel: usbcore: registered new interface driver hub Oct 17 12:25:10 volumio-x86 kernel: usbcore: registered new device driver usb Oct 17 12:25:10 volumio-x86 kernel: efivars: Registered efivars operations Oct 17 12:25:10 volumio-x86 kernel: PCI: Using ACPI for IRQ routing Oct 17 12:25:10 volumio-x86 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 17 12:25:10 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x0008f000-0x0008ffff] Oct 17 12:25:10 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x1f000000-0x1fffffff] Oct 17 12:25:10 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x6d802000-0x6fffffff] Oct 17 12:25:10 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x78d5f000-0x7bffffff] Oct 17 12:25:10 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x79ba6000-0x7bffffff] Oct 17 12:25:10 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x79d57000-0x7bffffff] Oct 17 12:25:10 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x7a000000-0x7bffffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Oct 17 12:25:10 volumio-x86 kernel: vgaarb: loaded Oct 17 12:25:10 volumio-x86 kernel: clocksource: Switched to clocksource tsc-early Oct 17 12:25:10 volumio-x86 kernel: VFS: Disk quotas dquot_6.6.0 Oct 17 12:25:10 volumio-x86 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 17 12:25:10 volumio-x86 kernel: pnp: PnP ACPI init Oct 17 12:25:10 volumio-x86 kernel: system 00:01: [io 0x0680-0x069f] has been reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:01: [io 0x0400-0x047f] has been reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:01: [io 0x0500-0x05fe] has been reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:01: [io 0x0600-0x061f] has been reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:02: [mem 0xe0000000-0xefffffff] could not be reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:02: [mem 0xfed01000-0xfed01fff] has been reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:02: [mem 0xfed03000-0xfed03fff] has been reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:02: [mem 0xfed04000-0xfed04fff] has been reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:02: [mem 0xfed0c000-0xfed0ffff] has been reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:02: [mem 0xfed08000-0xfed08fff] has been reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:02: [mem 0xfed1c000-0xfed1cfff] has been reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:02: [mem 0xfee00000-0xfeefffff] has been reserved Oct 17 12:25:10 volumio-x86 kernel: system 00:02: [mem 0xfef00000-0xfeffffff] has been reserved Oct 17 12:25:10 volumio-x86 kernel: pnp: PnP ACPI: found 3 devices Oct 17 12:25:10 volumio-x86 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 17 12:25:10 volumio-x86 kernel: NET: Registered PF_INET protocol family Oct 17 12:25:10 volumio-x86 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: TCP: Hash tables configured (established 16384 bind 16384) Oct 17 12:25:10 volumio-x86 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Oct 17 12:25:10 volumio-x86 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 01] add_size 200000 add_align 100000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.1: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 02] add_size 200000 add_align 100000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: bridge window [io 0x1000-0x0fff] to [bus 03] add_size 1000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 03] add_size 200000 add_align 100000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: bridge window [mem 0x00100000-0x000fffff] to [bus 03] add_size 200000 add_align 100000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [io 0x1000-0x0fff] to [bus 04] add_size 1000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 04] add_size 200000 add_align 100000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [mem 0x00100000-0x000fffff] to [bus 04] add_size 200000 add_align 100000 Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.0: BAR 15: assigned [mem 0x80000000-0x801fffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.1: BAR 15: assigned [mem 0x80200000-0x803fffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: BAR 14: assigned [mem 0x80400000-0x805fffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: BAR 15: assigned [mem 0x80600000-0x807fffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: BAR 14: assigned [mem 0x80800000-0x809fffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: BAR 15: assigned [mem 0x80a00000-0x80bfffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: BAR 13: assigned [io 0x1000-0x1fff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: BAR 13: assigned [io 0x2000-0x2fff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.0: PCI bridge to [bus 01] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [io 0xe000-0xefff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [mem 0xd0700000-0xd07fffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [mem 0x80000000-0x801fffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.1: PCI bridge to [bus 02] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.1: bridge window [io 0xd000-0xdfff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.1: bridge window [mem 0xd0600000-0xd06fffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.1: bridge window [mem 0x80200000-0x803fffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: PCI bridge to [bus 03] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: bridge window [io 0x1000-0x1fff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: bridge window [mem 0x80400000-0x805fffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.2: bridge window [mem 0x80600000-0x807fffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: PCI bridge to [bus 04] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [io 0x2000-0x2fff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [mem 0x80800000-0x809fffff] Oct 17 12:25:10 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [mem 0x80a00000-0x80bfffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: resource 4 [io 0x0070-0x0077] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0x006f window] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: resource 6 [io 0x0078-0x0cf7 window] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: resource 7 [io 0x0d00-0xffff window] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: resource 8 [mem 0x000a0000-0x000fffff window] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:00: resource 9 [mem 0x80000000-0xd0815fff window] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:01: resource 0 [io 0xe000-0xefff] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:01: resource 1 [mem 0xd0700000-0xd07fffff] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:01: resource 2 [mem 0x80000000-0x801fffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:02: resource 0 [io 0xd000-0xdfff] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:02: resource 1 [mem 0xd0600000-0xd06fffff] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:02: resource 2 [mem 0x80200000-0x803fffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:03: resource 0 [io 0x1000-0x1fff] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:03: resource 1 [mem 0x80400000-0x805fffff] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:03: resource 2 [mem 0x80600000-0x807fffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:04: resource 0 [io 0x2000-0x2fff] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:04: resource 1 [mem 0x80800000-0x809fffff] Oct 17 12:25:10 volumio-x86 kernel: pci_bus 0000:04: resource 2 [mem 0x80a00000-0x80bfffff 64bit pref] Oct 17 12:25:10 volumio-x86 kernel: PCI: CLS 64 bytes, default 64 Oct 17 12:25:10 volumio-x86 kernel: Trying to unpack rootfs image as initramfs... Oct 17 12:25:10 volumio-x86 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x16d2a43079d, max_idle_ns: 440795226549 ns Oct 17 12:25:10 volumio-x86 kernel: clocksource: Switched to clocksource tsc Oct 17 12:25:10 volumio-x86 kernel: Initialise system trusted keyrings Oct 17 12:25:10 volumio-x86 kernel: workingset: timestamp_bits=46 max_order=19 bucket_order=0 Oct 17 12:25:10 volumio-x86 kernel: zbud: loaded Oct 17 12:25:10 volumio-x86 kernel: Key type asymmetric registered Oct 17 12:25:10 volumio-x86 kernel: Asymmetric key parser 'x509' registered Oct 17 12:25:10 volumio-x86 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) Oct 17 12:25:10 volumio-x86 kernel: io scheduler mq-deadline registered Oct 17 12:25:10 volumio-x86 kernel: io scheduler kyber registered Oct 17 12:25:10 volumio-x86 kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Oct 17 12:25:10 volumio-x86 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 17 12:25:10 volumio-x86 kernel: ACPI: button: Power Button [PWRB] Oct 17 12:25:10 volumio-x86 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Oct 17 12:25:10 volumio-x86 kernel: ACPI: button: Sleep Button [SLPB] Oct 17 12:25:10 volumio-x86 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Oct 17 12:25:10 volumio-x86 kernel: ACPI: button: Power Button [PWRF] Oct 17 12:25:10 volumio-x86 kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Oct 17 12:25:10 volumio-x86 kernel: hpet: number irqs doesn't agree with number of timers Oct 17 12:25:10 volumio-x86 kernel: Linux agpgart interface v0.103 Oct 17 12:25:10 volumio-x86 kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller Oct 17 12:25:10 volumio-x86 kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1 Oct 17 12:25:10 volumio-x86 kernel: xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x0000000000009810 Oct 17 12:25:10 volumio-x86 kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller Oct 17 12:25:10 volumio-x86 kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2 Oct 17 12:25:10 volumio-x86 kernel: xhci_hcd 0000:00:14.0: Host supports USB 3.0 SuperSpeed Oct 17 12:25:10 volumio-x86 kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Oct 17 12:25:10 volumio-x86 kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Oct 17 12:25:10 volumio-x86 kernel: usb usb1: Product: xHCI Host Controller Oct 17 12:25:10 volumio-x86 kernel: usb usb1: Manufacturer: Linux 6.6.32-volumio xhci-hcd Oct 17 12:25:10 volumio-x86 kernel: usb usb1: SerialNumber: 0000:00:14.0 Oct 17 12:25:10 volumio-x86 kernel: hub 1-0:1.0: USB hub found Oct 17 12:25:10 volumio-x86 kernel: hub 1-0:1.0: 6 ports detected Oct 17 12:25:10 volumio-x86 kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Oct 17 12:25:10 volumio-x86 kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Oct 17 12:25:10 volumio-x86 kernel: usb usb2: Product: xHCI Host Controller Oct 17 12:25:10 volumio-x86 kernel: usb usb2: Manufacturer: Linux 6.6.32-volumio xhci-hcd Oct 17 12:25:10 volumio-x86 kernel: usb usb2: SerialNumber: 0000:00:14.0 Oct 17 12:25:10 volumio-x86 kernel: hub 2-0:1.0: USB hub found Oct 17 12:25:10 volumio-x86 kernel: hub 2-0:1.0: 1 port detected Oct 17 12:25:10 volumio-x86 kernel: i8042: PNP: No PS/2 controller found. Oct 17 12:25:10 volumio-x86 kernel: mousedev: PS/2 mouse device common for all mice Oct 17 12:25:10 volumio-x86 kernel: rtc_cmos 00:00: RTC can wake from S4 Oct 17 12:25:10 volumio-x86 kernel: rtc_cmos 00:00: registered as rtc0 Oct 17 12:25:10 volumio-x86 kernel: rtc_cmos 00:00: setting system clock to 2024-10-17T04:24:53 UTC (1729139093) Oct 17 12:25:10 volumio-x86 kernel: rtc_cmos 00:00: alarms up to one month, y3k, 242 bytes nvram Oct 17 12:25:10 volumio-x86 kernel: i2c_dev: i2c /dev entries driver Oct 17 12:25:10 volumio-x86 kernel: platform eisa.0: Probing EISA bus 0 Oct 17 12:25:10 volumio-x86 kernel: platform eisa.0: EISA: Cannot allocate resource for mainboard Oct 17 12:25:10 volumio-x86 kernel: intel_pstate: Intel P-state driver initializing Oct 17 12:25:10 volumio-x86 kernel: ledtrig-cpu: registered to indicate activity on CPUs Oct 17 12:25:10 volumio-x86 kernel: efifb: probing for efifb Oct 17 12:25:10 volumio-x86 kernel: efifb: framebuffer at 0xc0000000, using 1920k, total 1920k Oct 17 12:25:10 volumio-x86 kernel: efifb: mode is 800x600x32, linelength=3200, pages=1 Oct 17 12:25:10 volumio-x86 kernel: efifb: scrolling: redraw Oct 17 12:25:10 volumio-x86 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Oct 17 12:25:10 volumio-x86 kernel: Console: switching to colour frame buffer device 100x37 Oct 17 12:25:10 volumio-x86 kernel: fb0: EFI VGA frame buffer device Oct 17 12:25:10 volumio-x86 kernel: NET: Registered PF_INET6 protocol family Oct 17 12:25:10 volumio-x86 kernel: Segment Routing with IPv6 Oct 17 12:25:10 volumio-x86 kernel: In-situ OAM (IOAM) with IPv6 Oct 17 12:25:10 volumio-x86 kernel: mip6: Mobile IPv6 Oct 17 12:25:10 volumio-x86 kernel: NET: Registered PF_PACKET protocol family Oct 17 12:25:10 volumio-x86 kernel: mpls_gso: MPLS GSO support Oct 17 12:25:10 volumio-x86 kernel: microcode: Microcode Update Driver: v2.2. Oct 17 12:25:10 volumio-x86 kernel: IPI shorthand broadcast: enabled Oct 17 12:25:10 volumio-x86 kernel: sched_clock: Marking stable (220007425, 1034700)->(277011766, -55969641) Oct 17 12:25:10 volumio-x86 kernel: Loading compiled-in X.509 certificates Oct 17 12:25:10 volumio-x86 kernel: usb 1-4: new high-speed USB device number 2 using xhci_hcd Oct 17 12:25:10 volumio-x86 kernel: clk: Disabling unused clocks Oct 17 12:25:10 volumio-x86 kernel: usb 1-4: New USB device found, idVendor=05e3, idProduct=0608, bcdDevice=85.36 Oct 17 12:25:10 volumio-x86 kernel: usb 1-4: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Oct 17 12:25:10 volumio-x86 kernel: usb 1-4: Product: USB2.0 Hub Oct 17 12:25:10 volumio-x86 kernel: hub 1-4:1.0: USB hub found Oct 17 12:25:10 volumio-x86 kernel: hub 1-4:1.0: 4 ports detected Oct 17 12:25:10 volumio-x86 kernel: usb 1-4.2: new high-speed USB device number 3 using xhci_hcd Oct 17 12:25:10 volumio-x86 kernel: usb 1-4.2: New USB device found, idVendor=16d0, idProduct=0a23, bcdDevice= 1.9b Oct 17 12:25:10 volumio-x86 kernel: usb 1-4.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Oct 17 12:25:10 volumio-x86 kernel: usb 1-4.2: Product: Combo384 Amanero Oct 17 12:25:10 volumio-x86 kernel: usb 1-4.2: Manufacturer: Amanero Technologies Oct 17 12:25:10 volumio-x86 kernel: usb 1-4.2: SerialNumber: 415-001 Oct 17 12:25:10 volumio-x86 kernel: Freeing initrd memory: 68108K Oct 17 12:25:10 volumio-x86 kernel: Freeing unused kernel image (initmem) memory: 2988K Oct 17 12:25:10 volumio-x86 kernel: Write protecting the kernel read-only data: 20480k Oct 17 12:25:10 volumio-x86 kernel: Freeing unused kernel image (rodata/data gap) memory: 1504K Oct 17 12:25:10 volumio-x86 kernel: Run /init as init process Oct 17 12:25:10 volumio-x86 kernel: with arguments: Oct 17 12:25:10 volumio-x86 kernel: /init Oct 17 12:25:10 volumio-x86 kernel: splash Oct 17 12:25:10 volumio-x86 kernel: with environment: Oct 17 12:25:10 volumio-x86 kernel: HOME=/ Oct 17 12:25:10 volumio-x86 kernel: TERM=linux Oct 17 12:25:10 volumio-x86 kernel: BOOT_IMAGE=/vmlinuz Oct 17 12:25:10 volumio-x86 kernel: biosdevname=0 Oct 17 12:25:10 volumio-x86 kernel: imgpart=UUID=d0822069-d48a-490f-b8bc-9970c0b6e384 Oct 17 12:25:10 volumio-x86 kernel: bootpart=UUID=1496-1547 Oct 17 12:25:10 volumio-x86 kernel: datapart=UUID=a0bf3376-7b72-4c09-9fc2-d0970ff7651c Oct 17 12:25:10 volumio-x86 kernel: hwdevice=x86 Oct 17 12:25:10 volumio-x86 kernel: uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg Oct 17 12:25:10 volumio-x86 kernel: imgfile=/volumio_current.sqsh Oct 17 12:25:10 volumio-x86 kernel: use_kmsg=no Oct 17 12:25:10 volumio-x86 kernel: ACPI: bus type drm_connector registered Oct 17 12:25:10 volumio-x86 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 17 12:25:10 volumio-x86 kernel: ahci 0000:00:13.0: version 3.0 Oct 17 12:25:10 volumio-x86 kernel: ahci 0000:00:13.0: controller can't do DEVSLP, turning off Oct 17 12:25:10 volumio-x86 kernel: ahci 0000:00:13.0: AHCI 0001.0300 32 slots 2 ports 3 Gbps 0x1 impl SATA mode Oct 17 12:25:10 volumio-x86 kernel: ahci 0000:00:13.0: flags: 64bit ncq pm led clo pio slum part deso Oct 17 12:25:10 volumio-x86 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Oct 17 12:25:10 volumio-x86 kernel: i2c i2c-0: 1/2 memory slots populated (from DMI) Oct 17 12:25:10 volumio-x86 kernel: i2c i2c-0: Successfully instantiated SPD at 0x50 Oct 17 12:25:10 volumio-x86 kernel: scsi host0: ahci Oct 17 12:25:10 volumio-x86 kernel: scsi host1: ahci Oct 17 12:25:10 volumio-x86 kernel: ata1: SATA max UDMA/133 abar m2048@0xd0815000 port 0xd0815100 irq 92 Oct 17 12:25:10 volumio-x86 kernel: ata2: DUMMY Oct 17 12:25:10 volumio-x86 kernel: ahci 0000:02:00.0: SSS flag set, parallel bus scan disabled Oct 17 12:25:10 volumio-x86 kernel: ahci 0000:02:00.0: AHCI 0001.0200 32 slots 2 ports 6 Gbps 0x3 impl SATA mode Oct 17 12:25:10 volumio-x86 kernel: ahci 0000:02:00.0: flags: 64bit ncq sntf stag led clo pmp pio slum part ccc sxs Oct 17 12:25:10 volumio-x86 kernel: scsi host2: ahci Oct 17 12:25:10 volumio-x86 kernel: scsi host3: ahci Oct 17 12:25:10 volumio-x86 kernel: ata3: SATA max UDMA/133 abar m512@0xd0610000 port 0xd0610100 irq 93 Oct 17 12:25:10 volumio-x86 kernel: ata4: SATA max UDMA/133 abar m512@0xd0610000 port 0xd0610180 irq 93 Oct 17 12:25:10 volumio-x86 kernel: ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Oct 17 12:25:10 volumio-x86 kernel: ata1.00: ATA-9: SanDisk SSD i100 16GB, 11.56.00, max UDMA/133 Oct 17 12:25:10 volumio-x86 kernel: ata1.00: 31277232 sectors, multi 1: LBA48 NCQ (depth 32) Oct 17 12:25:10 volumio-x86 kernel: ata1.00: configured for UDMA/133 Oct 17 12:25:10 volumio-x86 kernel: scsi 0:0:0:0: Direct-Access ATA SanDisk SSD i100 6.00 PQ: 0 ANSI: 5 Oct 17 12:25:10 volumio-x86 kernel: sd 0:0:0:0: [sda] 31277232 512-byte logical blocks: (16.0 GB/14.9 GiB) Oct 17 12:25:10 volumio-x86 kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 17 12:25:10 volumio-x86 kernel: sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 Oct 17 12:25:10 volumio-x86 kernel: ata3: SATA link down (SStatus 0 SControl 300) Oct 17 12:25:10 volumio-x86 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Oct 17 12:25:10 volumio-x86 kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 512 bytes Oct 17 12:25:10 volumio-x86 kernel: sda: sda1 sda2 sda3 Oct 17 12:25:10 volumio-x86 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 17 12:25:10 volumio-x86 kernel: ata4: SATA link down (SStatus 0 SControl 300) Oct 17 12:25:10 volumio-x86 kernel: r8169 0000:01:00.0: can't disable ASPM; OS doesn't have ASPM control Oct 17 12:25:10 volumio-x86 kernel: r8169 0000:01:00.0 eth0: RTL8168evl/8111evl, 00:e1:4c:68:20:1a, XID 2c9, IRQ 94 Oct 17 12:25:10 volumio-x86 kernel: r8169 0000:01:00.0 eth0: jumbo features [frames: 9194 bytes, tx checksumming: ko] Oct 17 12:25:10 volumio-x86 kernel: Console: switching to colour dummy device 80x25 Oct 17 12:25:10 volumio-x86 kernel: i915 0000:00:02.0: vgaarb: deactivate vga console Oct 17 12:25:10 volumio-x86 kernel: [drm] Initialized i915 1.6.0 20201103 for 0000:00:02.0 on minor 0 Oct 17 12:25:10 volumio-x86 kernel: ACPI: video: Video Device [GFX0] (multi-head: yes rom: no post: no) Oct 17 12:25:10 volumio-x86 kernel: input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input3 Oct 17 12:25:10 volumio-x86 kernel: fbcon: i915drmfb (fb0) is primary device Oct 17 12:25:10 volumio-x86 kernel: Console: switching to colour frame buffer device 128x48 Oct 17 12:25:10 volumio-x86 kernel: i915 0000:00:02.0: [drm] fb0: i915drmfb frame buffer device Oct 17 12:25:10 volumio-x86 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 17 12:25:10 volumio-x86 kernel: sdhci: Secure Digital Host Controller Interface driver Oct 17 12:25:10 volumio-x86 kernel: sdhci: Copyright(c) Pierre Ossman Oct 17 12:25:10 volumio-x86 kernel: usbcore: registered new interface driver usbhid Oct 17 12:25:10 volumio-x86 kernel: usbhid: USB HID core driver Oct 17 12:25:10 volumio-x86 kernel: fuse: init (API version 7.39) Oct 17 12:25:10 volumio-x86 kernel: usbcore: registered new interface driver usb-storage Oct 17 12:25:10 volumio-x86 kernel: usbcore: registered new interface driver uas Oct 17 12:25:10 volumio-x86 kernel: [drm] radeon kernel modesetting enabled. Oct 17 12:25:10 volumio-x86 kernel: scsi host4: pata_legacy Oct 17 12:25:10 volumio-x86 kernel: ata5: PATA max PIO4 cmd 0x1f0 ctl 0x3f6 irq 14 Oct 17 12:25:10 volumio-x86 kernel: scsi host4: pata_legacy Oct 17 12:25:10 volumio-x86 kernel: ata6: PATA max PIO4 cmd 0x170 ctl 0x376 irq 15 Oct 17 12:25:10 volumio-x86 kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Oct 17 12:25:10 volumio-x86 kernel: EXT4-fs (sda2): recovery complete Oct 17 12:25:10 volumio-x86 kernel: EXT4-fs (sda2): mounted filesystem d0822069-d48a-490f-b8bc-9970c0b6e384 r/w with ordered data mode. Quota mode: none. Oct 17 12:25:10 volumio-x86 kernel: loop: module loaded Oct 17 12:25:10 volumio-x86 kernel: block device autoloading is deprecated and will be removed. Oct 17 12:25:10 volumio-x86 kernel: loop0: detected capacity change from 0 to 1725048 Oct 17 12:25:10 volumio-x86 kernel: EXT4-fs (sda3): recovery complete Oct 17 12:25:10 volumio-x86 kernel: EXT4-fs (sda3): mounted filesystem a0bf3376-7b72-4c09-9fc2-d0970ff7651c r/w with ordered data mode. Quota mode: none. Oct 17 12:25:10 volumio-x86 kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038-01-19 (0x7fffffff) Oct 17 12:25:10 volumio-x86 systemd[1]: Inserted module 'autofs4' Oct 17 12:25:10 volumio-x86 kernel: efivars: duplicate variable: PCI_COMMON-aca9f304-21e2-4852-9875-7ff4881d67a5 Oct 17 12:25:10 volumio-x86 systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Oct 17 12:25:10 volumio-x86 systemd[1]: Detected architecture x86-64. Oct 17 12:25:10 volumio-x86 systemd[1]: Set hostname to . Oct 17 12:25:10 volumio-x86 systemd[1]: File /lib/systemd/system/systemd-journald.service:12 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling. Oct 17 12:25:10 volumio-x86 systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Oct 17 12:25:10 volumio-x86 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Oct 17 12:25:10 volumio-x86 systemd[1]: Created slice system-systemd\x2dfsck.slice. Oct 17 12:25:10 volumio-x86 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 17 12:25:10 volumio-x86 systemd[1]: Listening on udev Kernel Socket. Oct 17 12:25:10 volumio-x86 systemd[1]: Listening on Journal Socket. Oct 17 12:25:10 volumio-x86 systemd-journald[434]: Journal started Oct 17 12:25:10 volumio-x86 systemd-journald[434]: Runtime journal (/run/log/journal/b3b3dafc924fb5a631d5d74266e9a123) is 3.7M, max 30.0M, 26.2M free. Oct 17 12:25:10 volumio-x86 fake-hwclock[428]: Current system time: 2024-10-17 04:25:10 Oct 17 12:25:10 volumio-x86 fake-hwclock[428]: fake-hwclock saved clock information is in the past: 2024-10-17 04:24:43 Oct 17 12:25:10 volumio-x86 fake-hwclock[428]: To set system time to this saved clock anyway, use "force" Oct 17 12:25:10 volumio-x86 systemd[1]: Started Load/Save Random Seed. Oct 17 12:25:10 volumio-x86 systemd[1]: dynamicswap.service: Succeeded. Oct 17 12:25:10 volumio-x86 kernel: RPC: Registered named UNIX socket transport module. Oct 17 12:25:10 volumio-x86 kernel: RPC: Registered udp transport module. Oct 17 12:25:10 volumio-x86 kernel: RPC: Registered tcp transport module. Oct 17 12:25:10 volumio-x86 kernel: RPC: Registered tcp-with-tls transport module. Oct 17 12:25:10 volumio-x86 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Oct 17 12:25:10 volumio-x86 systemd[1]: Started Apply Kernel Variables. Oct 17 12:25:10 volumio-x86 systemd[1]: Mounted RPC Pipe File System. Oct 17 12:25:11 volumio-x86 systemd[1]: Started Create System Users. Oct 17 12:25:11 volumio-x86 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 17 12:25:11 volumio-x86 systemd[1]: Started Create Static Device Nodes in /dev. Oct 17 12:25:11 volumio-x86 systemd[1]: Starting udev Kernel Device Manager... Oct 17 12:25:11 volumio-x86 systemd[1]: Reached target Local File Systems (Pre). Oct 17 12:25:11 volumio-x86 systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Oct 17 12:25:11 volumio-x86 systemd[1]: Mounting /var/log... Oct 17 12:25:11 volumio-x86 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Oct 17 12:25:11 volumio-x86 systemd[1]: Mounting /tmp... Oct 17 12:25:11 volumio-x86 systemd[1]: Mounting /var/spool/cups... Oct 17 12:25:11 volumio-x86 systemd-udevd[455]: Network interface NamePolicy= disabled on kernel command line, ignoring. Oct 17 12:25:11 volumio-x86 systemd[1]: Mounted /var/log. Oct 17 12:25:11 volumio-x86 systemd[1]: Mounted /tmp. Oct 17 12:25:11 volumio-x86 systemd[1]: Mounted /var/spool/cups. Oct 17 12:25:11 volumio-x86 systemd[1]: Mounting /var/spool/cups/tmp... Oct 17 12:25:11 volumio-x86 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 17 12:25:11 volumio-x86 systemd[1]: Started udev Kernel Device Manager. Oct 17 12:25:11 volumio-x86 systemd[1]: Mounted /var/spool/cups/tmp. Oct 17 12:25:11 volumio-x86 systemd-journald[434]: Runtime journal (/run/log/journal/b3b3dafc924fb5a631d5d74266e9a123) is 3.7M, max 30.0M, 26.2M free. Oct 17 12:25:11 volumio-x86 systemd[1]: Started Flush Journal to Persistent Storage. Oct 17 12:25:11 volumio-x86 systemd[1]: Started udev Coldplug all Devices. Oct 17 12:25:11 volumio-x86 systemd[1]: Starting Show Plymouth Boot Screen... Oct 17 12:25:11 volumio-x86 systemd[1]: Starting Helper to synchronize boot up for ifupdown... Oct 17 12:25:11 volumio-x86 systemd[1]: Started Helper to synchronize boot up for ifupdown. Oct 17 12:25:11 volumio-x86 systemd[1]: plymouth-start.service: Succeeded. Oct 17 12:25:11 volumio-x86 systemd[1]: Started Show Plymouth Boot Screen. Oct 17 12:25:11 volumio-x86 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Oct 17 12:25:11 volumio-x86 systemd[1]: Reached target Paths. Oct 17 12:25:11 volumio-x86 systemd[1]: Reached target Local Encrypted Volumes. Oct 17 12:25:11 volumio-x86 systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Oct 17 12:25:11 volumio-x86 kernel: cryptd: max_cpu_qlen set to 1000 Oct 17 12:25:11 volumio-x86 kernel: mei_txe 0000:00:1a.0: can't derive routing for PCI INT A Oct 17 12:25:11 volumio-x86 kernel: mei_txe 0000:00:1a.0: PCI INT A: not connected Oct 17 12:25:12 volumio-x86 kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Oct 17 12:25:12 volumio-x86 systemd-udevd[466]: Using default interface naming scheme 'v240'. Oct 17 12:25:12 volumio-x86 kernel: at24 0-0050: supply vcc not found, using dummy regulator Oct 17 12:25:12 volumio-x86 kernel: at24 0-0050: 256 byte spd EEPROM, read-only Oct 17 12:25:12 volumio-x86 kernel: pstore: Using crash dump compression: deflate Oct 17 12:25:12 volumio-x86 systemd-udevd[466]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: Core ver 2.22 Oct 17 12:25:12 volumio-x86 kernel: NET: Registered PF_BLUETOOTH protocol family Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI device and connection manager initialized Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI socket layer initialized Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: L2CAP socket layer initialized Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: SCO socket layer initialized Oct 17 12:25:12 volumio-x86 kernel: pstore: Registered efi_pstore as persistent store backend Oct 17 12:25:12 volumio-x86 systemd-udevd[468]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 17 12:25:12 volumio-x86 systemd-udevd[465]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 17 12:25:12 volumio-x86 systemd-udevd[472]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 17 12:25:12 volumio-x86 systemd-udevd[473]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 17 12:25:12 volumio-x86 kernel: snd_hda_intel 0000:00:1b.0: bound 0000:00:02.0 (ops __SCT__tp_func_intel_frontbuffer_flush [i915]) Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI UART driver ver 2.3 Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI UART protocol H4 registered Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI UART protocol BCSP registered Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI UART protocol LL registered Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI UART protocol ATH3K registered Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI UART protocol Intel registered Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI UART protocol Broadcom registered Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI UART protocol QCA registered Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI UART protocol AG6XX registered Oct 17 12:25:12 volumio-x86 kernel: Bluetooth: HCI UART protocol Marvell registered Oct 17 12:25:12 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: ALC662 rev1: SKU not ready 0x411111f0 Oct 17 12:25:12 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC662 rev1: line_outs=1 (0x1b/0x0/0x0/0x0/0x0) type:line Oct 17 12:25:12 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Oct 17 12:25:12 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: hp_outs=1 (0x14/0x0/0x0/0x0/0x0) Oct 17 12:25:12 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0 Oct 17 12:25:12 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: inputs: Oct 17 12:25:12 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: Mic=0x18 Oct 17 12:25:12 volumio-x86 kernel: input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input4 Oct 17 12:25:12 volumio-x86 kernel: input: HDA Intel PCH HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input5 Oct 17 12:25:12 volumio-x86 systemd-udevd[473]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 17 12:25:12 volumio-x86 kernel: usb 1-4.2: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Oct 17 12:25:12 volumio-x86 kernel: usb 1-4.2: [10] FU [PCM Playback Volume] ch = 2, val = -32767/0/1 Oct 17 12:25:12 volumio-x86 kernel: usb 1-4.2: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Oct 17 12:25:12 volumio-x86 kernel: usb 1-4.2: [10] FU [PCM Playback Volume] ch = 1, val = -32767/0/1 Oct 17 12:25:12 volumio-x86 kernel: usbcore: registered new interface driver snd-usb-audio Oct 17 12:25:12 volumio-x86 systemd[1]: Found device SanDisk_SSD_i100_16GB boot. Oct 17 12:25:13 volumio-x86 systemd-udevd[465]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 17 12:25:13 volumio-x86 systemd-udevd[460]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 17 12:25:13 volumio-x86 kernel: alsactl[559]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Oct 17 12:25:13 volumio-x86 systemd-udevd[474]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Oct 17 12:25:13 volumio-x86 systemd[1]: Condition check resulted in RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller being skipped. Oct 17 12:25:13 volumio-x86 systemd[1]: Starting Show Plymouth Boot Screen... Oct 17 12:25:13 volumio-x86 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 17 12:25:13 volumio-x86 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 17 12:25:13 volumio-x86 systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Oct 17 12:25:13 volumio-x86 systemd[1]: Starting File System Check on /dev/disk/by-uuid/1496-1547... Oct 17 12:25:14 volumio-x86 systemd[1]: plymouth-start.service: Succeeded. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Show Plymouth Boot Screen. Oct 17 12:25:14 volumio-x86 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Oct 17 12:25:14 volumio-x86 systemd[1]: Started File System Check Daemon to report status. Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: fsck.fat 4.1 (2017-01-24) Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: There are differences between boot sector and its backup. Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: This is mostly harmless. Differences: (offset:original/backup) Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: 3:53/6d, 4:59/6b, 5:53/66, 6:4c/73, 7:49/2e, 8:4e/66, 9:55/61, 10:58/74 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 90:fa/0e, 91:fc/1f, 92:31/be, 93:c9/77, 94:8e/7c, 95:d1/ac, 96:bc/22 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 97:76/c0, 98:7b/74, 99:52/0b, 100:06/56, 101:57/b4, 102:1e/0e, 103:56/bb Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 104:8e/07, 105:c1/00, 106:b1/cd, 107:26/10, 108:bf/5e, 109:78/eb Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 110:7b/f0, 111:f3/32, 112:a5/e4, 113:8e/cd, 114:d9/16, 115:bb/cd Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 116:78/19, 117:00/eb, 118:0f/fe, 119:b4/54, 120:37/68, 121:0f/69 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 122:a0/73, 123:56/20, 124:20/69, 125:d2/73, 126:78/20, 127:1b/6e Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 128:31/6f, 129:c0/74, 130:b1/20, 131:06/61, 132:89/20, 133:3f/62 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 134:89/6f, 135:47/6f, 136:02/74, 137:f3/61, 138:64/62, 139:a5/6c Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 140:8a/65, 141:0e/20, 142:18/64, 143:7c/69, 144:88/73, 145:4d/6b Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 146:f8/2e, 147:50/20, 148:50/20, 150:50/6c, 151:cd/65, 152:13/61 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 153:eb/73, 154:62/65, 155:8b/20, 156:55/69, 157:aa/6e, 158:8b/73 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 159:75/65, 160:a8/72, 161:c1/74, 162:ee/20, 163:04/61, 164:01/20 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 165:f2/62, 166:83/6f, 167:fa/6f, 168:4f/74, 169:76/61, 170:31/62 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 171:81/6c, 172:fa/65, 173:b2/20, 174:07/66, 175:73/6c, 176:2b/6f Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 177:f6/70, 178:45/70, 179:b4/79, 180:7f/20, 181:75/61, 182:25/6e Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 183:38/64, 184:4d/0d, 185:b8/0a, 186:74/70, 187:20/72, 188:66/65 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 189:3d/73, 190:21/73, 191:47/20, 192:50/61, 193:54/6e, 194:75/79 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 195:10/20, 196:80/6b, 197:7d/65, 198:b8/79, 199:ed/20, 200:75/74 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 201:0a/6f, 202:66/20, 203:ff/74, 204:75/72, 205:ec/79, 206:66/20 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 207:ff/61, 208:75/67, 209:e8/61, 210:eb/69, 211:0f/6e, 212:51/20 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 213:51/2e, 214:66/2e, 215:ff/2e, 216:75/20, 217:bc/0d, 218:eb/0a Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 219:07/00, 220:51/00, 221:51/00, 222:66/00, 223:ff/00, 224:36/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 225:1c/00, 226:7c/00, 227:b4/00, 228:08/00, 229:e8/00, 230:e9/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 232:72/00, 233:13/00, 234:20/00, 235:e4/00, 236:75/00, 237:0f/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 238:c1/00, 239:ea/00, 240:08/00, 241:42/00, 242:89/00, 243:16/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 244:1a/00, 245:7c/00, 246:83/00, 247:e1/00, 248:3f/00, 249:89/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 250:0e/00, 251:18/00, 252:7c/00, 253:fb/00, 254:bb/00, 255:aa/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 256:55/00, 257:b4/00, 258:41/00, 259:e8/00, 260:cb/00, 262:72/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 263:10/00, 264:81/00, 265:fb/00, 266:55/00, 267:aa/00, 268:75/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 269:0a/00, 270:f6/00, 271:c1/00, 272:01/00, 273:74/00, 274:05/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 275:c6/00, 276:06/00, 277:46/00, 278:7d/00, 280:66/00, 281:b8/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 282:c6/00, 283:9b/00, 286:66/00, 287:ba/00, 292:bb/00, 294:80/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 295:e8/00, 296:0e/00, 298:66/00, 299:81/00, 300:3e/00, 301:1c/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 302:80/00, 303:d5/00, 304:cf/00, 305:c7/00, 306:62/00, 307:75/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 308:74/00, 309:e9/00, 310:f8/00, 311:02/00, 312:66/00, 313:03/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 314:06/00, 315:60/00, 316:7b/00, 317:66/00, 318:13/00, 319:16/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 320:64/00, 321:7b/00, 322:b9/00, 323:10/00, 325:eb/00, 326:2b/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 327:66/00, 328:52/00, 329:66/00, 330:50/00, 331:06/00, 332:53/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 333:6a/00, 334:01/00, 335:6a/00, 336:10/00, 337:89/00, 338:e6/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 339:66/00, 340:60/00, 341:b4/00, 342:42/00, 343:e8/00, 344:77/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 346:66/00, 347:61/00, 348:8d/00, 349:64/00, 350:10/00, 351:72/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 352:01/00, 353:c3/00, 354:66/00, 355:60/00, 356:31/00, 357:c0/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 358:e8/00, 359:68/00, 361:66/00, 362:61/00, 363:e2/00, 364:da/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 365:c6/00, 366:06/00, 367:46/00, 368:7d/00, 369:2b/00, 370:66/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 371:60/00, 372:66/00, 373:0f/00, 374:b7/00, 375:36/00, 376:18/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 377:7c/00, 378:66/00, 379:0f/00, 380:b7/00, 381:3e/00, 382:1a/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 383:7c/00, 384:66/00, 385:f7/00, 386:f6/00, 387:31/00, 388:c9/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 389:87/00, 390:ca/00, 391:66/00, 392:f7/00, 393:f7/00, 394:66/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 395:3d/00, 396:ff/00, 397:03/00, 400:77/00, 401:17/00, 402:c0/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 403:e4/00, 404:06/00, 405:41/00, 406:08/00, 407:e1/00, 408:88/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 409:c5/00, 410:88/00, 411:d6/00, 412:b8/00, 413:01/00, 414:02/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 415:e8/00, 416:2f/00, 418:66/00, 419:61/00, 420:72/00, 421:01/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 422:c3/00, 423:e2/00, 424:c9/00, 425:31/00, 426:f6/00, 427:8e/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 428:d6/00, 429:bc/00, 430:68/00, 431:7b/00, 432:8e/00, 433:de/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 434:66/00, 435:8f/00, 436:06/00, 437:78/00, 439:be/00, 440:da/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 441:7d/00, 442:ac/00, 443:20/00, 444:c0/00, 445:74/00, 446:09/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 447:b4/00, 448:0e/00, 449:bb/00, 450:07/00, 452:cd/00, 453:10/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 454:eb/00, 455:f2/00, 456:31/00, 457:c0/00, 458:cd/00, 459:16/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 460:cd/00, 461:19/00, 462:f4/00, 463:eb/00, 464:fd/00, 465:8a/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 466:16/00, 467:74/00, 468:7b/00, 469:06/00, 470:cd/00, 471:13/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 472:07/00, 473:c3/00, 474:42/00, 475:6f/00, 476:6f/00, 477:74/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 478:20/00, 479:65/00, 480:72/00, 481:72/00, 482:6f/00, 483:72/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 484:0d/00, 485:0a/00, 504:fe/00, 505:02/00, 506:b2/00, 507:3e/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: , 508:18/00, 509:37/00 Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: Not automatically fixing this. Oct 17 12:25:14 volumio-x86 systemd-fsck[568]: /dev/sda1: 18 files, 159612/344788 clusters Oct 17 12:25:14 volumio-x86 systemd[1]: Started File System Check on /dev/disk/by-uuid/1496-1547. Oct 17 12:25:14 volumio-x86 systemd[1]: Mounting /boot... Oct 17 12:25:14 volumio-x86 kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Oct 17 12:25:14 volumio-x86 systemd[1]: Mounted /boot. Oct 17 12:25:14 volumio-x86 systemd[1]: Reached target Local File Systems. Oct 17 12:25:14 volumio-x86 systemd[1]: Starting Preprocess NFS configuration... Oct 17 12:25:14 volumio-x86 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 17 12:25:14 volumio-x86 systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Oct 17 12:25:14 volumio-x86 systemd[1]: Starting Raise network interfaces... Oct 17 12:25:14 volumio-x86 systemd[1]: Starting Create Volatile Files and Directories... Oct 17 12:25:14 volumio-x86 systemd[1]: Started ifup for eth0. Oct 17 12:25:14 volumio-x86 systemd[1]: plymouth-read-write.service: Succeeded. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Oct 17 12:25:14 volumio-x86 systemd[1]: nfs-config.service: Succeeded. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Preprocess NFS configuration. Oct 17 12:25:14 volumio-x86 systemd[1]: Received SIGRTMIN+20 from PID 318 (plymouthd). Oct 17 12:25:14 volumio-x86 systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Oct 17 12:25:14 volumio-x86 systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Oct 17 12:25:14 volumio-x86 systemd[1]: Reached target NFS client services. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Create Volatile Files and Directories. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Oct 17 12:25:14 volumio-x86 systemd[1]: Starting Update UTMP about System Boot/Shutdown... Oct 17 12:25:14 volumio-x86 systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Oct 17 12:25:14 volumio-x86 systemd[1]: Starting RPC bind portmap service... Oct 17 12:25:14 volumio-x86 kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Oct 17 12:25:14 volumio-x86 systemd[1]: Started RPC bind portmap service. Oct 17 12:25:14 volumio-x86 systemd[1]: Reached target RPC Port Mapper. Oct 17 12:25:14 volumio-x86 systemd[1]: Reached target Remote File Systems (Pre). Oct 17 12:25:14 volumio-x86 systemd[1]: Reached target Remote File Systems. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Update UTMP about System Boot/Shutdown. Oct 17 12:25:14 volumio-x86 systemd[1]: Reached target System Initialization. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 17 12:25:14 volumio-x86 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Daily apt download activities. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Daily apt upgrade and clean activities. Oct 17 12:25:14 volumio-x86 systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Daily man-db regeneration. Oct 17 12:25:14 volumio-x86 systemd[1]: Reached target Timers. Oct 17 12:25:14 volumio-x86 systemd[1]: Listening on triggerhappy.socket. Oct 17 12:25:14 volumio-x86 systemd[1]: Reached target Sockets. Oct 17 12:25:14 volumio-x86 systemd[1]: Reached target Basic System. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Volumio Iptables Module. Oct 17 12:25:14 volumio-x86 systemd[1]: Starting Wireless Services... Oct 17 12:25:14 volumio-x86 systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Oct 17 12:25:14 volumio-x86 systemd[1]: Starting Login Service... Oct 17 12:25:14 volumio-x86 systemd[1]: Started volumio-remote-updater.service. Oct 17 12:25:14 volumio-x86 kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Oct 17 12:25:14 volumio-x86 kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Oct 17 12:25:14 volumio-x86 systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Oct 17 12:25:14 volumio-x86 systemd[1]: Started UPnP Renderer front-end to MPD. Oct 17 12:25:14 volumio-x86 systemd[1]: Started Manage Sound Card State (restore and store). Oct 17 12:25:14 volumio-x86 systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Oct 17 12:25:14 volumio-x86 systemd[1]: Starting Save/Restore Sound Card State... Oct 17 12:25:14 volumio-x86 systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Oct 17 12:25:14 volumio-x86 systemd[1]: Started Volumio Log Rotation Service. Oct 17 12:25:14 volumio-x86 ifup[577]: command failed: No such device (-19) Oct 17 12:25:14 volumio-x86 systemd[1]: Started My Shell Script. Oct 17 12:25:14 volumio-x86 systemd[1]: Started D-Bus System Message Bus. Oct 17 12:25:14 volumio-x86 systemd[1]: Starting WPA supplicant... Oct 17 12:25:14 volumio-x86 systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Oct 17 12:25:14 volumio-x86 systemd[1]: Starting triggerhappy global hotkey daemon... Oct 17 12:25:14 volumio-x86 sh[581]: command failed: No such device (-19) Oct 17 12:25:14 volumio-x86 systemd[1]: Starting DHCP Client Daemon... Oct 17 12:25:14 volumio-x86 alsactl[615]: alsactl 1.1.8 daemon started Oct 17 12:25:14 volumio-x86 thd[623]: Unable to parse trigger line: Oct 17 12:25:14 volumio-x86 thd[623]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Oct 17 12:25:14 volumio-x86 thd[623]: Unable to parse trigger line: Oct 17 12:25:14 volumio-x86 thd[623]: Found socket passed from systemd Oct 17 12:25:14 volumio-x86 systemd-logind[606]: New seat seat0. Oct 17 12:25:14 volumio-x86 avahi-daemon[608]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Oct 17 12:25:14 volumio-x86 avahi-daemon[608]: Successfully dropped root privileges. Oct 17 12:25:14 volumio-x86 avahi-daemon[608]: avahi-daemon 0.7 starting up. Oct 17 12:25:15 volumio-x86 systemd-logind[606]: Watching system buttons on /dev/input/event2 (Power Button) Oct 17 12:25:15 volumio-x86 systemd-logind[606]: Watching system buttons on /dev/input/event0 (Power Button) Oct 17 12:25:15 volumio-x86 systemd-logind[606]: Watching system buttons on /dev/input/event1 (Sleep Button) Oct 17 12:25:15 volumio-x86 sh[581]: sending commands to master dhcpcd process Oct 17 12:25:15 volumio-x86 dhcpcd[647]: sending commands to master dhcpcd process Oct 17 12:25:15 volumio-x86 kernel: 8021q: 802.1Q VLAN Support v1.8 Oct 17 12:25:15 volumio-x86 ifup[577]: command failed: No such device (-19) Oct 17 12:25:15 volumio-x86 volumio-remote-updater[607]: Error: No active session Oct 17 12:25:15 volumio-x86 volumio-remote-updater[607]: [2024-10-17 12:25:15] [info] asio async_connect error: system:111 (Connection refused) Oct 17 12:25:15 volumio-x86 volumio-remote-updater[607]: [2024-10-17 12:25:15] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 17 12:25:15 volumio-x86 volumio-remote-updater[607]: [2024-10-17 12:25:15] [error] handle_connect error: Underlying Transport Error Oct 17 12:25:15 volumio-x86 dhcpcd[624]: no interfaces have a carrier Oct 17 12:25:15 volumio-x86 dhcpcd[624]: no interfaces have a carrier Oct 17 12:25:15 volumio-x86 systemd[1]: Started triggerhappy global hotkey daemon. Oct 17 12:25:15 volumio-x86 dhcpcd[624]: forked to background, child pid 711 Oct 17 12:25:15 volumio-x86 dhcpcd[624]: forked to background, child pid 711 Oct 17 12:25:15 volumio-x86 systemd[1]: Started Save/Restore Sound Card State. Oct 17 12:25:15 volumio-x86 systemd[1]: Started DHCP Client Daemon. Oct 17 12:25:15 volumio-x86 avahi-daemon[608]: Successfully called chroot(). Oct 17 12:25:15 volumio-x86 avahi-daemon[608]: Successfully dropped remaining capabilities. Oct 17 12:25:15 volumio-x86 avahi-daemon[608]: Loading service file /services/volumio.service. Oct 17 12:25:15 volumio-x86 kernel: RTL8211E Gigabit Ethernet r8169-0-100:00: attached PHY driver (mii_bus:phy_addr=r8169-0-100:00, irq=MAC) Oct 17 12:25:15 volumio-x86 wpa_supplicant[622]: Successfully initialized wpa_supplicant Oct 17 12:25:15 volumio-x86 volumio[611]: Could not open config: /tmp/upmpdcli.conf Oct 17 12:25:15 volumio-x86 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 17 12:25:15 volumio-x86 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 17 12:25:15 volumio-x86 systemd[1]: iptables.service: Succeeded. Oct 17 12:25:15 volumio-x86 sh[581]: eth0=eth0 Oct 17 12:25:15 volumio-x86 systemd[1]: Started Login Service. Oct 17 12:25:15 volumio-x86 systemd[1]: Started Avahi mDNS/DNS-SD Stack. Oct 17 12:25:15 volumio-x86 systemd[1]: Started WPA supplicant. Oct 17 12:25:15 volumio-x86 systemd[1]: Reached target Sound Card. Oct 17 12:25:15 volumio-x86 systemd[1]: Started Raise network interfaces. Oct 17 12:25:15 volumio-x86 systemd[1]: Reached target Network. Oct 17 12:25:15 volumio-x86 systemd[1]: Starting Network Time Service... Oct 17 12:25:15 volumio-x86 systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Oct 17 12:25:15 volumio-x86 haveged[597]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K Oct 17 12:25:15 volumio-x86 haveged[597]: haveged: cpu: (L4 VC); data: 24K (L4 V); inst: 32K (L4 V); idx: 24/40; sz: 31410/52825 Oct 17 12:25:15 volumio-x86 haveged[597]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99768 Oct 17 12:25:15 volumio-x86 haveged[597]: haveged: fills: 0, generated: 0 Oct 17 12:25:15 volumio-x86 systemd[1]: Starting Permit User Sessions... Oct 17 12:25:15 volumio-x86 systemd[1]: Reached target Network is Online. Oct 17 12:25:15 volumio-x86 systemd[1]: Starting Samba NMB Daemon... Oct 17 12:25:16 volumio-x86 kernel: r8169 0000:01:00.0 eth0: Link is Down Oct 17 12:25:16 volumio-x86 systemd[1]: Starting LSB: Brings up/down network automatically... Oct 17 12:25:15 volumio-x86 dhcpcd[711]: eth0: waiting for carrier Oct 17 12:25:15 volumio-x86 dhcpcd[711]: eth0: carrier acquired Oct 17 12:25:16 volumio-x86 systemd[1]: Starting /etc/rc.local Compatibility... Oct 17 12:25:15 volumio-x86 avahi-daemon[608]: Network interface enumeration completed. Oct 17 12:25:16 volumio-x86 avahi-daemon[608]: Server startup complete. Host name is volumio-x86.local. Local service cookie is 1749923912. Oct 17 12:25:16 volumio-x86 avahi-daemon[608]: Service "Volumio X86" (/services/volumio.service) successfully established. Oct 17 12:25:16 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:25:16 volumio-x86 systemd[1]: Started Permit User Sessions. Oct 17 12:25:16 volumio-x86 dhcpcd[711]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09 Oct 17 12:25:16 volumio-x86 dhcpcd[711]: eth0: IAID 4c:68:20:1a Oct 17 12:25:16 volumio-x86 dhcpcd[711]: eth0: adding address fe80::fc2f:692e:14ff:cbd7 Oct 17 12:25:16 volumio-x86 dhcpcd[711]: ipv6_addaddr1: Permission denied Oct 17 12:25:16 volumio-x86 dhcpcd[711]: control command: /sbin/dhcpcd eth0 Oct 17 12:25:16 volumio-x86 dhcpcd[711]: eth0: carrier lost Oct 17 12:25:16 volumio-x86 systemd[1]: Started /etc/rc.local Compatibility. Oct 17 12:25:16 volumio-x86 systemd[1]: Starting Hold until boot process finishes up... Oct 17 12:25:16 volumio-x86 systemd[1]: Starting Terminate Plymouth Boot Screen... Oct 17 12:25:16 volumio-x86 systemd[1]: Received SIGRTMIN+21 from PID 318 (plymouthd). Oct 17 12:25:16 volumio-x86 ntpd[750]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 17 12:25:16 volumio-x86 ntpd[750]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 17 12:25:16 volumio-x86 systemd[1]: Started Network Time Service. Oct 17 12:25:16 volumio-x86 systemd[1]: plymouth-quit-wait.service: Succeeded. Oct 17 12:25:16 volumio-x86 systemd[1]: Started Hold until boot process finishes up. Oct 17 12:25:16 volumio-x86 loadcpufreq[617]: Loading cpufreq kernel modules...done (acpi-cpufreq). Oct 17 12:25:16 volumio-x86 systemd[1]: plymouth-quit.service: Succeeded. Oct 17 12:25:16 volumio-x86 ntpd[795]: proto: precision = 0.264 usec (-22) Oct 17 12:25:16 volumio-x86 systemd[1]: Started Terminate Plymouth Boot Screen. Oct 17 12:25:16 volumio-x86 systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Oct 17 12:25:16 volumio-x86 systemd[1]: Received SIGRTMIN+21 from PID 318 (n/a). Oct 17 12:25:16 volumio-x86 ntpd[795]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 17 12:25:16 volumio-x86 ntpd[795]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 17 12:25:16 volumio-x86 ntpd[795]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 660 days ago Oct 17 12:25:16 volumio-x86 ntpd[795]: Listen and drop on 0 v6wildcard [::]:123 Oct 17 12:25:16 volumio-x86 ntpd[795]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 17 12:25:16 volumio-x86 ntpd[795]: Listen normally on 2 lo 127.0.0.1:123 Oct 17 12:25:16 volumio-x86 ntpd[795]: Listening on routing socket on fd #19 for interface updates Oct 17 12:25:16 volumio-x86 ntpd[795]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 17 12:25:16 volumio-x86 ntpd[795]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 17 12:25:16 volumio-x86 systemd[1]: Starting LSB: set CPUFreq kernel parameters... Oct 17 12:25:16 volumio-x86 systemd[1]: Started Getty on tty1. Oct 17 12:25:16 volumio-x86 systemd[1]: Reached target Login Prompts. Oct 17 12:25:16 volumio-x86 ifplugd(eth0)[809]: ifplugd 0.28 initializing. Oct 17 12:25:16 volumio-x86 ifplugd(eth0)[809]: Using interface eth0/00:E1:4C:68:20:1A with driver (version: 6.6.32-volumio) Oct 17 12:25:16 volumio-x86 ifplugd(eth0)[809]: Using detection mode: SIOCETHTOOL Oct 17 12:25:16 volumio-x86 ifplugd(eth0)[809]: Initialization complete, link beat not detected. Oct 17 12:25:16 volumio-x86 cpufrequtils[800]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Oct 17 12:25:16 volumio-x86 systemd[1]: Started LSB: set CPUFreq kernel parameters. Oct 17 12:25:16 volumio-x86 ifplugd[759]: Network Interface Plugging Daemon...start eth0...done. Oct 17 12:25:16 volumio-x86 systemd[1]: Started LSB: Brings up/down network automatically. Oct 17 12:25:16 volumio-x86 nmbd[769]: [2024/10/17 12:25:16.891054, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Oct 17 12:25:16 volumio-x86 nmbd[769]: started asyncdns process 824 Oct 17 12:25:16 volumio-x86 nmbd[769]: [2024/10/17 12:25:16.895069, 0] ../lib/util/become_daemon.c:149(daemon_status) Oct 17 12:25:16 volumio-x86 nmbd[769]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Oct 17 12:25:16 volumio-x86 nmbd[769]: [2024/10/17 12:25:16.895239, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Oct 17 12:25:16 volumio-x86 nmbd[769]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Oct 17 12:25:17 volumio-x86 wireless.js[605]: WIRELESS: No wireless interface, exiting Oct 17 12:25:17 volumio-x86 iw[829]: command failed: No such device (-19) Oct 17 12:25:17 volumio-x86 iwconfig[832]: Error for wireless request "Set Power Management" (8B2C) : Oct 17 12:25:17 volumio-x86 iwconfig[832]: SET failed on device wlan0 ; No such device. Oct 17 12:25:17 volumio-x86 systemd[1]: wireless.service: Succeeded. Oct 17 12:25:17 volumio-x86 systemd[1]: Started Wireless Services. Oct 17 12:25:17 volumio-x86 systemd[1]: Started Volumio Backend Module. Oct 17 12:25:17 volumio-x86 systemd[1]: Started Intel SST and HDA soundcard init service. Oct 17 12:25:17 volumio-x86 systemd[1]: Started Volumio Cpu Tweaker. Oct 17 12:25:17 volumio-x86 systemd[1]: Started Start Volumio Kiosk. Oct 17 12:25:17 volumio-x86 ntpd[795]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Oct 17 12:25:17 volumio-x86 volumio-cpu-tweak[837]: Setting RT Priority for mpd Oct 17 12:25:17 volumio-x86 volumio-cpu-tweak[837]: pid 35's current scheduling policy: SCHED_OTHER Oct 17 12:25:17 volumio-x86 volumio-cpu-tweak[837]: pid 35's current scheduling priority: 0 Oct 17 12:25:17 volumio-x86 volumio-cpu-tweak[837]: Not enough cores to set MPD affinity Oct 17 12:25:17 volumio-x86 volumio-cpu-tweak[837]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Oct 17 12:25:17 volumio-x86 systemd[1]: volumio_cpu_tweak.service: Succeeded. Oct 17 12:25:17 volumio-x86 startx[844]: X.Org X Server 1.20.4 Oct 17 12:25:17 volumio-x86 startx[844]: X Protocol Version 11, Revision 0 Oct 17 12:25:17 volumio-x86 startx[844]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Oct 17 12:25:17 volumio-x86 startx[844]: Current Operating System: Linux volumio-x86 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Oct 17 12:25:17 volumio-x86 startx[844]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=d0822069-d48a-490f-b8bc-9970c0b6e384 bootpart=UUID=1496-1547 datapart=UUID=a0bf3376-7b72-4c09-9fc2-d0970ff7651c hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no Oct 17 12:25:17 volumio-x86 startx[844]: Build Date: 18 December 2021 09:05:36AM Oct 17 12:25:17 volumio-x86 startx[844]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Oct 17 12:25:17 volumio-x86 startx[844]: Current version of pixman: 0.36.0 Oct 17 12:25:17 volumio-x86 startx[844]: Before reporting problems, check http://wiki.x.org Oct 17 12:25:17 volumio-x86 startx[844]: to make sure that you have the latest version. Oct 17 12:25:17 volumio-x86 startx[844]: Markers: (--) probed, (**) from config file, (==) default setting, Oct 17 12:25:17 volumio-x86 startx[844]: (++) from command line, (!!) notice, (II) informational, Oct 17 12:25:17 volumio-x86 startx[844]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Oct 17 12:25:17 volumio-x86 startx[844]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu Oct 17 12:25:17 2024 Oct 17 12:25:17 volumio-x86 startx[844]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Oct 17 12:25:18 volumio-x86 ntpd[795]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Oct 17 12:25:18 volumio-x86 kernel: r8169 0000:01:00.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx Oct 17 12:25:18 volumio-x86 dhcpcd[711]: eth0: carrier acquired Oct 17 12:25:18 volumio-x86 dhcpcd[711]: eth0: IAID 4c:68:20:1a Oct 17 12:25:18 volumio-x86 ifplugd(eth0)[809]: Link beat detected. Oct 17 12:25:18 volumio-x86 kernel: broken atomic modeset userspace detected, disabling atomic Oct 17 12:25:18 volumio-x86 ifplugd(eth0)[809]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 17 12:25:18 volumio-x86 ifplugd(eth0)[809]: client: ifup: interface eth0 already configured Oct 17 12:25:18 volumio-x86 ifplugd(eth0)[809]: Program executed successfully. Oct 17 12:25:18 volumio-x86 systemd[1]: soundcard-init.service: Succeeded. Oct 17 12:25:18 volumio-x86 startx[844]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Oct 17 12:25:19 volumio-x86 dhcpcd[711]: eth0: soliciting a DHCP lease Oct 17 12:25:19 volumio-x86 ntpd[795]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Oct 17 12:25:19 volumio-x86 dhcpcd[711]: eth0: soliciting an IPv6 router Oct 17 12:25:20 volumio-x86 dhcpcd[711]: eth0: offered 192.168.10.112 from 192.168.10.1 `HomeVPN' Oct 17 12:25:20 volumio-x86 dhcpcd[711]: eth0: probing address 192.168.10.112/24 Oct 17 12:25:20 volumio-x86 volumio[835]: info: ------------------------------------------- Oct 17 12:25:20 volumio-x86 volumio[835]: info: ----- Volumio3 ---- Oct 17 12:25:20 volumio-x86 volumio[835]: info: ------------------------------------------- Oct 17 12:25:20 volumio-x86 volumio[835]: info: ----- System startup ---- Oct 17 12:25:20 volumio-x86 volumio[835]: info: ------------------------------------------- Oct 17 12:25:20 volumio-x86 ntpd[795]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Oct 17 12:25:20 volumio-x86 volumio-remote-updater[607]: [2024-10-17 12:25:20] [connect] Successful connection Oct 17 12:25:22 volumio-x86 volumio[835]: info: MYVOLUMIO Environment detected Oct 17 12:25:22 volumio-x86 volumio[835]: info: Plugin folders cleanup Oct 17 12:25:22 volumio-x86 volumio[835]: info: Scanning into folder /volumio/app/plugins/ Oct 17 12:25:22 volumio-x86 volumio[835]: info: Scanning category audio_interface Oct 17 12:25:22 volumio-x86 volumio[835]: info: Scanning category miscellanea Oct 17 12:25:22 volumio-x86 volumio[835]: info: Scanning category music_service Oct 17 12:25:22 volumio-x86 volumio[835]: info: Scanning category plugins.json Oct 17 12:25:22 volumio-x86 volumio[835]: info: Scanning category system_controller Oct 17 12:25:22 volumio-x86 volumio[835]: info: Scanning category user_interface Oct 17 12:25:22 volumio-x86 volumio[835]: info: Scanning into folder /data/plugins/ Oct 17 12:25:22 volumio-x86 volumio[835]: info: Scanning category user_interface Oct 17 12:25:22 volumio-x86 volumio[835]: info: Plugin folders cleanup completed Oct 17 12:25:22 volumio-x86 volumio[835]: info: ------------------------------------------- Oct 17 12:25:22 volumio-x86 volumio[835]: info: ----- Core plugins startup ---- Oct 17 12:25:22 volumio-x86 volumio[835]: info: ------------------------------------------- Oct 17 12:25:22 volumio-x86 volumio[835]: info: Loading plugins from folder /volumio/app/plugins/ Oct 17 12:25:22 volumio-x86 volumio[835]: info: Adding plugin upnp to MyMusic Plugins Oct 17 12:25:22 volumio-x86 volumio[835]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 17 12:25:22 volumio-x86 volumio[835]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 17 12:25:22 volumio-x86 volumio[835]: info: Loading plugins from folder /data/plugins/ Oct 17 12:25:22 volumio-x86 volumio[835]: info: Loading plugin "system"... Oct 17 12:25:22 volumio-x86 volumio[835]: info: Loading plugin "appearance"... Oct 17 12:25:24 volumio-x86 dhcpcd[711]: eth0: leased 192.168.10.112 for 14400 seconds Oct 17 12:25:24 volumio-x86 dhcpcd[711]: eth0: adding route to 192.168.10.0/24 Oct 17 12:25:24 volumio-x86 dhcpcd[711]: eth0: adding default route via 192.168.10.1 Oct 17 12:25:24 volumio-x86 avahi-daemon[608]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.10.112. Oct 17 12:25:24 volumio-x86 avahi-daemon[608]: New relevant interface eth0.IPv4 for mDNS. Oct 17 12:25:24 volumio-x86 avahi-daemon[608]: Registering new address record for 192.168.10.112 on eth0.IPv4. Oct 17 12:25:25 volumio-x86 volumio[835]: info: Loading plugin "network"... Oct 17 12:25:25 volumio-x86 ntpd[795]: ntpd exiting on signal 15 (Terminated) Oct 17 12:25:25 volumio-x86 systemd[1]: Stopping Network Time Service... Oct 17 12:25:25 volumio-x86 systemd[1]: ntp.service: Succeeded. Oct 17 12:25:25 volumio-x86 volumio[835]: info: Refreshing Cached IP Addresses Oct 17 12:25:25 volumio-x86 systemd[1]: Stopped Network Time Service. Oct 17 12:25:25 volumio-x86 systemd[1]: Starting Network Time Service... Oct 17 12:25:25 volumio-x86 volumio[835]: info: Loading plugin "services"... Oct 17 12:25:25 volumio-x86 ntpd[1103]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 17 12:25:25 volumio-x86 volumio[835]: info: Loading plugin "alsa_controller"... Oct 17 12:25:25 volumio-x86 ntpd[1103]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 17 12:25:25 volumio-x86 systemd[1]: Started Network Time Service. Oct 17 12:25:25 volumio-x86 ntpd[1115]: proto: precision = 0.264 usec (-22) Oct 17 12:25:25 volumio-x86 ntpd[1115]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 17 12:25:25 volumio-x86 ntpd[1115]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 17 12:25:25 volumio-x86 ntpd[1115]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 660 days ago Oct 17 12:25:25 volumio-x86 ntpd[1115]: Listen and drop on 0 v6wildcard [::]:123 Oct 17 12:25:25 volumio-x86 ntpd[1115]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 17 12:25:25 volumio-x86 ntpd[1115]: Listen normally on 2 lo 127.0.0.1:123 Oct 17 12:25:25 volumio-x86 ntpd[1115]: Listen normally on 3 eth0 192.168.10.112:123 Oct 17 12:25:25 volumio-x86 ntpd[1115]: Listening on routing socket on fd #20 for interface updates Oct 17 12:25:25 volumio-x86 ntpd[1115]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 17 12:25:25 volumio-x86 ntpd[1115]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 17 12:25:25 volumio-x86 sudo[1105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 12:25:25 volumio-x86 sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 12:25:25 volumio-x86 sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:25 volumio-x86 sudo[1113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 17 12:25:25 volumio-x86 sudo[1113]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:25 volumio-x86 sudo[1105]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:25 volumio-x86 sudo[1105]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:25 volumio-x86 sudo[1113]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:25 volumio-x86 sudo[1110]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:25 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 12:25:25 volumio-x86 volumio[835]: info: Loading plugin "wizard"... Oct 17 12:25:25 volumio-x86 volumio[835]: info: Loading plugin "networkfs"... Oct 17 12:25:25 volumio-x86 volumio[835]: info: Starting Udev Watcher for removable devices Oct 17 12:25:25 volumio-x86 volumio[835]: info: Ignoring mount for partition: boot Oct 17 12:25:25 volumio-x86 volumio[835]: info: Ignoring mount for partition: volumio Oct 17 12:25:25 volumio-x86 volumio[835]: info: Ignoring mount for partition: volumio_data Oct 17 12:25:25 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 12:25:25 volumio-x86 volumio[835]: info: Loading plugin "volumio_command_line_client"... Oct 17 12:25:25 volumio-x86 sudo[1130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=alex76,password=uujijggl,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.45/Volume0/Music /mnt/NAS/MusicServer Oct 17 12:25:25 volumio-x86 sudo[1130]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:25 volumio-x86 volumio[835]: info: Loading plugin "upnp"... Oct 17 12:25:25 volumio-x86 volumio[835]: info: [1729139125656] Starting Upmpd Daemon Oct 17 12:25:25 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 12:25:25 volumio-x86 volumio[835]: info: Loading plugin "my_music"... Oct 17 12:25:25 volumio-x86 volumio[835]: info: Loading plugin "mpd"... Oct 17 12:25:25 volumio-x86 kernel: FS-Cache: Loaded Oct 17 12:25:25 volumio-x86 kernel: Key type dns_resolver registered Oct 17 12:25:25 volumio-x86 dbus-daemon[620]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.6' (uid=0 pid=1030 comm="/usr/lib/chromium/chromium --show-component-extens") Oct 17 12:25:25 volumio-x86 kernel: Key type cifs.spnego registered Oct 17 12:25:25 volumio-x86 kernel: Key type cifs.idmap registered Oct 17 12:25:25 volumio-x86 kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Oct 17 12:25:25 volumio-x86 kernel: CIFS: Attempting to mount //192.168.10.45/Volume0/Music Oct 17 12:25:25 volumio-x86 systemd[1]: Starting Bluetooth service... Oct 17 12:25:26 volumio-x86 bluetoothd[1138]: Bluetooth daemon 5.50 Oct 17 12:25:26 volumio-x86 bluetoothd[1138]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Oct 17 12:25:26 volumio-x86 dbus-daemon[620]: [system] Successfully activated service 'org.bluez' Oct 17 12:25:26 volumio-x86 systemd[1]: Started Bluetooth service. Oct 17 12:25:26 volumio-x86 bluetoothd[1138]: Starting SDP server Oct 17 12:25:26 volumio-x86 bluetoothd[1138]: Excluding (cli) sap Oct 17 12:25:26 volumio-x86 sudo[1130]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:26 volumio-x86 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Oct 17 12:25:26 volumio-x86 kernel: Bluetooth: BNEP filters: protocol multicast Oct 17 12:25:26 volumio-x86 kernel: Bluetooth: BNEP socket layer initialized Oct 17 12:25:26 volumio-x86 bluetoothd[1138]: Bluetooth management interface 1.22 initialized Oct 17 12:25:26 volumio-x86 dbus-daemon[620]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.7' (uid=0 pid=1138 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Oct 17 12:25:26 volumio-x86 systemd[1]: Starting Hostname Service... Oct 17 12:25:26 volumio-x86 dbus-daemon[620]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 17 12:25:26 volumio-x86 systemd[1]: Started Hostname Service. Oct 17 12:25:26 volumio-x86 ntpd[1115]: Soliciting pool server 220.134.230.37 Oct 17 12:25:26 volumio-x86 volumio[835]: info: Loading plugin "upnp_browser"... Oct 17 12:25:26 volumio-x86 nmbd[769]: [2024/10/17 12:25:26.904016, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 17 12:25:26 volumio-x86 nmbd[769]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 17 12:25:26 volumio-x86 systemd[1]: Started Samba NMB Daemon. Oct 17 12:25:26 volumio-x86 systemd[1]: Starting Samba Winbind Daemon... Oct 17 12:25:27 volumio-x86 volumio[835]: info: Loading plugin "alarm-clock"... Oct 17 12:25:27 volumio-x86 ntpd[1115]: Soliciting pool server 114.34.171.136 Oct 17 12:25:27 volumio-x86 ntpd[1115]: Soliciting pool server 114.35.131.27 Oct 17 12:25:27 volumio-x86 winbindd[1195]: [2024/10/17 12:25:27.440338, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Oct 17 12:25:27 volumio-x86 winbindd[1195]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 17 12:25:27 volumio-x86 winbindd[1195]: [2024/10/17 12:25:27.462902, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 17 12:25:27 volumio-x86 systemd[1]: Started Samba Winbind Daemon. Oct 17 12:25:27 volumio-x86 winbindd[1195]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 17 12:25:27 volumio-x86 systemd[1]: Starting Samba SMB Daemon... Oct 17 12:25:27 volumio-x86 volumio[835]: info: Loading plugin "airplay_emulation"... Oct 17 12:25:27 volumio-x86 volumio[835]: info: Starting Shairport Sync Oct 17 12:25:27 volumio-x86 volumio[835]: info: Loading plugin "last_100"... Oct 17 12:25:27 volumio-x86 volumio[835]: info: Loading plugin "webradio"... Oct 17 12:25:28 volumio-x86 volumio[835]: info: Loading plugin "i2s_dacs"... Oct 17 12:25:28 volumio-x86 volumio[835]: info: I2S DAC not set, start Auto-detection Oct 17 12:25:28 volumio-x86 volumio[835]: info: Loading plugin "volumiodiscovery"... Oct 17 12:25:28 volumio-x86 volumio[835]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 17 12:25:28 volumio-x86 node[835]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 17 12:25:28 volumio-x86 node[835]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 12:25:28 volumio-x86 volumio[835]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 12:25:28 volumio-x86 volumio[835]: *** WARNING *** For more information see Oct 17 12:25:28 volumio-x86 volumio[835]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 17 12:25:28 volumio-x86 volumio[835]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 12:25:28 volumio-x86 node[835]: *** WARNING *** For more information see Oct 17 12:25:28 volumio-x86 volumio[835]: *** WARNING *** For more information see Oct 17 12:25:28 volumio-x86 node[835]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 17 12:25:28 volumio-x86 node[835]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 12:25:28 volumio-x86 node[835]: *** WARNING *** For more information see Oct 17 12:25:28 volumio-x86 volumio[835]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 17 12:25:28 volumio-x86 volumio[835]: info: Discovery: Started advertising with name: Volumio X86 Oct 17 12:25:28 volumio-x86 ntpd[1115]: Soliciting pool server 125.229.106.76 Oct 17 12:25:28 volumio-x86 ntpd[1115]: Soliciting pool server 118.163.81.61 Oct 17 12:25:28 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 12:25:28 volumio-x86 volumio[835]: info: Loading plugin "peppy_screensaver"... Oct 17 12:25:28 volumio-x86 smbd[1219]: [2024/10/17 12:25:28.306012, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 17 12:25:28 volumio-x86 smbd[1219]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 17 12:25:28 volumio-x86 systemd[1]: Started Samba SMB Daemon. Oct 17 12:25:28 volumio-x86 systemd[1]: Reached target Multi-User System. Oct 17 12:25:28 volumio-x86 systemd[1]: Reached target Graphical Interface. Oct 17 12:25:28 volumio-x86 systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 17 12:25:28 volumio-x86 ntpd[1115]: Soliciting pool server 183.177.72.201 Oct 17 12:25:28 volumio-x86 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 17 12:25:28 volumio-x86 systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 17 12:25:28 volumio-x86 systemd[1]: Startup finished in 3.804s (firmware) + 2.799s (loader) + 16.212s (kernel) + 18.882s (userspace) = 41.698s. Oct 17 12:25:28 volumio-x86 volumio[835]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 17 12:25:28 volumio-x86 volumio[835]: info: Loading plugin "outputs"... Oct 17 12:25:28 volumio-x86 volumio[835]: info: Loading plugin "albumart"... Oct 17 12:25:28 volumio-x86 volumio[835]: info: Plugin example_plugin is not enabled Oct 17 12:25:28 volumio-x86 volumio[835]: info: Loading plugin "inputs"... Oct 17 12:25:28 volumio-x86 volumio[835]: info: Loading plugin "updater_comm"... Oct 17 12:25:29 volumio-x86 volumio[835]: Forking 1 albumart workers Oct 17 12:25:29 volumio-x86 ntpd[1115]: Soliciting pool server 103.147.22.149 Oct 17 12:25:29 volumio-x86 ntpd[1115]: Soliciting pool server 183.177.72.202 Oct 17 12:25:29 volumio-x86 ntpd[1115]: Soliciting pool server 122.117.253.246 Oct 17 12:25:29 volumio-x86 volumio[835]: info: Plugin mpdemulation is not enabled Oct 17 12:25:29 volumio-x86 volumio[835]: info: Loading plugin "rest_api"... Oct 17 12:25:29 volumio-x86 volumio[835]: info: Loading plugin "websocket"... Oct 17 12:25:29 volumio-x86 volumio[835]: info: Starting Socket.io Server version 2.3.0 Oct 17 12:25:29 volumio-x86 volumio[835]: info: Loading i18n strings for locale zh_TW Oct 17 12:25:29 volumio-x86 volumio[835]: Updating browse sources language Oct 17 12:25:29 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 12:25:29 volumio-x86 ntpd[1115]: Soliciting pool server 114.33.15.129 Oct 17 12:25:29 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 12:25:29 volumio-x86 volumio[835]: info: CoreCommandRouter::initPlayerControls Oct 17 12:25:29 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:29 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:29 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 12:25:29 volumio-x86 volumio[835]: Express server listening on port 3000 Oct 17 12:25:29 volumio-x86 volumio[835]: [Metrics] WebUI: 10s 483.69ms Oct 17 12:25:29 volumio-x86 volumio[835]: info: Setting Device type: x86 Oct 17 12:25:29 volumio-x86 volumio[835]: info: CoreStateMachine::resetVolumioState Oct 17 12:25:29 volumio-x86 volumio[835]: info: CoreStateMachine::getcurrentVolume Oct 17 12:25:29 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioRetrievevolume Oct 17 12:25:29 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:29 volumio-x86 volumio[835]: Starting albumart workers Oct 17 12:25:29 volumio-x86 volumio[835]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 17 12:25:29 volumio-x86 volumio[835]: info: Completed loading Core Plugins Oct 17 12:25:29 volumio-x86 volumio[835]: info: Preparing to generate the ALSA configuration file Oct 17 12:25:29 volumio-x86 volumio[835]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Oct 17 12:25:29 volumio-x86 volumio[835]: wlan0 Interface doesn't support scanning. Oct 17 12:25:29 volumio-x86 volumio[835]: info: Cannot use regular scanning, forcing with ap-force Oct 17 12:25:29 volumio-x86 sudo[1255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Oct 17 12:25:29 volumio-x86 sudo[1255]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:29 volumio-x86 sudo[1255]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:29 volumio-x86 volumio[835]: command failed: No such device (-19) Oct 17 12:25:29 volumio-x86 volumio[835]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Oct 17 12:25:29 volumio-x86 volumio[835]: command failed: No such device (-19) Oct 17 12:25:29 volumio-x86 volumio[835]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 17 12:25:29 volumio-x86 volumio[835]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 17 12:25:29 volumio-x86 volumio[835]: info: Reading ALSA contributions from plugins. Oct 17 12:25:29 volumio-x86 volumio[835]: verbose: New Socket.io Connection to 192.168.10.112 from 192.168.10.137 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 17 12:25:30 volumio-x86 volumio[835]: verbose: New Socket.io Connection to 192.168.10.112 from 192.168.10.137 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 17 12:25:30 volumio-x86 volumio[835]: verbose: New Socket.io Connection to 192.168.10.112 from 192.168.10.137 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 17 12:25:30 volumio-x86 volumio[835]: verbose: New Socket.io Connection to 192.168.10.112 from 192.168.10.137 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 17 12:25:30 volumio-x86 volumio[835]: verbose: New Socket.io Connection to 192.168.10.112 from 192.168.10.137 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:30 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:30 volumio-x86 volumio[835]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 17 12:25:30 volumio-x86 volumio[835]: info: Reloading queue from file Oct 17 12:25:30 volumio-x86 ntpd[1115]: Soliciting pool server 123.204.232.128 Oct 17 12:25:30 volumio-x86 ntpd[1115]: Soliciting pool server 118.163.74.161 Oct 17 12:25:30 volumio-x86 ntpd[1115]: Soliciting pool server 218.35.163.245 Oct 17 12:25:30 volumio-x86 volumio[835]: info: VolumeController:: Volume=96 Mute =false Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreStateMachine::pushState Oct 17 12:25:30 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioPushState Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreStateMachine::updateTrackBlock Oct 17 12:25:30 volumio-x86 volumio[835]: info: CorePlayQueue::getTrackBlock Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioRetrievevolume Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreStateMachine::setRepeat null single undefined Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreStateMachine::pushState Oct 17 12:25:30 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioPushState Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreStateMachine::setRandom null Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreStateMachine::pushState Oct 17 12:25:30 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioPushState Oct 17 12:25:30 volumio-x86 volumio[835]: info: VolumeController:: Volume=96 Mute =false Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreStateMachine::pushState Oct 17 12:25:30 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioPushState Oct 17 12:25:30 volumio-x86 volumio[835]: info: Asound.conf file unchanged, so no further update is needed Oct 17 12:25:30 volumio-x86 volumio[835]: info: Output device has changed, restarting MPD Oct 17 12:25:30 volumio-x86 volumio[835]: info: Output device has changed, restarting Shairport Sync Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:30 volumio-x86 sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:25:30 volumio-x86 sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:30 volumio-x86 sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:25:30 volumio-x86 sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:30 volumio-x86 sudo[1280]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:30 volumio-x86 systemd[1]: Listening on mpd.socket. Oct 17 12:25:30 volumio-x86 volumio[835]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:25:30 volumio-x86 volumio[835]: info: ___________ START PLUGINS ___________ Oct 17 12:25:30 volumio-x86 volumio[835]: info: ControllerMpd::onStart: Initializing MPD Oct 17 12:25:30 volumio-x86 volumio[835]: info: Creating MPD Configuration file Oct 17 12:25:30 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 12:25:30 volumio-x86 sudo[1290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 12:25:30 volumio-x86 volumio[835]: info: [1729139130787] CoreMusicLibrary::Adding element Media Servers Oct 17 12:25:30 volumio-x86 sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 12:25:30 volumio-x86 sudo[1290]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:30 volumio-x86 sudo[1292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:25:30 volumio-x86 sudo[1292]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:30 volumio-x86 sudo[1288]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:25:30 volumio-x86 sudo[1288]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:30 volumio-x86 sudo[1288]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:30 volumio-x86 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 17 12:25:30 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:25:30 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:25:30 volumio-x86 volumio[835]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:25:30 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:30 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:30 volumio-x86 volumio[835]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 12:25:31 volumio-x86 volumio[835]: info: [1729139130998] CoreMusicLibrary::Adding element Last_100 Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 12:25:31 volumio-x86 volumio[835]: info: [1729139131003] CoreMusicLibrary::Adding element Webradio Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 12:25:31 volumio-x86 volumio[835]: info: Initializing BBC Radios Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:31 volumio-x86 volumio[835]: info: Loading i18n strings for locale zh_TW Oct 17 12:25:31 volumio-x86 sudo[1298]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:25:31 volumio-x86 sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:31 volumio-x86 volumio[835]: info: /tmp/myfifo created Oct 17 12:25:31 volumio-x86 sudo[1298]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 17 12:25:31 volumio-x86 sudo[1298]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:31 volumio-x86 volumio[835]: info: /tmp/myfifosa created Oct 17 12:25:31 volumio-x86 sudo[1319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Oct 17 12:25:31 volumio-x86 sudo[1319]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:31 volumio-x86 sudo[1319]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:31 volumio-x86 volumio[835]: info: snd-dummy loaded Oct 17 12:25:31 volumio-x86 ntpd[1115]: Soliciting pool server 118.163.81.63 Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:31 volumio-x86 volumio[835]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:25:31 volumio-x86 volumio[835]: info: Volumio Calling Home Oct 17 12:25:31 volumio-x86 volumio[835]: info: Discovery: adding 6576be8c-9ca3-4f6e-ad09-3e064e726785 Oct 17 12:25:31 volumio-x86 volumio[835]: info: Discovery: Found device Volumio X86 Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:31 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:31 volumio-x86 volumio[835]: verbose: New Socket.io Connection to 192.168.10.112 from 192.168.10.137 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 17 12:25:31 volumio-x86 volumio[835]: info: MPD Permissions set Oct 17 12:25:31 volumio-x86 volumio[835]: info: MPD Permissions set Oct 17 12:25:31 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:31 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:32 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 12:25:32 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:32 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: Listing playlists Oct 17 12:25:32 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:32 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 12:25:32 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:32 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: Listing playlists Oct 17 12:25:32 volumio-x86 ntpd[1115]: Soliciting pool server 2406:2000:fc:437::2000 Oct 17 12:25:32 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:32 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 12:25:32 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:32 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: Listing playlists Oct 17 12:25:32 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:32 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:32 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:32 volumio-x86 volumio[835]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 sudo[1345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:25:32 volumio-x86 sudo[1345]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:25:32 volumio-x86 sudo[1345]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:32 volumio-x86 volumio-remote-updater[607]: [2024-10-17 12:25:32] [connect] Successful connection Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:32 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:33 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:33 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:25:33 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:33 volumio-x86 volumio[835]: info: Volumio called home Oct 17 12:25:33 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Oct 17 12:25:33 volumio-x86 volumio-remote-updater[607]: [2024-10-17 12:25:33] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1729139132 101 Oct 17 12:25:33 volumio-x86 volumio[835]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 9 Oct 17 12:25:33 volumio-x86 volumio[835]: info: Starting Shairport Sync Oct 17 12:25:33 volumio-x86 volumio[835]: info: Starting Shairport Sync Oct 17 12:25:33 volumio-x86 sudo[1360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:25:33 volumio-x86 sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:33 volumio-x86 sudo[1360]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:33 volumio-x86 sudo[1362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:25:33 volumio-x86 volumio[835]: info: Starting Shairport Sync Oct 17 12:25:33 volumio-x86 sudo[1362]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:33 volumio-x86 volumio[835]: info: Starting Shairport Sync Oct 17 12:25:33 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:25:33 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:25:33 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:25:33 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:25:33 volumio-x86 sudo[1362]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:33 volumio-x86 sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:25:33 volumio-x86 sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:33 volumio-x86 sudo[1368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:25:33 volumio-x86 sudo[1368]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:33 volumio-x86 sudo[1370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:25:33 volumio-x86 mpd[1316]: Oct 17 12:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 12:25:33 volumio-x86 sudo[1370]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:33 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:25:33 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:25:33 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:25:33 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:25:33 volumio-x86 sudo[1370]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:33 volumio-x86 sudo[1368]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:33 volumio-x86 sudo[1365]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:33 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 17 12:25:33 volumio-x86 sudo[1292]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:33 volumio-x86 sudo[1282]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:34 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Oct 17 12:25:34 volumio-x86 volumio[835]: info: Shairport-Sync Started Oct 17 12:25:34 volumio-x86 volumio[835]: Error adding Membership: Error: addMembership EINVAL Oct 17 12:25:34 volumio-x86 volumio[835]: info: Shairport-Sync Started Oct 17 12:25:34 volumio-x86 volumio[835]: info: Shairport-Sync Started Oct 17 12:25:34 volumio-x86 sudo[1383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:25:34 volumio-x86 sudo[1383]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:34 volumio-x86 volumio[835]: info: Completed starting Core Plugins Oct 17 12:25:34 volumio-x86 volumio[835]: info: ------------------------------------------- Oct 17 12:25:34 volumio-x86 volumio[835]: info: ----- MyVolumio plugins startup ---- Oct 17 12:25:34 volumio-x86 volumio[835]: info: ------------------------------------------- Oct 17 12:25:34 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 17 12:25:34 volumio-x86 systemd[1]: Stopping Music Player Daemon... Oct 17 12:25:34 volumio-x86 volumio[835]: info: MPD Permissions set Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:25:34 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:25:34 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:25:34 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:25:34 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:25:34 volumio-x86 volumio[835]: error: MPD error: Error: write EPIPE Oct 17 12:25:34 volumio-x86 volumio[835]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Oct 17 12:25:34 volumio-x86 volumio[835]: error: MPD error: The expression evaluated to a falsy value: Oct 17 12:25:34 volumio-x86 volumio[835]: assert.ok(self.idling) Oct 17 12:25:34 volumio-x86 volumio[835]: error: The expression evaluated to a falsy value: Oct 17 12:25:34 volumio-x86 volumio[835]: assert.ok(self.idling) Oct 17 12:25:34 volumio-x86 volumio[835]: error: MPD error: Error: write EPIPE Oct 17 12:25:34 volumio-x86 volumio[835]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Oct 17 12:25:34 volumio-x86 sudo[1393]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:25:34 volumio-x86 sudo[1393]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:34 volumio-x86 volumio[835]: error: Cannot initialize MPD Connection: MPD is not running Oct 17 12:25:34 volumio-x86 sudo[1393]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:35 volumio-x86 sudo[1398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 12:25:35 volumio-x86 sudo[1398]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:35 volumio-x86 sudo[1398]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:35 volumio-x86 sudo[1400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 12:25:35 volumio-x86 sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:35 volumio-x86 sudo[1400]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:35 volumio-x86 sudo[1405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 17 12:25:35 volumio-x86 sudo[1405]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:35 volumio-x86 systemd[1]: Started UPnP Renderer front-end to MPD. Oct 17 12:25:35 volumio-x86 sudo[1405]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:36 volumio-x86 mpd[1395]: Oct 17 12:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 12:25:36 volumio-x86 volumio[835]: info: Upmpdcli Daemon Started Oct 17 12:25:36 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 17 12:25:36 volumio-x86 sudo[1383]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:36 volumio-x86 volumio[835]: error: updateQueue error: null Oct 17 12:25:36 volumio-x86 volumio[1409]: Generating RSA private key, 4096 bit long modulus (2 primes) Oct 17 12:25:36 volumio-x86 volumio[835]: 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/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 17 12:25:37 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 12:25:37 volumio-x86 ntpd[1115]: receive: Unexpected origin timestamp 0xeabb1041.44f7359e does not match aorg 0000000000.00000000 from server@114.33.15.129 xmt 0xeabb1041.19f0b9d1 Oct 17 12:25:37 volumio-x86 ntpd[1115]: receive: Unexpected origin timestamp 0xeabb1041.44fb27dd does not match aorg 0000000000.00000000 from server@103.147.22.149 xmt 0xeabb1041.25474b02 Oct 17 12:25:41 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:41 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:41 volumio-x86 volumio[835]: 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/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 17 12:25:42 volumio-x86 volumio[835]: info: Adding plugin bluetooth to MyMusic Plugins Oct 17 12:25:42 volumio-x86 volumio[835]: info: Adding plugin multiroom to MyMusic Plugins Oct 17 12:25:42 volumio-x86 volumio[835]: info: Adding plugin metavolumio to MyMusic Plugins Oct 17 12:25:42 volumio-x86 volumio[835]: info: Adding plugin cd_controller to MyMusic Plugins Oct 17 12:25:42 volumio-x86 volumio[835]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 17 12:25:42 volumio-x86 volumio[835]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 17 12:25:42 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 17 12:25:44 volumio-x86 systemd[1]: systemd-fsckd.service: Succeeded. Oct 17 12:25:44 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 17 12:25:44 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 17 12:25:44 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:44 volumio-x86 volumio[835]: info: Starting MyVolumio Remote Streaming Endpoints Oct 17 12:25:44 volumio-x86 volumio[835]: info: MyVolumio login type: Token Oct 17 12:25:44 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 17 12:25:44 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 17 12:25:45 volumio-x86 volumio[835]: info: Starting Streaming Service Transparent Proxy Oct 17 12:25:45 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 17 12:25:45 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 17 12:25:45 volumio-x86 volumio[835]: info: Streaming services startup Oct 17 12:25:45 volumio-x86 volumio[835]: info: Starting Streaming Daemon Oct 17 12:25:45 volumio-x86 sudo[1620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 17 12:25:45 volumio-x86 sudo[1620]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:45 volumio-x86 volumio[835]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 17 12:25:45 volumio-x86 sudo[1620]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:46 volumio-x86 volumio[835]: 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/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Oct 17 12:25:46 volumio-x86 volumio[835]: error: Cannot start Volumio Streaming Daemon Oct 17 12:25:46 volumio-x86 volumio[835]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 17 12:25:46 volumio-x86 volumio[835]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 17 12:25:46 volumio-x86 volumio[835]: 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/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Oct 17 12:25:47 volumio-x86 volumio[835]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 17 12:25:47 volumio-x86 volumio[835]: STREAMING PROXY: Starting server on port 3245 Oct 17 12:25:47 volumio-x86 volumio[835]: Node JS runtime: 14 Oct 17 12:25:48 volumio-x86 volumio[1409]: ....................................................................................................................................................................................................................................................................................................................................++++ Oct 17 12:25:48 volumio-x86 volumio[835]: info: MyVolumio token set successfully Oct 17 12:25:48 volumio-x86 volumio[835]: info: MYVOLUMIO: Adding device Oct 17 12:25:48 volumio-x86 volumio[835]: info: MYVOLUMIO: Evaluating Server Oct 17 12:25:49 volumio-x86 volumio[1409]: ................++++ Oct 17 12:25:49 volumio-x86 volumio[1409]: e is 65537 (0x010001) Oct 17 12:25:49 volumio-x86 volumio[835]: info: MyVolumio status changed Oct 17 12:25:49 volumio-x86 volumio[835]: info: Streaming services startup Oct 17 12:25:49 volumio-x86 volumio[835]: info: Starting Streaming Daemon Oct 17 12:25:49 volumio-x86 volumio[1409]: writing RSA key Oct 17 12:25:49 volumio-x86 volumio[835]: info: Removing browser output: myVolumio user plan is not superstar Oct 17 12:25:49 volumio-x86 volumio[835]: info: Removing audio output: Oct 17 12:25:49 volumio-x86 volumio[835]: info: Stoppping Tunnel 1 Oct 17 12:25:49 volumio-x86 sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 17 12:25:49 volumio-x86 sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:49 volumio-x86 sudo[1650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 17 12:25:49 volumio-x86 sudo[1650]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:25:49 volumio-x86 sudo[1646]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:49 volumio-x86 volumio[835]: error: Cannot start Volumio Streaming Daemon Oct 17 12:25:49 volumio-x86 volumio[835]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 17 12:25:49 volumio-x86 volumio[835]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 17 12:25:49 volumio-x86 sudo[1650]: pam_unix(sudo:session): session closed for user root Oct 17 12:25:49 volumio-x86 volumio[835]: info: Remote SSH Stopped Oct 17 12:25:49 volumio-x86 volumio[835]: info: Setting Geolocation for MyVolumio to as1 Oct 17 12:25:49 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:50 volumio-x86 volumio[835]: info: Updating MyVolumio device info Oct 17 12:25:50 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:51 volumio-x86 volumio[835]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 17 12:25:51 volumio-x86 volumio[835]: 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/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:51 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 12:25:51 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:51 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:51 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:51 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:51 volumio-x86 volumio[835]: info: Listing playlists Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:51 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 12:25:51 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:51 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:51 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 12:25:51 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:51 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:51 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:51 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:51 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 12:25:51 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:51 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:51 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:51 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:51 volumio-x86 volumio[835]: info: Listing playlists Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 17 12:25:51 volumio-x86 volumio[835]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 17 12:25:51 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 17 12:25:52 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:52 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:53 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 17 12:25:55 volumio-x86 volumio[835]: info: MYVOLUMIO: Adding device Oct 17 12:25:55 volumio-x86 volumio[835]: info: MYVOLUMIO: Evaluating Server Oct 17 12:25:55 volumio-x86 volumio[835]: info: Setting Geolocation for MyVolumio to as1 Oct 17 12:25:55 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:55 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:55 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:56 volumio-x86 systemd[1]: systemd-hostnamed.service: Succeeded. Oct 17 12:25:56 volumio-x86 volumio[835]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 17 12:25:56 volumio-x86 volumio[835]: info: Updating MyVolumio device info Oct 17 12:25:56 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:56 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:56 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:25:57 volumio-x86 volumio[835]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 17 12:25:58 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 12:25:58 volumio-x86 volumio[835]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 17 12:25:58 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 17 12:25:58 volumio-x86 volumio[835]: info: Received Get System Version Oct 17 12:25:58 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 12:25:58 volumio-x86 volumio[835]: info: Received Get System Info Oct 17 12:25:58 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:25:58 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:25:58 volumio-x86 volumio[835]: info: Discovery: Getting this device information Oct 17 12:25:58 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:58 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:25:58 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:25:59 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 12:25:59 volumio-x86 volumio[835]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Oct 17 12:25:59 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:25:59 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:01 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 12:26:01 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:26:01 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 12:26:01 volumio-x86 volumio-remote-updater[607]: No test mode Oct 17 12:26:01 volumio-x86 volumio-remote-updater[607]: No alpha test mode Oct 17 12:26:01 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 17 12:26:02 volumio-x86 volumio[835]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 17 12:26:02 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 17 12:26:03 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:26:03 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:04 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:26:04 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:26:04 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 17 12:26:04 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 17 12:26:04 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 17 12:26:04 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetBrowseSources Oct 17 12:26:04 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 12:26:05 volumio-x86 volumio[835]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 17 12:26:05 volumio-x86 volumio[835]: info: Completed starting MyVolumio Plugin Oct 17 12:26:05 volumio-x86 volumio[835]: info: BOOT COMPLETED Oct 17 12:26:05 volumio-x86 volumio[835]: [Metrics] CommandRouter: 45s 936.70ms Oct 17 12:26:05 volumio-x86 volumio[835]: info: CoreCommandRouter::volumiosetStartupVolume Oct 17 12:26:05 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:26:05 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:26:05 volumio-x86 volumio[835]: info: CoreCommandRouter::Close All Modals sent Oct 17 12:26:05 volumio-x86 volumio[835]: info: CoreCommandRouter::Close All Modals sent Oct 17 12:26:06 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 17 12:26:06 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 17 12:26:07 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioPlay Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreStateMachine::play index undefined Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:26:13 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreStateMachine::startPlaybackTimer Oct 17 12:26:13 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::clearAddPlayTracks NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 12:26:13 volumio-x86 volumio[835]: info: sendMpdCommand stop took 7 milliseconds Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::sendMpdCommand clear Oct 17 12:26:13 volumio-x86 volumio[835]: info: sendMpdCommand clear took 1 milliseconds Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::sendMpdCommand add "NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav" Oct 17 12:26:13 volumio-x86 volumio[835]: info: Oct 17 12:26:13 volumio-x86 volumio[835]: ---------------------------- MPD announces system playlist update Oct 17 12:26:13 volumio-x86 volumio[835]: info: Ignoring MPD Status Update Oct 17 12:26:13 volumio-x86 volumio[835]: info: Oct 17 12:26:13 volumio-x86 volumio[835]: ---------------------------- MPD announces system playlist update Oct 17 12:26:13 volumio-x86 volumio[835]: info: Ignoring MPD Status Update Oct 17 12:26:13 volumio-x86 volumio[835]: info: sendMpdCommand add "NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav" took 9 milliseconds Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::sendMpdCommand play Oct 17 12:26:13 volumio-x86 volumio[835]: info: ------------------------------ 15ms Oct 17 12:26:13 volumio-x86 volumio[835]: info: ------------------------------ 13ms Oct 17 12:26:13 volumio-x86 volumio[835]: info: sendMpdCommand play took 8 milliseconds Oct 17 12:26:13 volumio-x86 volumio[835]: info: Oct 17 12:26:13 volumio-x86 volumio[835]: ---------------------------- MPD announces state update: player Oct 17 12:26:13 volumio-x86 volumio[835]: info: ControllerMpd::getState Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:26:13 volumio-x86 volumio[835]: info: Oct 17 12:26:13 volumio-x86 volumio[835]: ---------------------------- MPD announces state update: player Oct 17 12:26:13 volumio-x86 volumio[835]: info: sendMpdCommand status took 53 milliseconds Oct 17 12:26:13 volumio-x86 volumio[835]: info: ControllerMpd::getState Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::parseState Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:26:13 volumio-x86 volumio[835]: info: sendMpdCommand status took 11 milliseconds Oct 17 12:26:13 volumio-x86 volumio[835]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::parseState Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:26:13 volumio-x86 volumio[835]: info: ControllerMpd::pushState Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreCommandRouter::servicePushState Oct 17 12:26:13 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: CURRENT POSITION 0 Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreStateMachine::syncState stateService play Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:26:13 volumio-x86 volumio[835]: info: ------------------------------ 84ms Oct 17 12:26:13 volumio-x86 volumio[835]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:26:13 volumio-x86 volumio[835]: info: ControllerMpd::pushState Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreCommandRouter::servicePushState Oct 17 12:26:13 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:26:13 volumio-x86 volumio[835]: verbose: CURRENT POSITION 0 Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreStateMachine::syncState stateService play Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:26:13 volumio-x86 volumio[835]: info: Received an update from plugin. extracting info from payload Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreStateMachine::pushState Oct 17 12:26:13 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioPushState Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreStateMachine::pushState Oct 17 12:26:13 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:13 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioPushState Oct 17 12:26:13 volumio-x86 volumio[835]: info: ------------------------------ 71ms Oct 17 12:26:14 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioGetState Oct 17 12:26:14 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:14 volumio-x86 sudo[1709]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Oct 17 12:26:14 volumio-x86 sudo[1709]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:26:15 volumio-x86 volumiologrotate[618]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Oct 17 12:26:15 volumio-x86 volumiologrotate[618]: ls: cannot access 'X86': No such file or directory Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioPause Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreStateMachine::pause Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreStateMachine::servicePause Oct 17 12:26:18 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreCommandRouter::servicePause Oct 17 12:26:18 volumio-x86 volumio[835]: info: ControllerMpd::pause Oct 17 12:26:18 volumio-x86 volumio[835]: verbose: ControllerMpd::sendMpdCommand pause Oct 17 12:26:18 volumio-x86 volumio[835]: info: Oct 17 12:26:18 volumio-x86 volumio[835]: ---------------------------- MPD announces state update: player Oct 17 12:26:18 volumio-x86 volumio[835]: info: sendMpdCommand pause took 4 milliseconds Oct 17 12:26:18 volumio-x86 volumio[835]: info: ControllerMpd::getState Oct 17 12:26:18 volumio-x86 volumio[835]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:26:18 volumio-x86 volumio[835]: info: sendMpdCommand status took 2 milliseconds Oct 17 12:26:18 volumio-x86 volumio[835]: verbose: ControllerMpd::parseState Oct 17 12:26:18 volumio-x86 volumio[835]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:26:18 volumio-x86 volumio[835]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 17 12:26:18 volumio-x86 volumio[835]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:26:18 volumio-x86 volumio[835]: info: ControllerMpd::pushState Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreCommandRouter::servicePushState Oct 17 12:26:18 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:18 volumio-x86 volumio[835]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5623,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:26:18 volumio-x86 volumio[835]: verbose: CURRENT POSITION 0 Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreStateMachine::syncState stateService pause Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreStateMachine::syncState currentStatus pause Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreStateMachine::pushState Oct 17 12:26:18 volumio-x86 volumio[835]: info: CorePlayQueue::getTrack 0 Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreCommandRouter::volumioPushState Oct 17 12:26:18 volumio-x86 volumio[835]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:26:18 volumio-x86 volumio[835]: info: ------------------------------ 36ms Oct 17 12:26:18 volumio-x86 volumio[835]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 12:26:18 volumio-x86 volumio[835]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Oct 17 12:26:18 volumio-x86 volumio[835]: at Object.readdirSync (fs.js:1048:3) Oct 17 12:26:18 volumio-x86 volumio[835]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Oct 17 12:26:18 volumio-x86 volumio[835]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Oct 17 12:26:18 volumio-x86 volumio[835]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Oct 17 12:26:18 volumio-x86 volumio[835]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Oct 17 12:26:18 volumio-x86 volumio[835]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Oct 17 12:26:18 volumio-x86 volumio[835]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 12:26:18 volumio-x86 volumio[835]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Oct 17 12:26:18 volumio-x86 volumio[835]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Oct 17 12:26:18 volumio-x86 volumio[835]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 17 12:26:18 volumio-x86 volumio[835]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 12:26:18 volumio-x86 volumio[835]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Oct 17 12:26:18 volumio-x86 volumio[835]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 17 12:26:18 volumio-x86 volumio[835]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 12:26:18 volumio-x86 volumio[835]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Oct 17 12:26:18 volumio-x86 volumio[835]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Oct 17 12:26:18 volumio-x86 volumio[835]: errno: -20, Oct 17 12:26:18 volumio-x86 volumio[835]: syscall: 'scandir', Oct 17 12:26:18 volumio-x86 volumio[835]: code: 'ENOTDIR', Oct 17 12:26:18 volumio-x86 volumio[835]: path: '/tmp/peppyrunning' Oct 17 12:26:18 volumio-x86 volumio[835]: } Oct 17 12:26:18 volumio-x86 volumio[835]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 12:26:19 volumio-x86 sudo[1796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-17 12:25 Oct 17 12:26:19 volumio-x86 sudo[1796]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"