-- Logs begin at Sun 2025-05-04 20:17:53 CST, end at Mon 2025-05-05 04:17:54 CST. -- May 05 04:17:39 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 May 05 04:17:39 volumio-x86 kernel: Command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=3cc03e2d-018e-43c1-b7e6-361cc0a7c20f bootpart=UUID=0A5D-C90D datapart=UUID=de34b9f5-9b78-4162-a289-2de9c46fbb26 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 May 05 04:17:39 volumio-x86 kernel: KERNEL supported cpus: May 05 04:17:39 volumio-x86 kernel: Intel GenuineIntel May 05 04:17:39 volumio-x86 kernel: AMD AuthenticAMD May 05 04:17:39 volumio-x86 kernel: Hygon HygonGenuine May 05 04:17:39 volumio-x86 kernel: Centaur CentaurHauls May 05 04:17:39 volumio-x86 kernel: zhaoxin Shanghai May 05 04:17:39 volumio-x86 kernel: BIOS-provided physical RAM map: May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x0000000000000000-0x0000000000000fff] reserved May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x0000000000001000-0x000000000009ffff] usable May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x00000000000a0000-0x00000000000fffff] reserved May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000007a83ffff] usable May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x000000007a840000-0x000000007a93ffff] type 20 May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x000000007a940000-0x000000007aa47fff] reserved May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x000000007aa48000-0x000000007aa52fff] usable May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x000000007aa53000-0x000000007aa64fff] ACPI data May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x000000007aa65000-0x000000007aa65fff] usable May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x000000007aa66000-0x000000007fffffff] reserved May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x00000000ffbc0000-0x00000000ffbfffff] reserved May 05 04:17:39 volumio-x86 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000027effffff] usable May 05 04:17:39 volumio-x86 kernel: NX (Execute Disable) protection: active May 05 04:17:39 volumio-x86 kernel: APIC: Static calls initialized May 05 04:17:39 volumio-x86 kernel: efi: EFI v2.7 by EDK II May 05 04:17:39 volumio-x86 kernel: efi: SMBIOS=0x7a94b000 SMBIOS 3.0=0x7a949000 ACPI=0x7aa64000 ACPI 2.0=0x7aa64014 MEMATTR=0x76f54298 May 05 04:17:39 volumio-x86 kernel: efi: Remove mem89: MMIO range=[0xffbc0000-0xffbfffff] (0MB) from e820 map May 05 04:17:39 volumio-x86 kernel: e820: remove [mem 0xffbc0000-0xffbfffff] reserved May 05 04:17:39 volumio-x86 kernel: SMBIOS 3.0.0 present. May 05 04:17:39 volumio-x86 kernel: DMI: Google Teemo/Teemo, BIOS MrChromebox-4.22.2 01/20/2024 May 05 04:17:39 volumio-x86 kernel: tsc: Detected 2000.000 MHz processor May 05 04:17:39 volumio-x86 kernel: tsc: Detected 1999.968 MHz TSC May 05 04:17:39 volumio-x86 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved May 05 04:17:39 volumio-x86 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable May 05 04:17:39 volumio-x86 kernel: last_pfn = 0x27f000 max_arch_pfn = 0x400000000 May 05 04:17:39 volumio-x86 kernel: MTRR map: 7 entries (3 fixed + 4 variable; max 23), built from 10 variable MTRRs May 05 04:17:39 volumio-x86 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT May 05 04:17:39 volumio-x86 kernel: last_pfn = 0x7aa66 max_arch_pfn = 0x400000000 May 05 04:17:39 volumio-x86 kernel: Using GB pages for direct mapping May 05 04:17:39 volumio-x86 kernel: Secure boot could not be determined May 05 04:17:39 volumio-x86 kernel: RAMDISK: [mem 0x2fae7000-0x33d6afff] May 05 04:17:39 volumio-x86 kernel: ACPI: Early table checksum verification disabled May 05 04:17:39 volumio-x86 kernel: ACPI: RSDP 0x000000007AA64014 000024 (v02 COREv4) May 05 04:17:39 volumio-x86 kernel: ACPI: XSDT 0x000000007AA630E8 00007C (v01 COREv4 COREBOOT 00000000 01000013) May 05 04:17:39 volumio-x86 kernel: ACPI: FACP 0x000000007AA62000 000114 (v06 COREv4 COREBOOT 00000000 CORE 20230628) May 05 04:17:39 volumio-x86 kernel: ACPI: DSDT 0x000000007AA5E000 003C11 (v02 COREv4 COREBOOT 20110725 INTL 20230628) May 05 04:17:39 volumio-x86 kernel: ACPI: FACS 0x000000007AA7E240 000040 May 05 04:17:39 volumio-x86 kernel: ACPI: SSDT 0x000000007AA5C000 001DAB (v02 COREv4 COREBOOT 00000000 CORE 20230628) May 05 04:17:39 volumio-x86 kernel: ACPI: MCFG 0x000000007AA5B000 00003C (v01 COREv4 COREBOOT 00000000 CORE 20230628) May 05 04:17:39 volumio-x86 kernel: ACPI: TPM2 0x000000007AA5A000 00004C (v04 COREv4 COREBOOT 00000000 CORE 20230628) May 05 04:17:39 volumio-x86 kernel: ACPI: LPIT 0x000000007AA59000 000094 (v00 COREv4 COREBOOT 00000000 CORE 20230628) May 05 04:17:39 volumio-x86 kernel: ACPI: APIC 0x000000007AA58000 000092 (v03 COREv4 COREBOOT 00000000 CORE 20230628) May 05 04:17:39 volumio-x86 kernel: ACPI: NHLT 0x000000007AA57000 00017D (v05 GOOGLE FIZZ 00000000 CORE 00000000) May 05 04:17:39 volumio-x86 kernel: ACPI: DMAR 0x000000007AA56000 000088 (v01 COREv4 COREBOOT 00000000 CORE 20230628) May 05 04:17:39 volumio-x86 kernel: ACPI: DBG2 0x000000007AA55000 000061 (v00 COREv4 COREBOOT 00000000 CORE 20230628) May 05 04:17:39 volumio-x86 kernel: ACPI: HPET 0x000000007AA54000 000038 (v01 COREv4 COREBOOT 00000000 CORE 20230628) May 05 04:17:39 volumio-x86 kernel: ACPI: BGRT 0x000000007AA53000 000038 (v01 INTEL EDK2 00000002 01000013) May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving FACP table memory at [mem 0x7aa62000-0x7aa62113] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving DSDT table memory at [mem 0x7aa5e000-0x7aa61c10] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving FACS table memory at [mem 0x7aa7e240-0x7aa7e27f] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving SSDT table memory at [mem 0x7aa5c000-0x7aa5ddaa] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving MCFG table memory at [mem 0x7aa5b000-0x7aa5b03b] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving TPM2 table memory at [mem 0x7aa5a000-0x7aa5a04b] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving LPIT table memory at [mem 0x7aa59000-0x7aa59093] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving APIC table memory at [mem 0x7aa58000-0x7aa58091] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving NHLT table memory at [mem 0x7aa57000-0x7aa5717c] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving DMAR table memory at [mem 0x7aa56000-0x7aa56087] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving DBG2 table memory at [mem 0x7aa55000-0x7aa55060] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving HPET table memory at [mem 0x7aa54000-0x7aa54037] May 05 04:17:39 volumio-x86 kernel: ACPI: Reserving BGRT table memory at [mem 0x7aa53000-0x7aa53037] May 05 04:17:39 volumio-x86 kernel: Zone ranges: May 05 04:17:39 volumio-x86 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] May 05 04:17:39 volumio-x86 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] May 05 04:17:39 volumio-x86 kernel: Normal [mem 0x0000000100000000-0x000000027effffff] May 05 04:17:39 volumio-x86 kernel: Movable zone start for each node May 05 04:17:39 volumio-x86 kernel: Early memory node ranges May 05 04:17:39 volumio-x86 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] May 05 04:17:39 volumio-x86 kernel: node 0: [mem 0x0000000000100000-0x000000007a83ffff] May 05 04:17:39 volumio-x86 kernel: node 0: [mem 0x000000007aa48000-0x000000007aa52fff] May 05 04:17:39 volumio-x86 kernel: node 0: [mem 0x000000007aa65000-0x000000007aa65fff] May 05 04:17:39 volumio-x86 kernel: node 0: [mem 0x0000000100000000-0x000000027effffff] May 05 04:17:39 volumio-x86 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000027effffff] May 05 04:17:39 volumio-x86 kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 05 04:17:39 volumio-x86 kernel: On node 0, zone DMA: 96 pages in unavailable ranges May 05 04:17:39 volumio-x86 kernel: On node 0, zone DMA32: 520 pages in unavailable ranges May 05 04:17:39 volumio-x86 kernel: On node 0, zone DMA32: 18 pages in unavailable ranges May 05 04:17:39 volumio-x86 kernel: On node 0, zone Normal: 21914 pages in unavailable ranges May 05 04:17:39 volumio-x86 kernel: On node 0, zone Normal: 4096 pages in unavailable ranges May 05 04:17:39 volumio-x86 kernel: Reserving Intel graphics memory at [mem 0x7c000000-0x7fffffff] May 05 04:17:39 volumio-x86 kernel: ACPI: PM-Timer IO Port: 0x1808 May 05 04:17:39 volumio-x86 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] high edge lint[0x1]) May 05 04:17:39 volumio-x86 kernel: IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-119 May 05 04:17:39 volumio-x86 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 high edge) May 05 04:17:39 volumio-x86 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) May 05 04:17:39 volumio-x86 kernel: ACPI: Using ACPI (MADT) for SMP configuration information May 05 04:17:39 volumio-x86 kernel: ACPI: HPET id: 0x8086a701 base: 0xfed00000 May 05 04:17:39 volumio-x86 kernel: e820: update [mem 0x76eef000-0x76f13fff] usable ==> reserved May 05 04:17:39 volumio-x86 kernel: TSC deadline timer available May 05 04:17:39 volumio-x86 kernel: smpboot: Allowing 8 CPUs, 0 hotplug CPUs May 05 04:17:39 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] May 05 04:17:39 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000fffff] May 05 04:17:39 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x76eef000-0x76f13fff] May 05 04:17:39 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x7a840000-0x7a93ffff] May 05 04:17:39 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x7a940000-0x7aa47fff] May 05 04:17:39 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x7aa53000-0x7aa64fff] May 05 04:17:39 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x7aa66000-0x7fffffff] May 05 04:17:39 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x80000000-0xffffffff] May 05 04:17:39 volumio-x86 kernel: [mem 0x80000000-0xffffffff] available for PCI devices May 05 04:17:39 volumio-x86 kernel: Booting paravirtualized kernel on bare hardware May 05 04:17:39 volumio-x86 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns May 05 04:17:39 volumio-x86 kernel: setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:8 nr_node_ids:1 May 05 04:17:39 volumio-x86 kernel: percpu: Embedded 56 pages/cpu s191400 r8192 d29784 u262144 May 05 04:17:39 volumio-x86 kernel: pcpu-alloc: s191400 r8192 d29784 u262144 alloc=1*2097152 May 05 04:17:39 volumio-x86 kernel: pcpu-alloc: [0] 0 1 2 3 4 5 6 7 May 05 04:17:39 volumio-x86 kernel: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=3cc03e2d-018e-43c1-b7e6-361cc0a7c20f bootpart=UUID=0A5D-C90D datapart=UUID=de34b9f5-9b78-4162-a289-2de9c46fbb26 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 May 05 04:17:39 volumio-x86 kernel: Unknown kernel command line parameters "splash BOOT_IMAGE=/vmlinuz biosdevname=0 imgpart=UUID=3cc03e2d-018e-43c1-b7e6-361cc0a7c20f bootpart=UUID=0A5D-C90D datapart=UUID=de34b9f5-9b78-4162-a289-2de9c46fbb26 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh use_kmsg=no", will be passed to user space. May 05 04:17:39 volumio-x86 kernel: random: crng init done May 05 04:17:39 volumio-x86 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) May 05 04:17:39 volumio-x86 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 05 04:17:39 volumio-x86 kernel: Built 1 zonelists, mobility grouping on. Total pages: 2035946 May 05 04:17:39 volumio-x86 kernel: mem auto-init: stack:all(zero), heap alloc:off, heap free:off May 05 04:17:39 volumio-x86 kernel: software IO TLB: area num 8. May 05 04:17:39 volumio-x86 kernel: Memory: 7906576K/8282028K available (14336K kernel code, 1878K rwdata, 4640K rodata, 2988K init, 1148K bss, 375196K reserved, 0K cma-reserved) May 05 04:17:39 volumio-x86 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1 May 05 04:17:39 volumio-x86 kernel: Kernel/User page tables isolation: enabled May 05 04:17:39 volumio-x86 kernel: ftrace: allocating 40433 entries in 158 pages May 05 04:17:39 volumio-x86 kernel: ftrace: allocated 158 pages with 5 groups May 05 04:17:39 volumio-x86 kernel: Dynamic Preempt: voluntary May 05 04:17:39 volumio-x86 kernel: rcu: Preemptible hierarchical RCU implementation. May 05 04:17:39 volumio-x86 kernel: Trampoline variant of Tasks RCU enabled. May 05 04:17:39 volumio-x86 kernel: Rude variant of Tasks RCU enabled. May 05 04:17:39 volumio-x86 kernel: Tracing variant of Tasks RCU enabled. May 05 04:17:39 volumio-x86 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. May 05 04:17:39 volumio-x86 kernel: NR_IRQS: 4352, nr_irqs: 2048, preallocated irqs: 16 May 05 04:17:39 volumio-x86 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 05 04:17:39 volumio-x86 kernel: spurious 8259A interrupt: IRQ7. May 05 04:17:39 volumio-x86 kernel: Console: colour dummy device 80x25 May 05 04:17:39 volumio-x86 kernel: printk: console [tty0] enabled May 05 04:17:39 volumio-x86 kernel: ACPI: Core revision 20230628 May 05 04:17:39 volumio-x86 kernel: hpet: HPET dysfunctional in PC10. Force disabled. May 05 04:17:39 volumio-x86 kernel: APIC: Switch to symmetric I/O mode setup May 05 04:17:39 volumio-x86 kernel: x2apic: IRQ remapping doesn't support X2APIC mode May 05 04:17:39 volumio-x86 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x39a8208cdd2, max_idle_ns: 881590748921 ns May 05 04:17:39 volumio-x86 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 3999.93 BogoMIPS (lpj=7999872) May 05 04:17:39 volumio-x86 kernel: CPU0: Thermal monitoring enabled (TM1) May 05 04:17:39 volumio-x86 kernel: process: using mwait in idle threads May 05 04:17:39 volumio-x86 kernel: Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8 May 05 04:17:39 volumio-x86 kernel: Last level dTLB entries: 4KB 64, 2MB 0, 4MB 0, 1GB 4 May 05 04:17:39 volumio-x86 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization May 05 04:17:39 volumio-x86 kernel: Spectre V2 : Mitigation: IBRS May 05 04:17:39 volumio-x86 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch May 05 04:17:39 volumio-x86 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT May 05 04:17:39 volumio-x86 kernel: RETBleed: Mitigation: IBRS May 05 04:17:39 volumio-x86 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier May 05 04:17:39 volumio-x86 kernel: Spectre V2 : User space: Mitigation: STIBP via prctl May 05 04:17:39 volumio-x86 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl May 05 04:17:39 volumio-x86 kernel: MDS: Mitigation: Clear CPU buffers May 05 04:17:39 volumio-x86 kernel: MMIO Stale Data: Mitigation: Clear CPU buffers May 05 04:17:39 volumio-x86 kernel: SRBDS: Mitigation: Microcode May 05 04:17:39 volumio-x86 kernel: GDS: Mitigation: Microcode May 05 04:17:39 volumio-x86 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' May 05 04:17:39 volumio-x86 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' May 05 04:17:39 volumio-x86 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' May 05 04:17:39 volumio-x86 kernel: x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers' May 05 04:17:39 volumio-x86 kernel: x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR' May 05 04:17:39 volumio-x86 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 May 05 04:17:39 volumio-x86 kernel: x86/fpu: xstate_offset[3]: 832, xstate_sizes[3]: 64 May 05 04:17:39 volumio-x86 kernel: x86/fpu: xstate_offset[4]: 896, xstate_sizes[4]: 64 May 05 04:17:39 volumio-x86 kernel: x86/fpu: Enabled xstate features 0x1f, context size is 960 bytes, using 'compacted' format. May 05 04:17:39 volumio-x86 kernel: Freeing SMP alternatives memory: 32K May 05 04:17:39 volumio-x86 kernel: pid_max: default: 32768 minimum: 301 May 05 04:17:39 volumio-x86 kernel: LSM: initializing lsm=capability,yama,integrity May 05 04:17:39 volumio-x86 kernel: Yama: becoming mindful. May 05 04:17:39 volumio-x86 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) May 05 04:17:39 volumio-x86 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) May 05 04:17:39 volumio-x86 kernel: smpboot: CPU0: Intel(R) Core(TM) i7-8550U CPU @ 1.80GHz (family: 0x6, model: 0x8e, stepping: 0xa) May 05 04:17:39 volumio-x86 kernel: RCU Tasks: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1. May 05 04:17:39 volumio-x86 kernel: RCU Tasks Rude: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1. May 05 04:17:39 volumio-x86 kernel: RCU Tasks Trace: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1. May 05 04:17:39 volumio-x86 kernel: Performance Events: PEBS fmt3+, Skylake events, 32-deep LBR, full-width counters, Intel PMU driver. May 05 04:17:39 volumio-x86 kernel: ... version: 4 May 05 04:17:39 volumio-x86 kernel: ... bit width: 48 May 05 04:17:39 volumio-x86 kernel: ... generic registers: 4 May 05 04:17:39 volumio-x86 kernel: ... value mask: 0000ffffffffffff May 05 04:17:39 volumio-x86 kernel: ... max period: 00007fffffffffff May 05 04:17:39 volumio-x86 kernel: ... fixed-purpose events: 3 May 05 04:17:39 volumio-x86 kernel: ... event mask: 000000070000000f May 05 04:17:39 volumio-x86 kernel: signal: max sigframe size: 2032 May 05 04:17:39 volumio-x86 kernel: Estimated ratio of average max frequency by base frequency (times 1024): 1894 May 05 04:17:39 volumio-x86 kernel: rcu: Hierarchical SRCU implementation. May 05 04:17:39 volumio-x86 kernel: rcu: Max phase no-delay instances is 1000. May 05 04:17:39 volumio-x86 kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. May 05 04:17:39 volumio-x86 kernel: smp: Bringing up secondary CPUs ... May 05 04:17:39 volumio-x86 kernel: smpboot: x86: Booting SMP configuration: May 05 04:17:39 volumio-x86 kernel: .... node #0, CPUs: #1 #2 #3 #4 #5 #6 #7 May 05 04:17:39 volumio-x86 kernel: MDS CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/mds.html for more details. May 05 04:17:39 volumio-x86 kernel: MMIO Stale Data CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/processor_mmio_stale_data.html for more details. May 05 04:17:39 volumio-x86 kernel: smp: Brought up 1 node, 8 CPUs May 05 04:17:39 volumio-x86 kernel: smpboot: Max logical packages: 1 May 05 04:17:39 volumio-x86 kernel: smpboot: Total of 8 processors activated (31999.48 BogoMIPS) May 05 04:17:39 volumio-x86 kernel: devtmpfs: initialized May 05 04:17:39 volumio-x86 kernel: x86/mm: Memory block size: 128MB May 05 04:17:39 volumio-x86 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns May 05 04:17:39 volumio-x86 kernel: futex hash table entries: 2048 (order: 5, 131072 bytes, linear) May 05 04:17:39 volumio-x86 kernel: pinctrl core: initialized pinctrl subsystem May 05 04:17:39 volumio-x86 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 05 04:17:39 volumio-x86 kernel: audit: initializing netlink subsys (disabled) May 05 04:17:39 volumio-x86 kernel: audit: type=2000 audit(1746389844.004:1): state=initialized audit_enabled=0 res=1 May 05 04:17:39 volumio-x86 kernel: thermal_sys: Registered thermal governor 'fair_share' May 05 04:17:39 volumio-x86 kernel: thermal_sys: Registered thermal governor 'bang_bang' May 05 04:17:39 volumio-x86 kernel: thermal_sys: Registered thermal governor 'step_wise' May 05 04:17:39 volumio-x86 kernel: thermal_sys: Registered thermal governor 'user_space' May 05 04:17:39 volumio-x86 kernel: EISA bus registered May 05 04:17:39 volumio-x86 kernel: cpuidle: using governor ladder May 05 04:17:39 volumio-x86 kernel: cpuidle: using governor menu May 05 04:17:39 volumio-x86 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 05 04:17:39 volumio-x86 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) May 05 04:17:39 volumio-x86 kernel: PCI: not using MMCONFIG May 05 04:17:39 volumio-x86 kernel: PCI: Using configuration type 1 for base access May 05 04:17:39 volumio-x86 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 05 04:17:39 volumio-x86 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 05 04:17:39 volumio-x86 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page May 05 04:17:39 volumio-x86 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 05 04:17:39 volumio-x86 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page May 05 04:17:39 volumio-x86 kernel: ACPI: Added _OSI(Module Device) May 05 04:17:39 volumio-x86 kernel: ACPI: Added _OSI(Processor Device) May 05 04:17:39 volumio-x86 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 05 04:17:39 volumio-x86 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 05 04:17:39 volumio-x86 kernel: ACPI: 2 ACPI AML tables successfully acquired and loaded May 05 04:17:39 volumio-x86 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC May 05 04:17:39 volumio-x86 kernel: ACPI: EC: EC started May 05 04:17:39 volumio-x86 kernel: ACPI: EC: interrupt blocked May 05 04:17:39 volumio-x86 kernel: ACPI: EC: EC_CMD/EC_SC=0x66, EC_DATA=0x62 May 05 04:17:39 volumio-x86 kernel: ACPI: \_SB_.PCI0.LPCB.EC0_: Boot DSDT EC used to handle transactions May 05 04:17:39 volumio-x86 kernel: ACPI: Interpreter enabled May 05 04:17:39 volumio-x86 kernel: ACPI: PM: (supports S0 S3 S4 S5) May 05 04:17:39 volumio-x86 kernel: ACPI: Using IOAPIC for interrupt routing May 05 04:17:39 volumio-x86 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) May 05 04:17:39 volumio-x86 kernel: PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved as ACPI motherboard resource May 05 04:17:39 volumio-x86 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug May 05 04:17:39 volumio-x86 kernel: PCI: Ignoring E820 reservations for host bridge windows May 05 04:17:39 volumio-x86 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 05 04:17:39 volumio-x86 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 05 04:17:39 volumio-x86 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug SHPCHotplug PME AER PCIeCapability LTR] May 05 04:17:39 volumio-x86 kernel: PCI host bridge to bus 0000:00 May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000fffff window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xdfffffff window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: root bus resource [mem 0x27f000000-0x7fffffffff window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: root bus resource [mem 0xfc800000-0xfe7fffff window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:00.0: [8086:5914] type 00 class 0x060000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:02.0: [8086:5917] type 00 class 0x030000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:02.0: reg 0x10: [mem 0x90000000-0x90ffffff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:02.0: reg 0x18: [mem 0x80000000-0x8fffffff 64bit pref] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:02.0: reg 0x20: [io 0x1000-0x103f] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:02.0: BAR 2: assigned to efifb May 05 04:17:39 volumio-x86 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:04.0: [8086:1903] type 00 class 0x118000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x91320000-0x91327fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:14.0: [8086:9d2f] type 00 class 0x0c0330 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:14.0: reg 0x10: [mem 0x91300000-0x9130ffff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:14.0: PME# supported from D3hot D3cold May 05 04:17:39 volumio-x86 kernel: pci 0000:00:14.2: [8086:9d31] type 00 class 0x118000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:14.2: reg 0x10: [mem 0x91330000-0x91330fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:15.0: [8086:9d60] type 00 class 0x118000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:15.0: reg 0x10: [mem 0x91331000-0x91331fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:15.2: [8086:9d62] type 00 class 0x118000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:15.2: reg 0x10: [mem 0x91332000-0x91332fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:19.0: [8086:9d66] type 00 class 0x118000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:19.0: reg 0x10: [mem 0xfe030000-0xfe030fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:19.0: reg 0x18: [mem 0x91334000-0x91334fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:19.1: [8086:9d65] type 00 class 0x118000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:19.1: reg 0x10: [mem 0x91335000-0x91335fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.0: [8086:9d12] type 01 class 0x060400 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.3: [8086:9d13] type 01 class 0x060400 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.4: [8086:9d14] type 01 class 0x060400 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.4: PME# supported from D0 D3hot D3cold May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1e.0: [8086:9d27] type 00 class 0x118000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1e.0: reg 0x10: [mem 0x91336000-0x91336fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1e.0: reg 0x18: [mem 0x91337000-0x91337fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1e.2: [8086:9d29] type 00 class 0x118000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1e.2: reg 0x10: [mem 0x91338000-0x91338fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1e.6: [8086:9d2d] type 00 class 0x080501 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1e.6: reg 0x10: [mem 0x91339000-0x91339fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.0: [8086:9d4e] type 00 class 0x060100 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.2: [8086:9d21] type 00 class 0x058000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.2: reg 0x10: [mem 0x91328000-0x9132bfff] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.3: [8086:9d71] type 00 class 0x040100 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.3: reg 0x10: [mem 0x9132c000-0x9132ffff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.3: reg 0x20: [mem 0x91310000-0x9131ffff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.3: PME# supported from D3hot D3cold May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.4: [8086:9d23] type 00 class 0x0c0500 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.4: reg 0x10: [mem 0x9133b000-0x9133b0ff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.4: reg 0x20: [io 0xefa0-0xefbf] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.5: [8086:9d24] type 00 class 0x000000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.5: reg 0x10: [mem 0xfe010000-0xfe010fff] May 05 04:17:39 volumio-x86 kernel: pci 0000:01:00.0: [10ec:8168] type 00 class 0x020000 May 05 04:17:39 volumio-x86 kernel: pci 0000:01:00.0: reg 0x10: [io 0x2000-0x20ff] May 05 04:17:39 volumio-x86 kernel: pci 0000:01:00.0: reg 0x18: [mem 0x91004000-0x91004fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:01:00.0: reg 0x20: [mem 0x91000000-0x91003fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:01:00.0: supports D1 D2 May 05 04:17:39 volumio-x86 kernel: pci 0000:01:00.0: PME# supported from D0 D1 D2 D3hot D3cold May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.0: PCI bridge to [bus 01] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [io 0x2000-0x2fff] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [mem 0x91000000-0x910fffff] May 05 04:17:39 volumio-x86 kernel: pci 0000:02:00.0: [8086:095a] type 00 class 0x028000 May 05 04:17:39 volumio-x86 kernel: pci 0000:02:00.0: reg 0x10: [mem 0x91100000-0x91101fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:02:00.0: PME# supported from D0 D3hot D3cold May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.3: PCI bridge to [bus 02] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [mem 0x91100000-0x911fffff] May 05 04:17:39 volumio-x86 kernel: pci 0000:03:00.0: [2646:5019] type 00 class 0x010802 May 05 04:17:39 volumio-x86 kernel: pci 0000:03:00.0: reg 0x10: [mem 0x91200000-0x91203fff 64bit] May 05 04:17:39 volumio-x86 kernel: pci 0000:03:00.0: 31.504 Gb/s available PCIe bandwidth, limited by 8.0 GT/s PCIe x4 link at 0000:00:1c.4 (capable of 63.012 Gb/s with 16.0 GT/s PCIe x4 link) May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.4: PCI bridge to [bus 03] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.4: bridge window [mem 0x91200000-0x912fffff] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: on NUMA node 0 May 05 04:17:39 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 11 May 05 04:17:39 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 May 05 04:17:39 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 May 05 04:17:39 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 May 05 04:17:39 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 11 May 05 04:17:39 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 11 May 05 04:17:39 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 May 05 04:17:39 volumio-x86 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 May 05 04:17:39 volumio-x86 kernel: Low-power S0 idle used by default for system suspend May 05 04:17:39 volumio-x86 kernel: ACPI: EC: interrupt unblocked May 05 04:17:39 volumio-x86 kernel: ACPI: EC: event unblocked May 05 04:17:39 volumio-x86 kernel: ACPI: EC: EC_CMD/EC_SC=0x66, EC_DATA=0x62 May 05 04:17:39 volumio-x86 kernel: ACPI: EC: GPE=0x6e May 05 04:17:39 volumio-x86 kernel: ACPI: \_SB_.PCI0.LPCB.EC0_: Boot DSDT EC initialization complete May 05 04:17:39 volumio-x86 kernel: ACPI: \_SB_.PCI0.LPCB.EC0_: EC: Used to handle transactions and events May 05 04:17:39 volumio-x86 kernel: iommu: Default domain type: Translated May 05 04:17:39 volumio-x86 kernel: iommu: DMA domain TLB invalidation policy: lazy mode May 05 04:17:39 volumio-x86 kernel: SCSI subsystem initialized May 05 04:17:39 volumio-x86 kernel: libata version 3.00 loaded. May 05 04:17:39 volumio-x86 kernel: ACPI: bus type USB registered May 05 04:17:39 volumio-x86 kernel: usbcore: registered new interface driver usbfs May 05 04:17:39 volumio-x86 kernel: usbcore: registered new interface driver hub May 05 04:17:39 volumio-x86 kernel: usbcore: registered new device driver usb May 05 04:17:39 volumio-x86 kernel: efivars: Registered efivars operations May 05 04:17:39 volumio-x86 kernel: PCI: Using ACPI for IRQ routing May 05 04:17:39 volumio-x86 kernel: PCI: pci_cache_line_size set to 64 bytes May 05 04:17:39 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x76eef000-0x77ffffff] May 05 04:17:39 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x7a840000-0x7bffffff] May 05 04:17:39 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x7aa53000-0x7bffffff] May 05 04:17:39 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x7aa66000-0x7bffffff] May 05 04:17:39 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x27f000000-0x27fffffff] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device May 05 04:17:39 volumio-x86 kernel: pci 0000:00:02.0: vgaarb: bridge control possible May 05 04:17:39 volumio-x86 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none May 05 04:17:39 volumio-x86 kernel: vgaarb: loaded May 05 04:17:39 volumio-x86 kernel: clocksource: Switched to clocksource tsc-early May 05 04:17:39 volumio-x86 kernel: VFS: Disk quotas dquot_6.6.0 May 05 04:17:39 volumio-x86 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 05 04:17:39 volumio-x86 kernel: pnp: PnP ACPI init May 05 04:17:39 volumio-x86 kernel: system 00:00: [mem 0xe0000000-0xefffffff] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:01: [mem 0xfed10000-0xfed17fff] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:01: [mem 0xfed18000-0xfed18fff] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:01: [mem 0xfed19000-0xfed19fff] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:01: [mem 0xfed90000-0xfed93fff] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:01: [mem 0xff000000-0xffffffff] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:01: [mem 0xfee00000-0xfeefffff] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:01: [mem 0xfed00000-0xfed003ff] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:02: [mem 0xfed00000-0xfed003ff] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:03: [io 0x1800-0x18fe] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:05: [io 0x0900-0x09fe] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:06: [io 0x0200] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:06: [io 0x0204] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:06: [io 0x0800-0x087f] has been reserved May 05 04:17:39 volumio-x86 kernel: system 00:06: [io 0x0880-0x08ff] has been reserved May 05 04:17:39 volumio-x86 kernel: pnp: PnP ACPI: found 7 devices May 05 04:17:39 volumio-x86 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.1: [8086:9d20] type 00 class 0x058000 May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1f.1: reg 0x10: [mem 0xfd000000-0xfdffffff 64bit] May 05 04:17:39 volumio-x86 kernel: NET: Registered PF_INET protocol family May 05 04:17:39 volumio-x86 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) May 05 04:17:39 volumio-x86 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) May 05 04:17:39 volumio-x86 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 05 04:17:39 volumio-x86 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) May 05 04:17:39 volumio-x86 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) May 05 04:17:39 volumio-x86 kernel: TCP: Hash tables configured (established 65536 bind 65536) May 05 04:17:39 volumio-x86 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) May 05 04:17:39 volumio-x86 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) May 05 04:17:39 volumio-x86 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.0: PCI bridge to [bus 01] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [io 0x2000-0x2fff] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [mem 0x91000000-0x910fffff] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.3: PCI bridge to [bus 02] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [mem 0x91100000-0x911fffff] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.4: PCI bridge to [bus 03] May 05 04:17:39 volumio-x86 kernel: pci 0000:00:1c.4: bridge window [mem 0x91200000-0x912fffff] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000fffff window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: resource 7 [mem 0x80000000-0xdfffffff window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: resource 8 [mem 0x27f000000-0x7fffffffff window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:00: resource 9 [mem 0xfc800000-0xfe7fffff window] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:01: resource 0 [io 0x2000-0x2fff] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:01: resource 1 [mem 0x91000000-0x910fffff] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:02: resource 1 [mem 0x91100000-0x911fffff] May 05 04:17:39 volumio-x86 kernel: pci_bus 0000:03: resource 1 [mem 0x91200000-0x912fffff] May 05 04:17:39 volumio-x86 kernel: PCI: CLS 64 bytes, default 64 May 05 04:17:39 volumio-x86 kernel: DMAR: Host address width 39 May 05 04:17:39 volumio-x86 kernel: DMAR: DRHD base: 0x000000fed90000 flags: 0x0 May 05 04:17:39 volumio-x86 kernel: DMAR: dmar0: reg_base_addr fed90000 ver 1:0 cap 1c0000c40660462 ecap 19e2ff0505e May 05 04:17:39 volumio-x86 kernel: DMAR: DRHD base: 0x000000fed91000 flags: 0x1 May 05 04:17:39 volumio-x86 kernel: DMAR: dmar1: reg_base_addr fed91000 ver 1:0 cap d2008c40660462 ecap f050da May 05 04:17:39 volumio-x86 kernel: DMAR: RMRR base: 0x0000007b800000 end: 0x0000007fffffff May 05 04:17:39 volumio-x86 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) May 05 04:17:39 volumio-x86 kernel: software IO TLB: mapped [mem 0x0000000072eef000-0x0000000076eef000] (64MB) May 05 04:17:39 volumio-x86 kernel: Trying to unpack rootfs image as initramfs... May 05 04:17:39 volumio-x86 kernel: RAPL PMU: API unit is 2^-32 Joules, 5 fixed counters, 655360 ms ovfl timer May 05 04:17:39 volumio-x86 kernel: RAPL PMU: hw unit of domain pp0-core 2^-14 Joules May 05 04:17:39 volumio-x86 kernel: RAPL PMU: hw unit of domain package 2^-14 Joules May 05 04:17:39 volumio-x86 kernel: RAPL PMU: hw unit of domain dram 2^-14 Joules May 05 04:17:39 volumio-x86 kernel: RAPL PMU: hw unit of domain pp1-gpu 2^-14 Joules May 05 04:17:39 volumio-x86 kernel: RAPL PMU: hw unit of domain psys 2^-14 Joules May 05 04:17:39 volumio-x86 kernel: Initialise system trusted keyrings May 05 04:17:39 volumio-x86 kernel: workingset: timestamp_bits=46 max_order=21 bucket_order=0 May 05 04:17:39 volumio-x86 kernel: zbud: loaded May 05 04:17:39 volumio-x86 kernel: Key type asymmetric registered May 05 04:17:39 volumio-x86 kernel: Asymmetric key parser 'x509' registered May 05 04:17:39 volumio-x86 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) May 05 04:17:39 volumio-x86 kernel: io scheduler mq-deadline registered May 05 04:17:39 volumio-x86 kernel: io scheduler kyber registered May 05 04:17:39 volumio-x86 kernel: pcieport 0000:00:1c.0: PME: Signaling with IRQ 120 May 05 04:17:39 volumio-x86 kernel: pcieport 0000:00:1c.0: AER: enabled with IRQ 120 May 05 04:17:39 volumio-x86 kernel: pcieport 0000:00:1c.3: PME: Signaling with IRQ 121 May 05 04:17:39 volumio-x86 kernel: pcieport 0000:00:1c.3: AER: enabled with IRQ 121 May 05 04:17:39 volumio-x86 kernel: pcieport 0000:00:1c.4: PME: Signaling with IRQ 122 May 05 04:17:39 volumio-x86 kernel: pcieport 0000:00:1c.4: AER: enabled with IRQ 122 May 05 04:17:39 volumio-x86 kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 May 05 04:17:39 volumio-x86 kernel: ACPI: AC: AC Adapter [AC] (on-line) May 05 04:17:39 volumio-x86 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 May 05 04:17:39 volumio-x86 kernel: ACPI: button: Power Button [PWRF] May 05 04:17:39 volumio-x86 kernel: ACPI: battery: Slot [BAT0] (battery absent) May 05 04:17:39 volumio-x86 kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled May 05 04:17:39 volumio-x86 kernel: hpet_acpi_add: no address or irqs in _CRS May 05 04:17:39 volumio-x86 kernel: Linux agpgart interface v0.103 May 05 04:17:39 volumio-x86 kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller May 05 04:17:39 volumio-x86 kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1 May 05 04:17:39 volumio-x86 kernel: xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x0000000081109810 May 05 04:17:39 volumio-x86 kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller May 05 04:17:39 volumio-x86 kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2 May 05 04:17:39 volumio-x86 kernel: xhci_hcd 0000:00:14.0: Host supports USB 3.0 SuperSpeed May 05 04:17:39 volumio-x86 kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 May 05 04:17:39 volumio-x86 kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 May 05 04:17:39 volumio-x86 kernel: usb usb1: Product: xHCI Host Controller May 05 04:17:39 volumio-x86 kernel: usb usb1: Manufacturer: Linux 6.6.32-volumio xhci-hcd May 05 04:17:39 volumio-x86 kernel: usb usb1: SerialNumber: 0000:00:14.0 May 05 04:17:39 volumio-x86 kernel: hub 1-0:1.0: USB hub found May 05 04:17:39 volumio-x86 kernel: hub 1-0:1.0: 12 ports detected May 05 04:17:39 volumio-x86 kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 May 05 04:17:39 volumio-x86 kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 May 05 04:17:39 volumio-x86 kernel: usb usb2: Product: xHCI Host Controller May 05 04:17:39 volumio-x86 kernel: usb usb2: Manufacturer: Linux 6.6.32-volumio xhci-hcd May 05 04:17:39 volumio-x86 kernel: usb usb2: SerialNumber: 0000:00:14.0 May 05 04:17:39 volumio-x86 kernel: hub 2-0:1.0: USB hub found May 05 04:17:39 volumio-x86 kernel: hub 2-0:1.0: 6 ports detected May 05 04:17:39 volumio-x86 kernel: usb: port power management may be unreliable May 05 04:17:39 volumio-x86 kernel: i8042: PNP: No PS/2 controller found. May 05 04:17:39 volumio-x86 kernel: mousedev: PS/2 mouse device common for all mice May 05 04:17:39 volumio-x86 kernel: rtc_cmos 00:04: RTC can wake from S4 May 05 04:17:39 volumio-x86 kernel: rtc_cmos 00:04: registered as rtc0 May 05 04:17:39 volumio-x86 kernel: rtc_cmos 00:04: setting system clock to 2025-05-04T20:17:24 UTC (1746389844) May 05 04:17:39 volumio-x86 kernel: rtc_cmos 00:04: alarms up to one month, y3k, 242 bytes nvram May 05 04:17:39 volumio-x86 kernel: i2c_dev: i2c /dev entries driver May 05 04:17:39 volumio-x86 kernel: platform eisa.0: Probing EISA bus 0 May 05 04:17:39 volumio-x86 kernel: platform eisa.0: EISA: Cannot allocate resource for mainboard May 05 04:17:39 volumio-x86 kernel: intel_pstate: Intel P-state driver initializing May 05 04:17:39 volumio-x86 kernel: intel_pstate: HWP enabled May 05 04:17:39 volumio-x86 kernel: ledtrig-cpu: registered to indicate activity on CPUs May 05 04:17:39 volumio-x86 kernel: efifb: probing for efifb May 05 04:17:39 volumio-x86 kernel: efifb: framebuffer at 0x80000000, using 8128k, total 8128k May 05 04:17:39 volumio-x86 kernel: efifb: mode is 1920x1080x32, linelength=7680, pages=1 May 05 04:17:39 volumio-x86 kernel: efifb: scrolling: redraw May 05 04:17:39 volumio-x86 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 May 05 04:17:39 volumio-x86 kernel: Console: switching to colour frame buffer device 240x67 May 05 04:17:39 volumio-x86 kernel: fb0: EFI VGA frame buffer device May 05 04:17:39 volumio-x86 kernel: intel_pmc_core INT33A1:00: initialized May 05 04:17:39 volumio-x86 kernel: NET: Registered PF_INET6 protocol family May 05 04:17:39 volumio-x86 kernel: Segment Routing with IPv6 May 05 04:17:39 volumio-x86 kernel: In-situ OAM (IOAM) with IPv6 May 05 04:17:39 volumio-x86 kernel: mip6: Mobile IPv6 May 05 04:17:39 volumio-x86 kernel: NET: Registered PF_PACKET protocol family May 05 04:17:39 volumio-x86 kernel: mpls_gso: MPLS GSO support May 05 04:17:39 volumio-x86 kernel: microcode: Microcode Update Driver: v2.2. May 05 04:17:39 volumio-x86 kernel: IPI shorthand broadcast: enabled May 05 04:17:39 volumio-x86 kernel: sched_clock: Marking stable (286768708, 4400542)->(319789293, -28620043) May 05 04:17:39 volumio-x86 kernel: Loading compiled-in X.509 certificates May 05 04:17:39 volumio-x86 kernel: clk: Disabling unused clocks May 05 04:17:39 volumio-x86 kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd May 05 04:17:39 volumio-x86 kernel: usb 1-1: New USB device found, idVendor=2972, idProduct=0081, bcdDevice= 0.08 May 05 04:17:39 volumio-x86 kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 May 05 04:17:39 volumio-x86 kernel: usb 1-1: Product: FIIO KA11 May 05 04:17:39 volumio-x86 kernel: usb 1-1: Manufacturer: FIIO May 05 04:17:39 volumio-x86 kernel: Freeing initrd memory: 68112K May 05 04:17:39 volumio-x86 kernel: Freeing unused kernel image (initmem) memory: 2988K May 05 04:17:39 volumio-x86 kernel: Write protecting the kernel read-only data: 20480k May 05 04:17:39 volumio-x86 kernel: Freeing unused kernel image (rodata/data gap) memory: 1504K May 05 04:17:39 volumio-x86 kernel: Run /init as init process May 05 04:17:39 volumio-x86 kernel: with arguments: May 05 04:17:39 volumio-x86 kernel: /init May 05 04:17:39 volumio-x86 kernel: splash May 05 04:17:39 volumio-x86 kernel: with environment: May 05 04:17:39 volumio-x86 kernel: HOME=/ May 05 04:17:39 volumio-x86 kernel: TERM=linux May 05 04:17:39 volumio-x86 kernel: BOOT_IMAGE=/vmlinuz May 05 04:17:39 volumio-x86 kernel: biosdevname=0 May 05 04:17:39 volumio-x86 kernel: imgpart=UUID=3cc03e2d-018e-43c1-b7e6-361cc0a7c20f May 05 04:17:39 volumio-x86 kernel: bootpart=UUID=0A5D-C90D May 05 04:17:39 volumio-x86 kernel: datapart=UUID=de34b9f5-9b78-4162-a289-2de9c46fbb26 May 05 04:17:39 volumio-x86 kernel: hwdevice=x86 May 05 04:17:39 volumio-x86 kernel: uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg May 05 04:17:39 volumio-x86 kernel: imgfile=/volumio_current.sqsh May 05 04:17:39 volumio-x86 kernel: use_kmsg=no May 05 04:17:39 volumio-x86 kernel: usb 1-2: new low-speed USB device number 3 using xhci_hcd May 05 04:17:39 volumio-x86 kernel: idma64 idma64.0: Found Intel integrated DMA 64-bit May 05 04:17:39 volumio-x86 kernel: idma64 idma64.1: Found Intel integrated DMA 64-bit May 05 04:17:39 volumio-x86 kernel: sdhci: Secure Digital Host Controller Interface driver May 05 04:17:39 volumio-x86 kernel: sdhci: Copyright(c) Pierre Ossman May 05 04:17:39 volumio-x86 kernel: idma64 idma64.4: Found Intel integrated DMA 64-bit May 05 04:17:39 volumio-x86 kernel: idma64 idma64.5: Found Intel integrated DMA 64-bit May 05 04:17:39 volumio-x86 kernel: ACPI: bus type drm_connector registered May 05 04:17:39 volumio-x86 kernel: i801_smbus 0000:00:1f.4: SPD Write Disable is set May 05 04:17:39 volumio-x86 kernel: i801_smbus 0000:00:1f.4: SMBus using PCI interrupt May 05 04:17:39 volumio-x86 kernel: i2c i2c-3: 2/2 memory slots populated (from DMI) May 05 04:17:39 volumio-x86 kernel: i2c i2c-3: Successfully instantiated SPD at 0x50 May 05 04:17:39 volumio-x86 kernel: nvme nvme0: pci function 0000:03:00.0 May 05 04:17:39 volumio-x86 kernel: sdhci-pci 0000:00:1e.6: SDHCI controller found [8086:9d2d] (rev 21) May 05 04:17:39 volumio-x86 kernel: mmc0: SDHCI controller on PCI [0000:00:1e.6] using ADMA 64-bit May 05 04:17:39 volumio-x86 kernel: nvme nvme0: allocated 64 MiB host memory buffer. May 05 04:17:39 volumio-x86 kernel: nvme nvme0: 8/0/0 default/read/poll queues May 05 04:17:39 volumio-x86 kernel: nvme0n1: p1 p2 p3 p4 May 05 04:17:39 volumio-x86 kernel: r8169 0000:01:00.0 eth0: RTL8168h/8111h, d8:c4:97:e3:6c:f8, XID 541, IRQ 134 May 05 04:17:39 volumio-x86 kernel: r8169 0000:01:00.0 eth0: jumbo features [frames: 9194 bytes, tx checksumming: ko] May 05 04:17:39 volumio-x86 kernel: usb 1-2: New USB device found, idVendor=04b3, idProduct=300a, bcdDevice= 1.00 May 05 04:17:39 volumio-x86 kernel: usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0 May 05 04:17:39 volumio-x86 kernel: usb 1-2: Product: IBM USB Keyboard May 05 04:17:39 volumio-x86 kernel: usb 1-2: Manufacturer: Silitek May 05 04:17:39 volumio-x86 kernel: usb 1-5: new full-speed USB device number 4 using xhci_hcd May 05 04:17:39 volumio-x86 kernel: mmc0: new ultra high speed SDR104 SDXC card at address 59b4 May 05 04:17:39 volumio-x86 kernel: mmcblk0: mmc0:59b4 SDU1 57.7 GiB May 05 04:17:39 volumio-x86 kernel: Console: switching to colour dummy device 80x25 May 05 04:17:39 volumio-x86 kernel: i915 0000:00:02.0: vgaarb: deactivate vga console May 05 04:17:39 volumio-x86 kernel: usb 1-5: New USB device found, idVendor=1ea7, idProduct=0064, bcdDevice= 2.00 May 05 04:17:39 volumio-x86 kernel: usb 1-5: New USB device strings: Mfr=0, Product=1, SerialNumber=0 May 05 04:17:39 volumio-x86 kernel: usb 1-5: Product: 2.4G Mouse May 05 04:17:39 volumio-x86 kernel: mmcblk0: p1 p2 p3 May 05 04:17:39 volumio-x86 kernel: tsc: Refined TSC clocksource calibration: 1992.004 MHz May 05 04:17:39 volumio-x86 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x396d59a56c3, max_idle_ns: 881590573781 ns May 05 04:17:39 volumio-x86 kernel: clocksource: Switched to clocksource tsc May 05 04:17:39 volumio-x86 kernel: i915 0000:00:02.0: vgaarb: VGA decodes changed: olddecodes=io+mem,decodes=io+mem:owns=io+mem May 05 04:17:39 volumio-x86 kernel: i915 0000:00:02.0: [drm] Finished loading DMC firmware i915/kbl_dmc_ver1_04.bin (v1.4) May 05 04:17:39 volumio-x86 kernel: usb 1-7: new full-speed USB device number 5 using xhci_hcd May 05 04:17:39 volumio-x86 kernel: usb 1-7: New USB device found, idVendor=8087, idProduct=0a2a, bcdDevice= 0.03 May 05 04:17:39 volumio-x86 kernel: usb 1-7: New USB device strings: Mfr=0, Product=0, SerialNumber=0 May 05 04:17:39 volumio-x86 kernel: hid: raw HID events driver (C) Jiri Kosina May 05 04:17:39 volumio-x86 kernel: usbcore: registered new interface driver usbhid May 05 04:17:39 volumio-x86 kernel: usbhid: USB HID core driver May 05 04:17:39 volumio-x86 kernel: usbcore: registered new interface driver usbkbd May 05 04:17:39 volumio-x86 kernel: usbcore: registered new interface driver usbmouse May 05 04:17:39 volumio-x86 kernel: hid-generic 0003:2972:0081.0001: No inputs registered, leaving May 05 04:17:39 volumio-x86 kernel: hid-generic 0003:2972:0081.0001: hidraw0: USB HID v1.00 Device [FIIO FIIO KA11] on usb-0000:00:14.0-1/input0 May 05 04:17:39 volumio-x86 kernel: input: Silitek IBM USB Keyboard as /devices/pci0000:00/0000:00:14.0/usb1/1-2/1-2:1.0/0003:04B3:300A.0002/input/input2 May 05 04:17:39 volumio-x86 kernel: hid-generic 0003:04B3:300A.0002: input,hidraw1: USB HID v1.00 Keyboard [Silitek IBM USB Keyboard] on usb-0000:00:14.0-2/input0 May 05 04:17:39 volumio-x86 kernel: input: Silitek IBM USB Keyboard Consumer Control as /devices/pci0000:00/0000:00:14.0/usb1/1-2/1-2:1.1/0003:04B3:300A.0003/input/input3 May 05 04:17:39 volumio-x86 kernel: i915 0000:00:02.0: [drm] [ENCODER:94:DDI A/PHY A] failed to retrieve link info, disabling eDP May 05 04:17:39 volumio-x86 kernel: i915 0000:00:02.0: [drm] [ENCODER:103:DDI C/PHY C] is disabled/in DSI mode with an ungated DDI clock, gate it May 05 04:17:39 volumio-x86 kernel: i915 0000:00:02.0: [drm] [ENCODER:114:DDI D/PHY D] is disabled/in DSI mode with an ungated DDI clock, gate it May 05 04:17:39 volumio-x86 kernel: [drm] Initialized i915 1.6.0 20201103 for 0000:00:02.0 on minor 0 May 05 04:17:39 volumio-x86 kernel: input: Silitek IBM USB Keyboard System Control as /devices/pci0000:00/0000:00:14.0/usb1/1-2/1-2:1.1/0003:04B3:300A.0003/input/input4 May 05 04:17:39 volumio-x86 kernel: hid-generic 0003:04B3:300A.0003: input,hidraw2: USB HID v1.10 Device [Silitek IBM USB Keyboard] on usb-0000:00:14.0-2/input1 May 05 04:17:39 volumio-x86 kernel: input: 2.4G Mouse as /devices/pci0000:00/0000:00:14.0/usb1/1-5/1-5:1.0/0003:1EA7:0064.0004/input/input5 May 05 04:17:39 volumio-x86 kernel: input: 2.4G Mouse as /devices/pci0000:00/0000:00:14.0/usb1/1-5/1-5:1.0/0003:1EA7:0064.0004/input/input6 May 05 04:17:39 volumio-x86 kernel: hid-generic 0003:1EA7:0064.0004: input,hiddev0,hidraw3: USB HID v1.10 Mouse [2.4G Mouse] on usb-0000:00:14.0-5/input0 May 05 04:17:39 volumio-x86 kernel: fbcon: i915drmfb (fb0) is primary device May 05 04:17:39 volumio-x86 kernel: Console: switching to colour frame buffer device 240x67 May 05 04:17:39 volumio-x86 kernel: i915 0000:00:02.0: [drm] fb0: i915drmfb frame buffer device May 05 04:17:39 volumio-x86 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 05 04:17:39 volumio-x86 kernel: fuse: init (API version 7.39) May 05 04:17:39 volumio-x86 kernel: usbcore: registered new interface driver usb-storage May 05 04:17:39 volumio-x86 kernel: usbcore: registered new interface driver uas May 05 04:17:39 volumio-x86 kernel: [drm] radeon kernel modesetting enabled. May 05 04:17:39 volumio-x86 kernel: genirq: Flags mismatch irq 14. 00000008 (platform[pata_legacy.0]) vs. 00010088 (INT344B:00) May 05 04:17:39 volumio-x86 kernel: scsi host0: pata_legacy May 05 04:17:39 volumio-x86 kernel: ata1: PATA max PIO4 cmd 0x170 ctl 0x376 irq 15 May 05 04:17:39 volumio-x86 kernel: FAT-fs (mmcblk0p1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! May 05 04:17:39 volumio-x86 kernel: EXT4-fs (mmcblk0p2): recovery complete May 05 04:17:39 volumio-x86 kernel: EXT4-fs (mmcblk0p2): mounted filesystem 3cc03e2d-018e-43c1-b7e6-361cc0a7c20f r/w with ordered data mode. Quota mode: none. May 05 04:17:39 volumio-x86 kernel: loop: module loaded May 05 04:17:39 volumio-x86 kernel: block device autoloading is deprecated and will be removed. May 05 04:17:39 volumio-x86 kernel: loop0: detected capacity change from 0 to 1726400 May 05 04:17:39 volumio-x86 kernel: EXT4-fs (mmcblk0p3): mounted filesystem de34b9f5-9b78-4162-a289-2de9c46fbb26 r/w with ordered data mode. Quota mode: none. May 05 04:17:39 volumio-x86 kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038-01-19 (0x7fffffff) May 05 04:17:39 volumio-x86 systemd[1]: Inserted module 'autofs4' May 05 04:17:39 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) May 05 04:17:39 volumio-x86 systemd[1]: Detected architecture x86-64. May 05 04:17:39 volumio-x86 systemd[1]: Set hostname to . May 05 04:17:39 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. May 05 04:17:39 volumio-x86 systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) May 05 04:17:39 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. May 05 04:17:39 volumio-x86 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. May 05 04:17:39 volumio-x86 systemd[1]: Listening on Journal Audit Socket. May 05 04:17:39 volumio-x86 systemd[1]: Reached target System Time Synchronized. May 05 04:17:39 volumio-x86 systemd[1]: Listening on Journal Socket (/dev/log). May 05 04:17:39 volumio-x86 systemd-journald[541]: Journal started May 05 04:17:39 volumio-x86 systemd-journald[541]: Runtime journal (/run/log/journal/bd097a20dc242dbec9d88bbb67ead084) is 3.7M, max 30.0M, 26.2M free. May 05 04:17:39 volumio-x86 systemd[1]: Started Remount Root and Kernel File Systems. May 05 04:17:39 volumio-x86 systemd[1]: Mounted POSIX Message Queue File System. May 05 04:17:39 volumio-x86 systemd[1]: Mounted Kernel Debug File System. May 05 04:17:39 volumio-x86 systemd[1]: Mounted Huge Pages File System. May 05 04:17:39 volumio-x86 systemd[1]: Started Apply Kernel Variables. May 05 04:17:39 volumio-x86 systemd[1]: Mounted FUSE Control File System. May 05 04:17:39 volumio-x86 systemd[1]: Mounted Kernel Configuration File System. May 05 04:17:39 volumio-x86 systemd[1]: Starting Load/Save Random Seed... May 05 04:17:39 volumio-x86 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. May 05 04:17:39 volumio-x86 systemd[1]: Starting Create System Users... May 05 04:17:39 volumio-x86 fake-hwclock[543]: Current system time: 2025-05-04 20:17:39 May 05 04:17:39 volumio-x86 fake-hwclock[543]: fake-hwclock saved clock information is in the past: 2025-04-18 05:55:47 May 05 04:17:39 volumio-x86 fake-hwclock[543]: To set system time to this saved clock anyway, use "force" May 05 04:17:39 volumio-x86 systemd[1]: Started Restore / save the current clock. May 05 04:17:39 volumio-x86 systemd[1]: Started Load/Save Random Seed. May 05 04:17:39 volumio-x86 systemd[1]: Started udev Coldplug all Devices. May 05 04:17:39 volumio-x86 systemd[1]: Starting Helper to synchronize boot up for ifupdown... May 05 04:17:39 volumio-x86 systemd[1]: Mounted RPC Pipe File System. May 05 04:17:39 volumio-x86 kernel: RPC: Registered named UNIX socket transport module. May 05 04:17:39 volumio-x86 kernel: RPC: Registered udp transport module. May 05 04:17:39 volumio-x86 kernel: RPC: Registered tcp transport module. May 05 04:17:39 volumio-x86 kernel: RPC: Registered tcp-with-tls transport module. May 05 04:17:39 volumio-x86 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. May 05 04:17:39 volumio-x86 systemd[1]: Started Helper to synchronize boot up for ifupdown. May 05 04:17:39 volumio-x86 systemd[1]: dynamicswap.service: Succeeded. May 05 04:17:39 volumio-x86 systemd[1]: Started Create System Users. May 05 04:17:39 volumio-x86 systemd[1]: Starting Create Static Device Nodes in /dev... May 05 04:17:39 volumio-x86 systemd[1]: Started Create Static Device Nodes in /dev. May 05 04:17:39 volumio-x86 systemd[1]: Reached target Local File Systems (Pre). May 05 04:17:39 volumio-x86 systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. May 05 04:17:39 volumio-x86 systemd[1]: Mounting /var/log... May 05 04:17:39 volumio-x86 systemd[1]: Mounting /var/spool/cups... May 05 04:17:39 volumio-x86 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. May 05 04:17:39 volumio-x86 systemd[1]: Mounting /tmp... May 05 04:17:39 volumio-x86 systemd[1]: Starting udev Kernel Device Manager... May 05 04:17:39 volumio-x86 systemd[1]: Mounted /var/log. May 05 04:17:39 volumio-x86 systemd[1]: Mounted /var/spool/cups. May 05 04:17:39 volumio-x86 systemd[1]: Mounted /tmp. May 05 04:17:39 volumio-x86 systemd[1]: Mounting /var/spool/cups/tmp... May 05 04:17:39 volumio-x86 systemd[1]: Starting Flush Journal to Persistent Storage... May 05 04:17:39 volumio-x86 systemd[1]: Mounted /var/spool/cups/tmp. May 05 04:17:39 volumio-x86 systemd-udevd[572]: Network interface NamePolicy= disabled on kernel command line, ignoring. May 05 04:17:39 volumio-x86 systemd-journald[541]: Runtime journal (/run/log/journal/bd097a20dc242dbec9d88bbb67ead084) is 3.7M, max 30.0M, 26.2M free. May 05 04:17:39 volumio-x86 systemd[1]: Started udev Kernel Device Manager. May 05 04:17:39 volumio-x86 systemd[1]: Starting Show Plymouth Boot Screen... May 05 04:17:39 volumio-x86 systemd[1]: Started Flush Journal to Persistent Storage. May 05 04:17:39 volumio-x86 systemd[1]: plymouth-start.service: Succeeded. May 05 04:17:39 volumio-x86 systemd[1]: Started Show Plymouth Boot Screen. May 05 04:17:39 volumio-x86 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 05 04:17:39 volumio-x86 systemd[1]: Reached target Local Encrypted Volumes. May 05 04:17:39 volumio-x86 systemd[1]: Reached target Paths. May 05 04:17:39 volumio-x86 systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. May 05 04:17:39 volumio-x86 systemd-udevd[598]: Using default interface naming scheme 'v240'. May 05 04:17:39 volumio-x86 systemd-udevd[598]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 05 04:17:39 volumio-x86 systemd-udevd[603]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 05 04:17:39 volumio-x86 kernel: Consider using thermal netlink events interface May 05 04:17:39 volumio-x86 kernel: pstore: Using crash dump compression: deflate May 05 04:17:39 volumio-x86 kernel: pstore: Registered efi_pstore as persistent store backend May 05 04:17:39 volumio-x86 kernel: dw-apb-uart.2: ttyS4 at MMIO 0xfe030000 (irq = 32, base_baud = 115200) is a 16550A May 05 04:17:39 volumio-x86 kernel: dw-apb-uart.4: ttyS5 at MMIO 0x91336000 (irq = 20, base_baud = 7500000) is a 16550A May 05 04:17:39 volumio-x86 kernel: cryptd: max_cpu_qlen set to 1000 May 05 04:17:39 volumio-x86 kernel: intel_rapl_common: Found RAPL domain package May 05 04:17:39 volumio-x86 kernel: intel_rapl_common: Found RAPL domain dram May 05 04:17:39 volumio-x86 systemd-udevd[591]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 04:17:39 volumio-x86 kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database May 05 04:17:39 volumio-x86 kernel: AVX2 version of gcm_enc/dec engaged. May 05 04:17:39 volumio-x86 kernel: AES CTR mode by8 optimization enabled May 05 04:17:39 volumio-x86 kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' May 05 04:17:39 volumio-x86 kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' May 05 04:17:39 volumio-x86 kernel: Intel(R) Wireless WiFi driver for Linux May 05 04:17:39 volumio-x86 kernel: iwlwifi 0000:02:00.0: Detected crf-id 0x0, cnv-id 0x0 wfpm id 0x0 May 05 04:17:39 volumio-x86 kernel: iwlwifi 0000:02:00.0: PCI dev 095a/5010, rev=0x210, rfid=0xd55555d5 May 05 04:17:39 volumio-x86 kernel: snd_hda_intel 0000:00:1f.3: DSP detected with PCI class/subclass/prog-if info 0x040100 May 05 04:17:39 volumio-x86 kernel: rt5663 i2c-10EC5663:00: supply avdd not found, using dummy regulator May 05 04:17:39 volumio-x86 kernel: rt5663 i2c-10EC5663:00: supply cpvdd not found, using dummy regulator May 05 04:17:39 volumio-x86 kernel: usb 1-1: 2:4 : unsupported format bits 0x100000000 May 05 04:17:39 volumio-x86 kernel: usbcore: registered new interface driver snd-usb-audio May 05 04:17:39 volumio-x86 kernel: iwlwifi 0000:02:00.0: Found debug destination: EXTERNAL_DRAM May 05 04:17:39 volumio-x86 kernel: iwlwifi 0000:02:00.0: Found debug configuration: 0 May 05 04:17:39 volumio-x86 kernel: iwlwifi 0000:02:00.0: loaded firmware version 29.4063824552.0 7265D-29.ucode op_mode iwlmvm May 05 04:17:40 volumio-x86 systemd-udevd[606]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 04:17:40 volumio-x86 systemd-udevd[596]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 04:17:40 volumio-x86 systemd-udevd[624]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 04:17:40 volumio-x86 kernel: Bluetooth: Core ver 2.22 May 05 04:17:40 volumio-x86 kernel: NET: Registered PF_BLUETOOTH protocol family May 05 04:17:40 volumio-x86 kernel: Bluetooth: HCI device and connection manager initialized May 05 04:17:40 volumio-x86 kernel: Bluetooth: HCI socket layer initialized May 05 04:17:40 volumio-x86 kernel: Bluetooth: L2CAP socket layer initialized May 05 04:17:40 volumio-x86 kernel: Bluetooth: SCO socket layer initialized May 05 04:17:40 volumio-x86 kernel: snd_soc_skl 0000:00:1f.3: DSP detected with PCI class/subclass/prog-if info 0x040100 May 05 04:17:40 volumio-x86 kernel: snd_soc_skl 0000:00:1f.3: bound 0000:00:02.0 (ops __SCT__tp_func_intel_frontbuffer_flush [i915]) May 05 04:17:40 volumio-x86 systemd-udevd[602]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 04:17:40 volumio-x86 kernel: HDMI HDA Codec ehdaudio0D2: Max dais supported: 3 May 05 04:17:40 volumio-x86 kernel: usbcore: registered new interface driver btusb May 05 04:17:40 volumio-x86 kernel: Bluetooth: hci0: Legacy ROM 2.x revision 5.0 build 25 week 20 2015 May 05 04:17:40 volumio-x86 kernel: Bluetooth: hci0: Intel device is already patched. patch num: 3c May 05 04:17:40 volumio-x86 kernel: iwlwifi 0000:02:00.0: Detected Intel(R) Dual Band Wireless AC 7265, REV=0x210 May 05 04:17:40 volumio-x86 kernel: thermal thermal_zone5: failed to read out thermal zone (-61) May 05 04:17:40 volumio-x86 kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM May 05 04:17:40 volumio-x86 kernel: iwlwifi 0000:02:00.0: Allocated 0x00400000 bytes for firmware monitor. May 05 04:17:40 volumio-x86 kernel: iwlwifi 0000:02:00.0: base HW address: 48:f1:7f:b2:ca:f5, OTP minor version: 0x0 May 05 04:17:40 volumio-x86 systemd-udevd[636]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 04:17:40 volumio-x86 systemd-udevd[633]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 04:17:40 volumio-x86 kernel: ieee80211 phy0: Selected rate control algorithm 'iwl-mvm-rs' May 05 04:17:40 volumio-x86 systemd-udevd[632]: Using default interface naming scheme 'v240'. May 05 04:17:40 volumio-x86 systemd-udevd[632]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 05 04:17:40 volumio-x86 systemd-udevd[628]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. May 05 04:17:40 volumio-x86 kernel: alsactl[775]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set May 05 04:17:40 volumio-x86 systemd-udevd[614]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99. May 05 04:17:40 volumio-x86 systemd[1]: Found device /dev/disk/by-uuid/0A5D-C90D. May 05 04:17:40 volumio-x86 systemd[1]: Condition check resulted in RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller (RTL8111/8168 PCI Express Gigabit Ethernet controller) being skipped. May 05 04:17:40 volumio-x86 systemd[1]: Condition check resulted in Wireless 7265 (Dual Band Wireless-AC 7265) being skipped. May 05 04:17:40 volumio-x86 systemd[1]: Starting Show Plymouth Boot Screen... May 05 04:17:40 volumio-x86 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. May 05 04:17:40 volumio-x86 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. May 05 04:17:40 volumio-x86 systemd[1]: Starting File System Check on /dev/disk/by-uuid/0A5D-C90D... May 05 04:17:40 volumio-x86 systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. May 05 04:17:40 volumio-x86 systemd[1]: Starting Load/Save RF Kill Switch Status... May 05 04:17:40 volumio-x86 systemd[1]: Started File System Check Daemon to report status. May 05 04:17:40 volumio-x86 systemd[1]: plymouth-start.service: Succeeded. May 05 04:17:40 volumio-x86 systemd[1]: Started Show Plymouth Boot Screen. May 05 04:17:40 volumio-x86 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 05 04:17:40 volumio-x86 systemd[1]: Started Load/Save RF Kill Switch Status. May 05 04:17:41 volumio-x86 systemd-fsck[803]: fsck.fat 4.1 (2017-01-24) May 05 04:17:41 volumio-x86 systemd-fsck[803]: There are differences between boot sector and its backup. May 05 04:17:41 volumio-x86 systemd-fsck[803]: This is mostly harmless. Differences: (offset:original/backup) May 05 04:17:41 volumio-x86 systemd-fsck[803]: 3:53/6d, 4:59/6b, 5:53/66, 6:4c/73, 7:49/2e, 8:4e/66, 9:55/61, 10:58/74 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 90:fa/0e, 91:fc/1f, 92:31/be, 93:c9/77, 94:8e/7c, 95:d1/ac, 96:bc/22 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 97:76/c0, 98:7b/74, 99:52/0b, 100:06/56, 101:57/b4, 102:1e/0e, 103:56/bb May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 104:8e/07, 105:c1/00, 106:b1/cd, 107:26/10, 108:bf/5e, 109:78/eb May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 110:7b/f0, 111:f3/32, 112:a5/e4, 113:8e/cd, 114:d9/16, 115:bb/cd May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 116:78/19, 117:00/eb, 118:0f/fe, 119:b4/54, 120:37/68, 121:0f/69 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 122:a0/73, 123:56/20, 124:20/69, 125:d2/73, 126:78/20, 127:1b/6e May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 128:31/6f, 129:c0/74, 130:b1/20, 131:06/61, 132:89/20, 133:3f/62 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 134:89/6f, 135:47/6f, 136:02/74, 137:f3/61, 138:64/62, 139:a5/6c May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 140:8a/65, 141:0e/20, 142:18/64, 143:7c/69, 144:88/73, 145:4d/6b May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 146:f8/2e, 147:50/20, 148:50/20, 150:50/6c, 151:cd/65, 152:13/61 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 153:eb/73, 154:62/65, 155:8b/20, 156:55/69, 157:aa/6e, 158:8b/73 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 159:75/65, 160:a8/72, 161:c1/74, 162:ee/20, 163:04/61, 164:01/20 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 165:f2/62, 166:83/6f, 167:fa/6f, 168:4f/74, 169:76/61, 170:31/62 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 171:81/6c, 172:fa/65, 173:b2/20, 174:07/66, 175:73/6c, 176:2b/6f May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 177:f6/70, 178:45/70, 179:b4/79, 180:7f/20, 181:75/61, 182:25/6e May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 183:38/64, 184:4d/0d, 185:b8/0a, 186:74/70, 187:20/72, 188:66/65 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 189:3d/73, 190:21/73, 191:47/20, 192:50/61, 193:54/6e, 194:75/79 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 195:10/20, 196:80/6b, 197:7d/65, 198:b8/79, 199:ed/20, 200:75/74 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 201:0a/6f, 202:66/20, 203:ff/74, 204:75/72, 205:ec/79, 206:66/20 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 207:ff/61, 208:75/67, 209:e8/61, 210:eb/69, 211:0f/6e, 212:51/20 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 213:51/2e, 214:66/2e, 215:ff/2e, 216:75/20, 217:bc/0d, 218:eb/0a May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 219:07/00, 220:51/00, 221:51/00, 222:66/00, 223:ff/00, 224:36/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 225:1c/00, 226:7c/00, 227:b4/00, 228:08/00, 229:e8/00, 230:e9/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 232:72/00, 233:13/00, 234:20/00, 235:e4/00, 236:75/00, 237:0f/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 238:c1/00, 239:ea/00, 240:08/00, 241:42/00, 242:89/00, 243:16/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 244:1a/00, 245:7c/00, 246:83/00, 247:e1/00, 248:3f/00, 249:89/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 250:0e/00, 251:18/00, 252:7c/00, 253:fb/00, 254:bb/00, 255:aa/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 256:55/00, 257:b4/00, 258:41/00, 259:e8/00, 260:cb/00, 262:72/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 263:10/00, 264:81/00, 265:fb/00, 266:55/00, 267:aa/00, 268:75/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 269:0a/00, 270:f6/00, 271:c1/00, 272:01/00, 273:74/00, 274:05/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 275:c6/00, 276:06/00, 277:46/00, 278:7d/00, 280:66/00, 281:b8/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 282:c6/00, 283:9b/00, 286:66/00, 287:ba/00, 292:bb/00, 294:80/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 295:e8/00, 296:0e/00, 298:66/00, 299:81/00, 300:3e/00, 301:1c/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 302:80/00, 303:d5/00, 304:cf/00, 305:c7/00, 306:62/00, 307:75/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 308:74/00, 309:e9/00, 310:f8/00, 311:02/00, 312:66/00, 313:03/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 314:06/00, 315:60/00, 316:7b/00, 317:66/00, 318:13/00, 319:16/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 320:64/00, 321:7b/00, 322:b9/00, 323:10/00, 325:eb/00, 326:2b/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 327:66/00, 328:52/00, 329:66/00, 330:50/00, 331:06/00, 332:53/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 333:6a/00, 334:01/00, 335:6a/00, 336:10/00, 337:89/00, 338:e6/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 339:66/00, 340:60/00, 341:b4/00, 342:42/00, 343:e8/00, 344:77/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 346:66/00, 347:61/00, 348:8d/00, 349:64/00, 350:10/00, 351:72/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 352:01/00, 353:c3/00, 354:66/00, 355:60/00, 356:31/00, 357:c0/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 358:e8/00, 359:68/00, 361:66/00, 362:61/00, 363:e2/00, 364:da/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 365:c6/00, 366:06/00, 367:46/00, 368:7d/00, 369:2b/00, 370:66/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 371:60/00, 372:66/00, 373:0f/00, 374:b7/00, 375:36/00, 376:18/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 377:7c/00, 378:66/00, 379:0f/00, 380:b7/00, 381:3e/00, 382:1a/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 383:7c/00, 384:66/00, 385:f7/00, 386:f6/00, 387:31/00, 388:c9/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 389:87/00, 390:ca/00, 391:66/00, 392:f7/00, 393:f7/00, 394:66/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 395:3d/00, 396:ff/00, 397:03/00, 400:77/00, 401:17/00, 402:c0/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 403:e4/00, 404:06/00, 405:41/00, 406:08/00, 407:e1/00, 408:88/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 409:c5/00, 410:88/00, 411:d6/00, 412:b8/00, 413:01/00, 414:02/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 415:e8/00, 416:2f/00, 418:66/00, 419:61/00, 420:72/00, 421:01/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 422:c3/00, 423:e2/00, 424:c9/00, 425:31/00, 426:f6/00, 427:8e/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 428:d6/00, 429:bc/00, 430:68/00, 431:7b/00, 432:8e/00, 433:de/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 434:66/00, 435:8f/00, 436:06/00, 437:78/00, 439:be/00, 440:da/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 441:7d/00, 442:ac/00, 443:20/00, 444:c0/00, 445:74/00, 446:09/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 447:b4/00, 448:0e/00, 449:bb/00, 450:07/00, 452:cd/00, 453:10/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 454:eb/00, 455:f2/00, 456:31/00, 457:c0/00, 458:cd/00, 459:16/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 460:cd/00, 461:19/00, 462:f4/00, 463:eb/00, 464:fd/00, 465:8a/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 466:16/00, 467:74/00, 468:7b/00, 469:06/00, 470:cd/00, 471:13/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 472:07/00, 473:c3/00, 474:42/00, 475:6f/00, 476:6f/00, 477:74/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 478:20/00, 479:65/00, 480:72/00, 481:72/00, 482:6f/00, 483:72/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 484:0d/00, 485:0a/00, 504:fe/00, 505:02/00, 506:b2/00, 507:3e/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: , 508:18/00, 509:37/00 May 05 04:17:41 volumio-x86 systemd-fsck[803]: Not automatically fixing this. May 05 04:17:41 volumio-x86 systemd-fsck[803]: /dev/mmcblk0p1: 18 files, 159614/344788 clusters May 05 04:17:41 volumio-x86 systemd[1]: Started File System Check on /dev/disk/by-uuid/0A5D-C90D. May 05 04:17:41 volumio-x86 systemd[1]: Mounting /boot... May 05 04:17:41 volumio-x86 kernel: FAT-fs (mmcblk0p1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! May 05 04:17:41 volumio-x86 systemd[1]: Mounted /boot. May 05 04:17:41 volumio-x86 systemd[1]: Reached target Local File Systems. May 05 04:17:41 volumio-x86 kernel: snd_soc_skl 0000:00:1f.3: Direct firmware load for 9d71-GOOGLE-FIZZ-0-tplg.bin failed with error -2 May 05 04:17:41 volumio-x86 kernel: snd_soc_skl 0000:00:1f.3: tplg fw 9d71-GOOGLE-FIZZ-0-tplg.bin load failed with -2, trying alternative tplg name kbl_rt5663-tplg.bin May 05 04:17:41 volumio-x86 kernel: snd_soc_skl 0000:00:1f.3: Direct firmware load for kbl_rt5663-tplg.bin failed with error -2 May 05 04:17:41 volumio-x86 kernel: snd_soc_skl 0000:00:1f.3: tplg kbl_rt5663-tplg.bin failed with -2, falling back to dfw_sst.bin May 05 04:17:41 volumio-x86 kernel: snd_soc_skl 0000:00:1f.3: Direct firmware load for dfw_sst.bin failed with error -2 May 05 04:17:41 volumio-x86 kernel: snd_soc_skl 0000:00:1f.3: Fallback tplg fw dfw_sst.bin load failed with -2 May 05 04:17:41 volumio-x86 kernel: snd_soc_skl 0000:00:1f.3: Failed to init topology! May 05 04:17:41 volumio-x86 kernel: snd_soc_skl 0000:00:1f.3: ASoC: error at snd_soc_component_probe on 0000:00:1f.3: -2 May 05 04:17:41 volumio-x86 kernel: kbl_rt5663_m98927 kbl_rt5663: ASoC: failed to instantiate card -2 May 05 04:17:41 volumio-x86 kernel: kbl_rt5663_m98927: probe of kbl_rt5663 failed with error -2 May 05 04:17:41 volumio-x86 systemd[1]: Started ifup for wlan0. May 05 04:17:41 volumio-x86 systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... May 05 04:17:41 volumio-x86 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. May 05 04:17:41 volumio-x86 systemd[1]: Started ifup for eth0. May 05 04:17:41 volumio-x86 systemd[1]: Starting Raise network interfaces... May 05 04:17:41 volumio-x86 systemd[1]: Starting Preprocess NFS configuration... May 05 04:17:41 volumio-x86 systemd[1]: Starting Create Volatile Files and Directories... May 05 04:17:41 volumio-x86 systemd[1]: Received SIGRTMIN+20 from PID 404 (plymouthd). May 05 04:17:41 volumio-x86 systemd[1]: plymouth-read-write.service: Succeeded. May 05 04:17:41 volumio-x86 systemd[1]: Started Tell Plymouth To Write Out Runtime Data. May 05 04:17:41 volumio-x86 systemd[1]: nfs-config.service: Succeeded. May 05 04:17:41 volumio-x86 systemd[1]: Started Preprocess NFS configuration. May 05 04:17:41 volumio-x86 systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. May 05 04:17:41 volumio-x86 systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. May 05 04:17:41 volumio-x86 systemd[1]: Reached target NFS client services. May 05 04:17:41 volumio-x86 kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 May 05 04:17:41 volumio-x86 systemd[1]: Started Create Volatile Files and Directories. May 05 04:17:41 volumio-x86 systemd[1]: Starting Update UTMP about System Boot/Shutdown... May 05 04:17:41 volumio-x86 systemd[1]: Started Entropy daemon using the HAVEGE algorithm. May 05 04:17:41 volumio-x86 systemd[1]: Starting RPC bind portmap service... May 05 04:17:41 volumio-x86 systemd[1]: Condition check resulted in Network Time Synchronization being skipped. May 05 04:17:41 volumio-x86 systemd[1]: Started Update UTMP about System Boot/Shutdown. May 05 04:17:41 volumio-x86 systemd[1]: Reached target System Initialization. May 05 04:17:41 volumio-x86 systemd[1]: Listening on D-Bus System Message Bus Socket. May 05 04:17:41 volumio-x86 systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. May 05 04:17:41 volumio-x86 systemd[1]: Started Daily Cleanup of Temporary Directories. May 05 04:17:41 volumio-x86 systemd[1]: Started Daily man-db regeneration. May 05 04:17:41 volumio-x86 systemd[1]: Listening on triggerhappy.socket. May 05 04:17:41 volumio-x86 systemd[1]: Reached target Sockets. May 05 04:17:41 volumio-x86 systemd[1]: Reached target Basic System. May 05 04:17:41 volumio-x86 systemd[1]: Starting Bluetooth service... May 05 04:17:41 volumio-x86 systemd[1]: Starting triggerhappy global hotkey daemon... May 05 04:17:41 volumio-x86 systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. May 05 04:17:41 volumio-x86 systemd[1]: Starting Avahi mDNS/DNS-SD Stack... May 05 04:17:41 volumio-x86 systemd[1]: Started UPnP Renderer front-end to MPD. May 05 04:17:41 volumio-x86 systemd[1]: Started D-Bus System Message Bus. May 05 04:17:41 volumio-x86 systemd[1]: Starting WPA supplicant... May 05 04:17:41 volumio-x86 systemd[1]: Started Manage Sound Card State (restore and store). May 05 04:17:41 volumio-x86 systemd[1]: Started Volumio Log Rotation Service. May 05 04:17:41 volumio-x86 alsactl[891]: alsactl 1.1.8 daemon started May 05 04:17:41 volumio-x86 systemd[1]: Started Volumio Iptables Module. May 05 04:17:41 volumio-x86 systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. May 05 04:17:41 volumio-x86 systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. May 05 04:17:41 volumio-x86 systemd[1]: Starting DHCP Client Daemon... May 05 04:17:41 volumio-x86 systemd[1]: Started MPD Monitor Service. May 05 04:17:41 volumio-x86 systemd[1]: Starting Volumio Time Update Utility... May 05 04:17:41 volumio-x86 systemd[1]: Starting Login Service... May 05 04:17:41 volumio-x86 systemd[1]: Starting Save/Restore Sound Card State... May 05 04:17:41 volumio-x86 systemd[1]: Starting Wireless Services... May 05 04:17:41 volumio-x86 systemd[1]: Started volumio-remote-updater.service. May 05 04:17:41 volumio-x86 kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM May 05 04:17:41 volumio-x86 systemd[1]: Started My Shell Script. May 05 04:17:41 volumio-x86 systemd[1]: Started Daily apt download activities. May 05 04:17:41 volumio-x86 systemd[1]: Started Daily apt upgrade and clean activities. May 05 04:17:41 volumio-x86 systemd[1]: Reached target Timers. May 05 04:17:41 volumio-x86 systemd[1]: Started RPC bind portmap service. May 05 04:17:41 volumio-x86 systemd[1]: Starting Daily man-db regeneration... May 05 04:17:41 volumio-x86 systemd[1]: Reached target RPC Port Mapper. May 05 04:17:41 volumio-x86 systemd[1]: Reached target Remote File Systems (Pre). May 05 04:17:41 volumio-x86 systemd[1]: Reached target Remote File Systems. May 05 04:17:41 volumio-x86 systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... May 05 04:17:41 volumio-x86 alsactl[891]: No state is present for card KA11 May 05 04:17:41 volumio-x86 alsactl[891]: Found hardware: "USB-Audio" "USB Mixer" "USB2972:0081" "" "" May 05 04:17:41 volumio-x86 alsactl[891]: Hardware is initialized using a generic method May 05 04:17:41 volumio-x86 alsactl[891]: No state is present for card KA11 May 05 04:17:41 volumio-x86 volumio-time-update[896]: volumio-time-update-util: Fetching time from Volumio... May 05 04:17:41 volumio-x86 mpd_monitor.sh[895]: MPD Monitor Service: Starting MPD Monitor Service May 05 04:17:41 volumio-x86 kernel: 8021q: 802.1Q VLAN Support v1.8 May 05 04:17:41 volumio-x86 alsactl[898]: No state is present for card KA11 May 05 04:17:41 volumio-x86 alsactl[898]: Found hardware: "USB-Audio" "USB Mixer" "USB2972:0081" "" "" May 05 04:17:41 volumio-x86 alsactl[898]: Hardware is initialized using a generic method May 05 04:17:41 volumio-x86 alsactl[898]: No state is present for card KA11 May 05 04:17:41 volumio-x86 kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM May 05 04:17:41 volumio-x86 kernel: iwlwifi 0000:02:00.0: FW already configured (0) - re-configuring May 05 04:17:41 volumio-x86 systemd-logind[897]: New seat seat0. May 05 04:17:41 volumio-x86 systemd-logind[897]: Watching system buttons on /dev/input/event0 (Power Button) May 05 04:17:41 volumio-x86 systemd-logind[897]: Watching system buttons on /dev/input/event1 (Silitek IBM USB Keyboard) May 05 04:17:41 volumio-x86 thd[886]: Unable to parse trigger line: May 05 04:17:41 volumio-x86 thd[886]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle May 05 04:17:41 volumio-x86 thd[886]: Unable to parse trigger line: May 05 04:17:41 volumio-x86 thd[886]: Found socket passed from systemd May 05 04:17:41 volumio-x86 systemd-logind[897]: Watching system buttons on /dev/input/event3 (Silitek IBM USB Keyboard System Control) May 05 04:17:41 volumio-x86 mpd_monitor.sh[895]: MPD error: Connection refused May 05 04:17:41 volumio-x86 mpd_monitor.sh[895]: MPD Monitor Service: MPD Appears to be inactive, restarting May 05 04:17:41 volumio-x86 thd[886]: Device /dev/input/event4 not suitable. May 05 04:17:41 volumio-x86 haveged[880]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K May 05 04:17:41 volumio-x86 haveged[880]: haveged: cpu: (L4 VC); data: 32K (L4 V); inst: 32K (L4 V); idx: 24/40; sz: 31410/52825 May 05 04:17:41 volumio-x86 haveged[880]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99998 May 05 04:17:41 volumio-x86 haveged[880]: haveged: fills: 0, generated: 0 May 05 04:17:41 volumio-x86 mpd_monitor.sh[895]: mpd: no process found May 05 04:17:41 volumio-x86 avahi-daemon[887]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). May 05 04:17:41 volumio-x86 avahi-daemon[887]: Successfully dropped root privileges. May 05 04:17:41 volumio-x86 avahi-daemon[887]: avahi-daemon 0.7 starting up. May 05 04:17:41 volumio-x86 bluetoothd[884]: Bluetooth daemon 5.50 May 05 04:17:41 volumio-x86 bluetoothd[884]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf May 05 04:17:41 volumio-x86 volumio-remote-updater[900]: Error: No active session May 05 04:17:41 volumio-x86 volumio-remote-updater[900]: [2025-05-05 04:17:41] [info] asio async_connect error: system:111 (Connection refused) May 05 04:17:41 volumio-x86 volumio-remote-updater[900]: [2025-05-05 04:17:41] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 05 04:17:41 volumio-x86 volumio-time-update[896]: volumio-time-update-util: Date not found in response May 05 04:17:41 volumio-x86 volumio-time-update[896]: volumio-time-update-util: Retrying in 5 seconds... May 05 04:17:41 volumio-x86 volumio-remote-updater[900]: [2025-05-05 04:17:41] [error] handle_connect error: Underlying Transport Error May 05 04:17:41 volumio-x86 dhcpcd[894]: no interfaces have a carrier May 05 04:17:41 volumio-x86 dhcpcd[894]: forked to background, child pid 989 May 05 04:17:41 volumio-x86 dhcpcd[894]: no interfaces have a carrier May 05 04:17:41 volumio-x86 dhcpcd[894]: forked to background, child pid 989 May 05 04:17:42 volumio-x86 kernel: Generic FE-GE Realtek PHY r8169-0-100:00: attached PHY driver (mii_bus:phy_addr=r8169-0-100:00, irq=MAC) May 05 04:17:42 volumio-x86 systemd[1]: Started triggerhappy global hotkey daemon. May 05 04:17:42 volumio-x86 systemd[1]: Started DHCP Client Daemon. May 05 04:17:42 volumio-x86 wpa_supplicant[890]: Successfully initialized wpa_supplicant May 05 04:17:42 volumio-x86 avahi-daemon[887]: Successfully called chroot(). May 05 04:17:42 volumio-x86 systemd[1]: Started Save/Restore Sound Card State. May 05 04:17:42 volumio-x86 avahi-daemon[887]: Successfully dropped remaining capabilities. May 05 04:17:42 volumio-x86 volumio[888]: Could not open config: /tmp/upmpdcli.conf May 05 04:17:42 volumio-x86 bluetoothd[884]: Starting SDP server May 05 04:17:42 volumio-x86 bluetoothd[884]: Excluding (cli) sap May 05 04:17:42 volumio-x86 avahi-daemon[887]: Loading service file /services/volumio.service. May 05 04:17:42 volumio-x86 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 05 04:17:42 volumio-x86 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 05 04:17:42 volumio-x86 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 May 05 04:17:42 volumio-x86 kernel: Bluetooth: BNEP filters: protocol multicast May 05 04:17:42 volumio-x86 kernel: Bluetooth: BNEP socket layer initialized May 05 04:17:42 volumio-x86 bluetoothd[884]: Bluetooth management interface 1.22 initialized May 05 04:17:42 volumio-x86 dbus-daemon[889]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=884 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") May 05 04:17:42 volumio-x86 kernel: Bluetooth: MGMT ver 1.22 May 05 04:17:42 volumio-x86 sh[811]: wlan0=wlan0 May 05 04:17:42 volumio-x86 sh[815]: eth0: waiting for carrier May 05 04:17:42 volumio-x86 sh[815]: eth0: carrier acquired May 05 04:17:42 volumio-x86 dhcpcd[989]: eth0: waiting for carrier May 05 04:17:42 volumio-x86 dhcpcd[862]: eth0: waiting for carrier May 05 04:17:42 volumio-x86 kernel: r8169 0000:01:00.0 eth0: Link is Down May 05 04:17:42 volumio-x86 dhcpcd[989]: wlan0: waiting for carrier May 05 04:17:42 volumio-x86 dhcpcd[862]: eth0: carrier acquired May 05 04:17:42 volumio-x86 dhcpcd[989]: wlan0: carrier acquired May 05 04:17:42 volumio-x86 avahi-daemon[887]: Network interface enumeration completed. May 05 04:17:42 volumio-x86 avahi-daemon[887]: Server startup complete. Host name is volumio-x86.local. Local service cookie is 2895576510. May 05 04:17:42 volumio-x86 avahi-daemon[887]: Service "Volumio-x86" (/services/volumio.service) successfully established. May 05 04:17:42 volumio-x86 systemd[1]: Started Login Service. May 05 04:17:42 volumio-x86 sh[815]: DUID 00:01:00:01:2f:aa:87:e6:d8:c4:97:e3:6c:f8 May 05 04:17:42 volumio-x86 sh[815]: eth0: IAID 97:e3:6c:f8 May 05 04:17:42 volumio-x86 dhcpcd[862]: DUID 00:01:00:01:2f:aa:87:e6:d8:c4:97:e3:6c:f8 May 05 04:17:42 volumio-x86 systemd[1]: Started Avahi mDNS/DNS-SD Stack. May 05 04:17:42 volumio-x86 dhcpcd[989]: DUID 00:01:00:01:2f:aa:87:e6:48:f1:7f:b2:ca:f5 May 05 04:17:42 volumio-x86 dhcpcd[862]: eth0: IAID 97:e3:6c:f8 May 05 04:17:42 volumio-x86 dhcpcd[989]: wlan0: IAID 7f:b2:ca:f5 May 05 04:17:42 volumio-x86 sh[815]: eth0: adding address fe80::148:a25b:2f7e:fe7b May 05 04:17:42 volumio-x86 sh[815]: ipv6_addaddr1: Permission denied May 05 04:17:42 volumio-x86 dhcpcd[989]: wlan0: adding address fe80::f6ba:49c6:418b:6835 May 05 04:17:42 volumio-x86 dhcpcd[862]: eth0: adding address fe80::148:a25b:2f7e:fe7b May 05 04:17:42 volumio-x86 dhcpcd[989]: ipv6_addaddr1: Permission denied May 05 04:17:42 volumio-x86 dhcpcd[862]: ipv6_addaddr1: Permission denied May 05 04:17:42 volumio-x86 dhcpcd[989]: wlan0: carrier lost May 05 04:17:42 volumio-x86 systemd[1]: Started WPA supplicant. May 05 04:17:42 volumio-x86 systemd[1]: Started Bluetooth service. May 05 04:17:42 volumio-x86 dhcpcd[989]: eth0: carrier acquired May 05 04:17:42 volumio-x86 dhcpcd[989]: eth0: IAID 97:e3:6c:f8 May 05 04:17:42 volumio-x86 dhcpcd[989]: eth0: adding address fe80::148:a25b:2f7e:fe7b May 05 04:17:42 volumio-x86 dhcpcd[989]: ipv6_addaddr1: Permission denied May 05 04:17:42 volumio-x86 sh[815]: eth0: soliciting an IPv6 router May 05 04:17:42 volumio-x86 dhcpcd[862]: eth0: soliciting an IPv6 router May 05 04:17:42 volumio-x86 dhcpcd[989]: eth0: soliciting an IPv6 router May 05 04:17:42 volumio-x86 dhcpcd[989]: eth0: soliciting a DHCP lease May 05 04:17:42 volumio-x86 loadcpufreq[903]: Loading cpufreq kernel modules...done (acpi-cpufreq). May 05 04:17:42 volumio-x86 systemd[1]: Started Raise network interfaces. May 05 04:17:42 volumio-x86 systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. May 05 04:17:42 volumio-x86 systemd[1]: Starting LSB: set CPUFreq kernel parameters... May 05 04:17:42 volumio-x86 systemd[1]: Starting Hostname Service... May 05 04:17:42 volumio-x86 systemd[1]: Reached target Bluetooth. May 05 04:17:42 volumio-x86 systemd[1]: Listening on mpd.socket. May 05 04:17:42 volumio-x86 systemd[1]: Reached target Network. May 05 04:17:42 volumio-x86 systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. May 05 04:17:42 volumio-x86 systemd[1]: Starting OpenBSD Secure Shell server... May 05 04:17:42 volumio-x86 systemd[1]: Reached target Network is Online. May 05 04:17:42 volumio-x86 sh[815]: eth0: carrier lost May 05 04:17:42 volumio-x86 dhcpcd[989]: eth0: carrier lost May 05 04:17:42 volumio-x86 dhcpcd[862]: eth0: carrier lost May 05 04:17:42 volumio-x86 systemd[1]: Starting Samba NMB Daemon... May 05 04:17:42 volumio-x86 systemd[1]: Starting LSB: Brings up/down network automatically... May 05 04:17:42 volumio-x86 systemd[1]: Starting Network Time Service... May 05 04:17:42 volumio-x86 systemd[1]: Starting /etc/rc.local Compatibility... May 05 04:17:42 volumio-x86 systemd[1]: Starting Daily apt download activities... May 05 04:17:42 volumio-x86 systemd[1]: Starting Permit User Sessions... May 05 04:17:42 volumio-x86 systemd[1]: Reached target Sound Card. May 05 04:17:42 volumio-x86 systemd[1]: Starting Music Player Daemon... May 05 04:17:42 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 05 04:17:42 volumio-x86 systemd[1]: Started /etc/rc.local Compatibility. May 05 04:17:42 volumio-x86 systemd[1]: iptables.service: Succeeded. May 05 04:17:42 volumio-x86 dbus-daemon[889]: [system] Successfully activated service 'org.freedesktop.hostname1' May 05 04:17:42 volumio-x86 systemd[1]: Started Permit User Sessions. May 05 04:17:42 volumio-x86 systemd[1]: Started Hostname Service. May 05 04:17:42 volumio-x86 systemd[1]: Starting Hold until boot process finishes up... May 05 04:17:42 volumio-x86 systemd[1]: Starting Terminate Plymouth Boot Screen... May 05 04:17:42 volumio-x86 systemd[1]: Received SIGRTMIN+21 from PID 404 (plymouthd). May 05 04:17:42 volumio-x86 systemd[1]: Received SIGRTMIN+21 from PID 404 (plymouthd). May 05 04:17:42 volumio-x86 cpufrequtils[1067]: CPUFreq Utilities: Setting ondemand CPUFreq governor...error: unexpectedly disconnected from boot status daemon May 05 04:17:42 volumio-x86 systemd[1]: plymouth-quit-wait.service: Succeeded. May 05 04:17:42 volumio-x86 systemd[1]: Started Hold until boot process finishes up. May 05 04:17:42 volumio-x86 systemd[1]: plymouth-quit.service: Succeeded. May 05 04:17:42 volumio-x86 systemd[1]: Started Terminate Plymouth Boot Screen. May 05 04:17:42 volumio-x86 cpufrequtils[1067]: disabled, governor not available...done. May 05 04:17:42 volumio-x86 systemd[1]: Started LSB: set CPUFreq kernel parameters. May 05 04:17:42 volumio-x86 ifplugd(eth0)[1138]: ifplugd 0.28 initializing. May 05 04:17:42 volumio-x86 ifplugd(eth0)[1138]: Using interface eth0/D8:C4:97:E3:6C:F8 with driver (version: 6.6.32-volumio) May 05 04:17:42 volumio-x86 ifplugd(eth0)[1138]: Using detection mode: SIOCETHTOOL May 05 04:17:42 volumio-x86 ifplugd(eth0)[1138]: Initialization complete, link beat not detected. May 05 04:17:42 volumio-x86 systemd[1]: Started Getty on tty1. May 05 04:17:42 volumio-x86 systemd[1]: Reached target Login Prompts. May 05 04:17:42 volumio-x86 sshd[1139]: Server listening on 0.0.0.0 port 22. May 05 04:17:42 volumio-x86 sshd[1139]: Server listening on :: port 22. May 05 04:17:42 volumio-x86 systemd[1]: Started OpenBSD Secure Shell server. May 05 04:17:42 volumio-x86 ifplugd[1085]: Network Interface Plugging Daemon...start eth0...done. May 05 04:17:42 volumio-x86 systemd[1]: Started LSB: Brings up/down network automatically. May 05 04:17:42 volumio-x86 ntpd[1090]: ntpd 4.2.8p12@1.3728-o (1): Starting May 05 04:17:42 volumio-x86 ntpd[1090]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 05 04:17:42 volumio-x86 systemd[1]: Started Network Time Service. May 05 04:17:42 volumio-x86 ntpd[1143]: proto: precision = 0.155 usec (-23) May 05 04:17:42 volumio-x86 ntpd[1143]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 05 04:17:42 volumio-x86 ntpd[1143]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 05 04:17:42 volumio-x86 ntpd[1143]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 859 days ago May 05 04:17:42 volumio-x86 ntpd[1143]: Listen and drop on 0 v6wildcard [::]:123 May 05 04:17:42 volumio-x86 ntpd[1143]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 05 04:17:42 volumio-x86 ntpd[1143]: Listen normally on 2 lo 127.0.0.1:123 May 05 04:17:42 volumio-x86 ntpd[1143]: Listening on routing socket on fd #19 for interface updates May 05 04:17:42 volumio-x86 ntpd[1143]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 05 04:17:42 volumio-x86 ntpd[1143]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 05 04:17:43 volumio-x86 systemd[1]: man-db.service: Succeeded. May 05 04:17:43 volumio-x86 systemd[1]: Started Daily man-db regeneration. May 05 04:17:43 volumio-x86 sudo[1102]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 05 04:17:43 volumio-x86 sudo[1102]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:43 volumio-x86 sudo[1102]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory May 05 04:17:43 volumio-x86 sudo[1102]: pam_unix(sudo:session): session closed for user root May 05 04:17:43 volumio-x86 ntpd[1143]: error resolving pool 0.debian.pool.ntp.org: System error (-11) May 05 04:17:43 volumio-x86 wireless.js[899]: Cleaning previous... May 05 04:17:44 volumio-x86 nmbd[1106]: [2025/05/05 04:17:44.018452, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) May 05 04:17:44 volumio-x86 nmbd[1106]: started asyncdns process 1182 May 05 04:17:44 volumio-x86 nmbd[1106]: [2025/05/05 04:17:44.021214, 0] ../lib/util/become_daemon.c:149(daemon_status) May 05 04:17:44 volumio-x86 nmbd[1106]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... May 05 04:17:44 volumio-x86 nmbd[1106]: [2025/05/05 04:17:44.021347, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) May 05 04:17:44 volumio-x86 nmbd[1106]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). May 05 04:17:44 volumio-x86 sudo[1184]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 05 04:17:44 volumio-x86 sudo[1184]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:44 volumio-x86 sudo[1184]: pam_unix(sudo:session): session closed for user root May 05 04:17:44 volumio-x86 sudo[1186]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 05 04:17:44 volumio-x86 sudo[1186]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:44 volumio-x86 sudo[1186]: pam_unix(sudo:session): session closed for user root May 05 04:17:44 volumio-x86 wireless.js[899]: Stopped aP May 05 04:17:44 volumio-x86 sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 05 04:17:44 volumio-x86 sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:44 volumio-x86 kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM May 05 04:17:44 volumio-x86 kernel: pcieport 0000:00:1c.3: AER: Corrected error message received from 0000:00:1c.3 May 05 04:17:44 volumio-x86 kernel: pcieport 0000:00:1c.3: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) May 05 04:17:44 volumio-x86 kernel: pcieport 0000:00:1c.3: device [8086:9d13] error status/mask=00000001/00000000 May 05 04:17:44 volumio-x86 kernel: pcieport 0000:00:1c.3: [ 0] RxErr (First) May 05 04:17:44 volumio-x86 kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM May 05 04:17:44 volumio-x86 kernel: pcieport 0000:00:1c.3: AER: Corrected error message received from 0000:00:1c.3 May 05 04:17:44 volumio-x86 kernel: pcieport 0000:00:1c.3: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) May 05 04:17:44 volumio-x86 kernel: pcieport 0000:00:1c.3: device [8086:9d13] error status/mask=00000001/00000000 May 05 04:17:44 volumio-x86 kernel: pcieport 0000:00:1c.3: [ 0] RxErr (First) May 05 04:17:44 volumio-x86 kernel: iwlwifi 0000:02:00.0: FW already configured (0) - re-configuring May 05 04:17:44 volumio-x86 sudo[1193]: pam_unix(sudo:session): session closed for user root May 05 04:17:44 volumio-x86 sudo[1195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 05 04:17:44 volumio-x86 sudo[1195]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:44 volumio-x86 sudo[1195]: pam_unix(sudo:session): session closed for user root May 05 04:17:44 volumio-x86 sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 05 04:17:44 volumio-x86 sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:44 volumio-x86 sudo[1202]: pam_unix(sudo:session): session closed for user root May 05 04:17:44 volumio-x86 sudo[1204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 05 04:17:44 volumio-x86 sudo[1204]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:44 volumio-x86 ntpd[1143]: error resolving pool 1.debian.pool.ntp.org: System error (-11) May 05 04:17:45 volumio-x86 sh[815]: eth0: carrier acquired May 05 04:17:45 volumio-x86 dhcpcd[989]: eth0: carrier acquired May 05 04:17:45 volumio-x86 dhcpcd[862]: eth0: carrier acquired May 05 04:17:45 volumio-x86 kernel: r8169 0000:01:00.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx May 05 04:17:45 volumio-x86 dhcpcd[989]: eth0: IAID 97:e3:6c:f8 May 05 04:17:45 volumio-x86 dhcpcd[862]: eth0: IAID 97:e3:6c:f8 May 05 04:17:45 volumio-x86 sh[815]: eth0: IAID 97:e3:6c:f8 May 05 04:17:45 volumio-x86 dhcpcd[989]: eth0: soliciting a DHCP lease May 05 04:17:45 volumio-x86 dhcpcd[989]: eth0: offered 192.168.1.4 from 192.168.1.1 May 05 04:17:45 volumio-x86 dhcpcd[989]: eth0: probing address 192.168.1.4/24 May 05 04:17:45 volumio-x86 dhcpcd[989]: eth0: soliciting an IPv6 router May 05 04:17:45 volumio-x86 ifplugd(eth0)[1138]: Link beat detected. May 05 04:17:45 volumio-x86 systemd[1]: systemd-rfkill.service: Succeeded. May 05 04:17:45 volumio-x86 ntpd[1143]: error resolving pool 2.debian.pool.ntp.org: System error (-11) May 05 04:17:45 volumio-x86 ifplugd(eth0)[1138]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. May 05 04:17:45 volumio-x86 ifplugd(eth0)[1138]: client: ifup: waiting for lock on /run/network/ifstate.eth0 May 05 04:17:45 volumio-x86 sh[815]: eth0: soliciting an IPv6 router May 05 04:17:45 volumio-x86 dhcpcd[862]: eth0: soliciting an IPv6 router May 05 04:17:46 volumio-x86 sh[815]: eth0: soliciting a DHCP lease May 05 04:17:46 volumio-x86 dhcpcd[862]: eth0: soliciting a DHCP lease May 05 04:17:46 volumio-x86 sh[815]: eth0: offered 192.168.1.4 from 192.168.1.1 May 05 04:17:46 volumio-x86 dhcpcd[862]: eth0: offered 192.168.1.4 from 192.168.1.1 May 05 04:17:46 volumio-x86 sh[815]: eth0: probing address 192.168.1.4/24 May 05 04:17:46 volumio-x86 dhcpcd[862]: eth0: probing address 192.168.1.4/24 May 05 04:17:46 volumio-x86 mpd[1150]: May 05 04:17 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 05 04:17:46 volumio-x86 systemd[1]: Started Music Player Daemon. May 05 04:17:46 volumio-x86 mpd_monitor.sh[895]: MPD Monitor Service: MPD restarted due to no mpc output. May 05 04:17:46 volumio-x86 volumio-time-update[896]: volumio-time-update-util: Fetching time from Volumio... May 05 04:17:46 volumio-x86 volumio-remote-updater[900]: [2025-05-05 04:17:46] [info] asio async_connect error: system:111 (Connection refused) May 05 04:17:46 volumio-x86 volumio-remote-updater[900]: [2025-05-05 04:17:46] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 05 04:17:46 volumio-x86 volumio-remote-updater[900]: [2025-05-05 04:17:46] [error] handle_connect error: Underlying Transport Error May 05 04:17:46 volumio-x86 volumio-time-update[896]: volumio-time-update-util: Date not found in response May 05 04:17:46 volumio-x86 volumio-time-update[896]: volumio-time-update-util: Retrying in 5 seconds... May 05 04:17:46 volumio-x86 ntpd[1143]: error resolving pool 3.debian.pool.ntp.org: System error (-11) May 05 04:17:48 volumio-x86 sudo[1204]: pam_unix(sudo:session): session closed for user root May 05 04:17:48 volumio-x86 wireless.js[899]: SETTING APPROPRIATE REG DOMAIN: CN May 05 04:17:48 volumio-x86 sudo[1226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 05 04:17:48 volumio-x86 sudo[1226]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:48 volumio-x86 sudo[1226]: pam_unix(sudo:session): session closed for user root May 05 04:17:48 volumio-x86 sudo[1228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CN May 05 04:17:48 volumio-x86 sudo[1228]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:48 volumio-x86 sudo[1228]: pam_unix(sudo:session): session closed for user root May 05 04:17:48 volumio-x86 wireless.js[899]: SUCCESSFULLY SET NEW REGDOMAIN: CN May 05 04:17:48 volumio-x86 sudo[1235]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 05 04:17:48 volumio-x86 sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:48 volumio-x86 sudo[1235]: pam_unix(sudo:session): session closed for user root May 05 04:17:48 volumio-x86 sudo[1237]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 05 04:17:48 volumio-x86 sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: AER: Corrected error message received from 0000:00:1c.3 May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: device [8086:9d13] error status/mask=00000001/00000000 May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: [ 0] RxErr (First) May 05 04:17:48 volumio-x86 sudo[1237]: pam_unix(sudo:session): session closed for user root May 05 04:17:48 volumio-x86 kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM May 05 04:17:48 volumio-x86 kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: AER: Corrected error message received from 0000:00:1c.3 May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: device [8086:9d13] error status/mask=00000001/00000000 May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: [ 0] RxErr (First) May 05 04:17:48 volumio-x86 kernel: iwlwifi 0000:02:00.0: FW already configured (0) - re-configuring May 05 04:17:48 volumio-x86 avahi-daemon[887]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. May 05 04:17:48 volumio-x86 avahi-daemon[887]: New relevant interface wlan0.IPv4 for mDNS. May 05 04:17:48 volumio-x86 avahi-daemon[887]: Registering new address record for 192.168.211.1 on wlan0.IPv4. May 05 04:17:48 volumio-x86 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... May 05 04:17:48 volumio-x86 hostapd[1243]: Configuration file: /etc/hostapd/hostapd.conf May 05 04:17:48 volumio-x86 avahi-daemon[887]: Interface wlan0.IPv4 no longer relevant for mDNS. May 05 04:17:48 volumio-x86 avahi-daemon[887]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. May 05 04:17:48 volumio-x86 kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: AER: Corrected error message received from 0000:00:1c.3 May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: device [8086:9d13] error status/mask=00000001/00000000 May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: [ 0] RxErr (First) May 05 04:17:48 volumio-x86 kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: AER: Corrected error message received from 0000:00:1c.3 May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: device [8086:9d13] error status/mask=00000001/00000000 May 05 04:17:48 volumio-x86 kernel: pcieport 0000:00:1c.3: [ 0] RxErr (First) May 05 04:17:48 volumio-x86 kernel: iwlwifi 0000:02:00.0: FW already configured (0) - re-configuring May 05 04:17:48 volumio-x86 avahi-daemon[887]: Withdrawing address record for 192.168.211.1 on wlan0. May 05 04:17:48 volumio-x86 avahi-daemon[887]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. May 05 04:17:48 volumio-x86 avahi-daemon[887]: New relevant interface wlan0.IPv4 for mDNS. May 05 04:17:48 volumio-x86 avahi-daemon[887]: Registering new address record for 192.168.211.1 on wlan0.IPv4. May 05 04:17:48 volumio-x86 hostapd[1243]: Using interface wlan0 with hwaddr 48:f1:7f:b2:ca:f5 and ssid "Volumio-07690" May 05 04:17:48 volumio-x86 dhcpcd[989]: wlan0: carrier acquired May 05 04:17:48 volumio-x86 hostapd[1243]: wlan0: interface state UNINITIALIZED->ENABLED May 05 04:17:48 volumio-x86 hostapd[1243]: wlan0: AP-ENABLED May 05 04:17:48 volumio-x86 systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. May 05 04:17:48 volumio-x86 dhcpcd[989]: wlan0: IAID 7f:b2:ca:f5 May 05 04:17:48 volumio-x86 systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... May 05 04:17:48 volumio-x86 iwconfig[1248]: Error for wireless request "Set Power Management" (8B2C) : May 05 04:17:48 volumio-x86 iwconfig[1248]: SET failed on device wlan0 ; Invalid argument. May 05 04:17:48 volumio-x86 systemd[1]: wireless.service: Succeeded. May 05 04:17:48 volumio-x86 systemd[1]: Started Wireless Services. May 05 04:17:48 volumio-x86 systemd[1]: Started Volumio Backend Module. May 05 04:17:48 volumio-x86 dnsmasq[1246]: dnsmasq: syntax check OK. May 05 04:17:48 volumio-x86 systemd[1]: Started Intel SST and HDA soundcard init service. May 05 04:17:48 volumio-x86 systemd[1]: Started Start Volumio Kiosk. May 05 04:17:48 volumio-x86 systemd[1]: Started Volumio Cpu Tweaker. May 05 04:17:48 volumio-x86 volumio-cpu-tweak[1252]: Setting RT Priority for mpd May 05 04:17:48 volumio-x86 volumio-cpu-tweak[1252]: Setting MPD Affinity May 05 04:17:48 volumio-x86 volumio-cpu-tweak[1252]: pid 1150's current affinity mask: ff May 05 04:17:48 volumio-x86 volumio-cpu-tweak[1252]: pid 1150's new affinity mask: 3 May 05 04:17:48 volumio-x86 volumio-cpu-tweak[1252]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 05 04:17:48 volumio-x86 dhcpcd[989]: wlan0: soliciting an IPv6 router May 05 04:17:48 volumio-x86 systemd[1]: volumio_cpu_tweak.service: Succeeded. May 05 04:17:48 volumio-x86 dnsmasq[1295]: started, version 2.80 cachesize 150 May 05 04:17:48 volumio-x86 dnsmasq[1295]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile May 05 04:17:48 volumio-x86 dnsmasq-dhcp[1295]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d May 05 04:17:48 volumio-x86 dnsmasq[1295]: reading /etc/resolv.conf May 05 04:17:48 volumio-x86 dnsmasq[1295]: using nameserver 208.67.222.222#53 May 05 04:17:48 volumio-x86 dnsmasq[1295]: using nameserver 208.67.220.220#53 May 05 04:17:48 volumio-x86 dnsmasq[1295]: read /etc/hosts - 1 addresses May 05 04:17:48 volumio-x86 systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. May 05 04:17:48 volumio-x86 systemd[1]: Reached target Host and Network Name Lookups. May 05 04:17:49 volumio-x86 nmbd[1106]: [2025/05/05 04:17:49.038824, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 04:17:49 volumio-x86 nmbd[1106]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 05 04:17:49 volumio-x86 systemd[1]: Started Samba NMB Daemon. May 05 04:17:49 volumio-x86 systemd[1]: Starting Samba Winbind Daemon... May 05 04:17:49 volumio-x86 startx[1251]: X.Org X Server 1.20.4 May 05 04:17:49 volumio-x86 startx[1251]: X Protocol Version 11, Revision 0 May 05 04:17:49 volumio-x86 startx[1251]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian May 05 04:17:49 volumio-x86 startx[1251]: Current Operating System: Linux volumio-x86 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 May 05 04:17:49 volumio-x86 startx[1251]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=3cc03e2d-018e-43c1-b7e6-361cc0a7c20f bootpart=UUID=0A5D-C90D datapart=UUID=de34b9f5-9b78-4162-a289-2de9c46fbb26 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 May 05 04:17:49 volumio-x86 startx[1251]: Build Date: 18 December 2021 09:05:36AM May 05 04:17:49 volumio-x86 startx[1251]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) May 05 04:17:49 volumio-x86 startx[1251]: Current version of pixman: 0.36.0 May 05 04:17:49 volumio-x86 startx[1251]: Before reporting problems, check http://wiki.x.org May 05 04:17:49 volumio-x86 startx[1251]: to make sure that you have the latest version. May 05 04:17:49 volumio-x86 startx[1251]: Markers: (--) probed, (**) from config file, (==) default setting, May 05 04:17:49 volumio-x86 startx[1251]: (++) from command line, (!!) notice, (II) informational, May 05 04:17:49 volumio-x86 startx[1251]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 05 04:17:49 volumio-x86 startx[1251]: (==) Log file: "/var/log/Xorg.0.log", Time: Mon May 5 04:17:49 2025 May 05 04:17:49 volumio-x86 startx[1251]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 05 04:17:49 volumio-x86 dhcpcd[989]: wlan0: soliciting a DHCP lease May 05 04:17:49 volumio-x86 ntpd[1143]: Listen normally on 3 wlan0 192.168.211.1:123 May 05 04:17:49 volumio-x86 ntpd[1143]: new interface(s) found: waking up resolver May 05 04:17:50 volumio-x86 dhcpcd[989]: eth0: leased 192.168.1.4 for 86400 seconds May 05 04:17:50 volumio-x86 avahi-daemon[887]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.4. May 05 04:17:50 volumio-x86 dhcpcd[989]: eth0: adding route to 192.168.1.0/24 May 05 04:17:50 volumio-x86 avahi-daemon[887]: New relevant interface eth0.IPv4 for mDNS. May 05 04:17:50 volumio-x86 avahi-daemon[887]: Registering new address record for 192.168.1.4 on eth0.IPv4. May 05 04:17:50 volumio-x86 dhcpcd[989]: eth0: adding default route via 192.168.1.1 May 05 04:17:50 volumio-x86 dnsmasq[1295]: reading /etc/resolv.conf May 05 04:17:50 volumio-x86 dnsmasq[1295]: using nameserver 202.96.128.86#53 May 05 04:17:50 volumio-x86 dnsmasq[1295]: using nameserver 202.96.128.166#53 May 05 04:17:50 volumio-x86 dnsmasq[1295]: using nameserver 208.67.222.222#53 May 05 04:17:50 volumio-x86 dnsmasq[1295]: using nameserver 208.67.220.220#53 May 05 04:17:50 volumio-x86 winbindd[1326]: [2025/05/05 04:17:50.743464, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 05 04:17:50 volumio-x86 winbindd[1326]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 05 04:17:50 volumio-x86 winbindd[1326]: [2025/05/05 04:17:50.761498, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 04:17:50 volumio-x86 winbindd[1326]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 05 04:17:50 volumio-x86 systemd[1]: Started Samba Winbind Daemon. May 05 04:17:50 volumio-x86 systemd[1]: Starting Samba SMB Daemon... May 05 04:17:50 volumio-x86 sh[815]: eth0: leased 192.168.1.4 for 86400 seconds May 05 04:17:50 volumio-x86 sh[815]: eth0: adding route to 192.168.1.0/24 May 05 04:17:50 volumio-x86 sh[815]: eth0: adding default route via 192.168.1.1 May 05 04:17:50 volumio-x86 dhcpcd[862]: eth0: leased 192.168.1.4 for 86400 seconds May 05 04:17:50 volumio-x86 dhcpcd[862]: eth0: adding route to 192.168.1.0/24 May 05 04:17:50 volumio-x86 dhcpcd[862]: eth0: adding default route via 192.168.1.1 May 05 04:17:51 volumio-x86 screensaver.sh[901]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused May 05 04:17:51 volumio-x86 volumio-time-update[896]: volumio-time-update-util: Fetching time from Volumio... May 05 04:17:51 volumio-x86 ntpd[1143]: Listen normally on 4 eth0 192.168.1.4:123 May 05 04:17:51 volumio-x86 ntpd[1143]: new interface(s) found: waking up resolver May 05 04:17:51 volumio-x86 ntpd[1143]: ntpd exiting on signal 15 (Terminated) May 05 04:17:51 volumio-x86 systemd[1]: Stopping Network Time Service... May 05 04:17:51 volumio-x86 systemd[1]: ntp.service: Succeeded. May 05 04:17:51 volumio-x86 systemd[1]: Stopped Network Time Service. May 05 04:17:52 volumio-x86 systemd[1]: Starting Network Time Service... May 05 04:17:52 volumio-x86 systemd[1]: soundcard-init.service: Succeeded. May 05 04:17:52 volumio-x86 ntpd[1448]: ntpd 4.2.8p12@1.3728-o (1): Starting May 05 04:17:52 volumio-x86 ntpd[1448]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 05 04:17:52 volumio-x86 ntpd[1470]: proto: precision = 0.081 usec (-23) May 05 04:17:52 volumio-x86 ntpd[1470]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 05 04:17:52 volumio-x86 ntpd[1470]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 05 04:17:52 volumio-x86 ntpd[1470]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 859 days ago May 05 04:17:52 volumio-x86 ntpd[1470]: Listen and drop on 0 v6wildcard [::]:123 May 05 04:17:52 volumio-x86 ntpd[1470]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 05 04:17:52 volumio-x86 ntpd[1470]: Listen normally on 2 lo 127.0.0.1:123 May 05 04:17:52 volumio-x86 ntpd[1470]: Listen normally on 3 eth0 192.168.1.4:123 May 05 04:17:52 volumio-x86 ntpd[1470]: Listen normally on 4 wlan0 192.168.211.1:123 May 05 04:17:52 volumio-x86 ntpd[1470]: Listening on routing socket on fd #21 for interface updates May 05 04:17:52 volumio-x86 ntpd[1470]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 05 04:17:52 volumio-x86 ntpd[1470]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 05 04:17:52 volumio-x86 systemd[1]: Started Network Time Service. May 05 04:17:52 volumio-x86 ntpd[1470]: ntpd exiting on signal 15 (Terminated) May 05 04:17:52 volumio-x86 systemd[1]: Stopping Network Time Service... May 05 04:17:52 volumio-x86 systemd[1]: ntp.service: Succeeded. May 05 04:17:52 volumio-x86 systemd[1]: Stopped Network Time Service. May 05 04:17:52 volumio-x86 systemd[1]: Starting Network Time Service... May 05 04:17:52 volumio-x86 ntpd[1477]: ntpd 4.2.8p12@1.3728-o (1): Starting May 05 04:17:52 volumio-x86 ntpd[1477]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 05 04:17:52 volumio-x86 systemd[1]: Started Network Time Service. May 05 04:17:52 volumio-x86 sh[815]: forked to background, child pid 1486 May 05 04:17:52 volumio-x86 ntpd[1484]: proto: precision = 0.052 usec (-24) May 05 04:17:52 volumio-x86 dhcpcd[862]: forked to background, child pid 1486 May 05 04:17:52 volumio-x86 ntpd[1484]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 05 04:17:52 volumio-x86 ntpd[1484]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 05 04:17:52 volumio-x86 ntpd[1484]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 859 days ago May 05 04:17:52 volumio-x86 ntpd[1484]: Listen and drop on 0 v6wildcard [::]:123 May 05 04:17:52 volumio-x86 ntpd[1484]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 05 04:17:52 volumio-x86 ntpd[1484]: Listen normally on 2 lo 127.0.0.1:123 May 05 04:17:52 volumio-x86 ntpd[1484]: Listen normally on 3 eth0 192.168.1.4:123 May 05 04:17:52 volumio-x86 ntpd[1484]: Listen normally on 4 wlan0 192.168.211.1:123 May 05 04:17:52 volumio-x86 ntpd[1484]: Listening on routing socket on fd #21 for interface updates May 05 04:17:52 volumio-x86 ntpd[1484]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 05 04:17:52 volumio-x86 ntpd[1484]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 05 04:17:52 volumio-x86 ifplugd(eth0)[1138]: client: ifup: interface eth0 already configured May 05 04:17:52 volumio-x86 sh[815]: eth0=eth0 May 05 04:17:52 volumio-x86 ifplugd(eth0)[1138]: Program executed successfully. May 05 04:17:52 volumio-x86 smbd[1459]: [2025/05/05 04:17:52.328867, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 04:17:52 volumio-x86 smbd[1459]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 05 04:17:52 volumio-x86 systemd[1]: Started Samba SMB Daemon. May 05 04:17:52 volumio-x86 kernel: broken atomic modeset userspace detected, disabling atomic May 05 04:17:52 volumio-x86 systemd[1]: apt-daily.service: Succeeded. May 05 04:17:52 volumio-x86 systemd[1]: Started Daily apt download activities. May 05 04:17:52 volumio-x86 systemd[1]: Starting Daily apt upgrade and clean activities... May 05 04:17:52 volumio-x86 volumio[1249]: info: ------------------------------------------- May 05 04:17:52 volumio-x86 volumio[1249]: info: ----- Volumio3 ---- May 05 04:17:52 volumio-x86 volumio[1249]: info: ------------------------------------------- May 05 04:17:52 volumio-x86 volumio[1249]: info: ----- System startup ---- May 05 04:17:52 volumio-x86 volumio[1249]: info: ------------------------------------------- May 05 04:17:52 volumio-x86 systemd[1]: apt-daily-upgrade.service: Succeeded. May 05 04:17:52 volumio-x86 systemd[1]: Started Daily apt upgrade and clean activities. May 05 04:17:53 volumio-x86 startx[1251]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. May 05 04:17:53 volumio-x86 volumio[1249]: info: MYVOLUMIO Environment detected May 05 04:17:53 volumio-x86 ntpd[1484]: Soliciting pool server 193.182.111.143 May 05 04:17:53 volumio-x86 volumio[1249]: info: Plugin folders cleanup May 05 04:17:53 volumio-x86 volumio[1249]: info: Scanning into folder /volumio/app/plugins/ May 05 04:17:53 volumio-x86 volumio[1249]: info: Scanning category audio_interface May 05 04:17:53 volumio-x86 volumio[1249]: info: Scanning category miscellanea May 05 04:17:53 volumio-x86 volumio[1249]: info: Scanning category music_service May 05 04:17:53 volumio-x86 volumio[1249]: info: Scanning category plugins.json May 05 04:17:53 volumio-x86 volumio[1249]: info: Scanning category system_controller May 05 04:17:53 volumio-x86 volumio[1249]: info: Scanning category user_interface May 05 04:17:53 volumio-x86 volumio[1249]: info: Scanning into folder /data/plugins/ May 05 04:17:53 volumio-x86 volumio[1249]: info: Scanning category music_service May 05 04:17:53 volumio-x86 volumio[1249]: info: Scanning category system_controller May 05 04:17:53 volumio-x86 volumio[1249]: info: Scanning category user_interface May 05 04:17:53 volumio-x86 volumio[1249]: info: Plugin folders cleanup completed May 05 04:17:53 volumio-x86 volumio[1249]: info: ------------------------------------------- May 05 04:17:53 volumio-x86 volumio[1249]: info: ----- Core plugins startup ---- May 05 04:17:53 volumio-x86 volumio[1249]: info: ------------------------------------------- May 05 04:17:53 volumio-x86 volumio[1249]: info: Loading plugins from folder /volumio/app/plugins/ May 05 04:17:53 volumio-x86 volumio[1249]: info: Adding plugin upnp to MyMusic Plugins May 05 04:17:53 volumio-x86 volumio[1249]: info: Adding plugin airplay_emulation to MyMusic Plugins May 05 04:17:53 volumio-x86 volumio[1249]: info: Adding plugin upnp_browser to MyMusic Plugins May 05 04:17:53 volumio-x86 volumio[1249]: info: Loading plugins from folder /data/plugins/ May 05 04:17:53 volumio-x86 volumio[1249]: info: Loading plugin "system"... May 05 04:17:53 volumio-x86 volumio[1249]: info: Loading plugin "appearance"... May 05 04:17:53 volumio-x86 volumio[1249]: info: Loading plugin "network"... May 05 04:17:53 volumio-x86 volumio[1249]: info: Refreshing Cached IP Addresses May 05 04:17:53 volumio-x86 sudo[1645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 04:17:53 volumio-x86 sudo[1645]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:53 volumio-x86 sudo[1645]: pam_unix(sudo:session): session closed for user root May 05 04:17:53 volumio-x86 sudo[1647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 04:17:53 volumio-x86 sudo[1647]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:53 volumio-x86 sudo[1647]: pam_unix(sudo:session): session closed for user root May 05 04:17:53 volumio-x86 volumio[1249]: info: Loading plugin "services"... May 05 04:17:53 volumio-x86 volumio[1249]: info: Loading plugin "alsa_controller"... May 05 04:17:53 volumio-x86 sudo[1660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 05 04:17:53 volumio-x86 sudo[1660]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:53 volumio-x86 sudo[1660]: pam_unix(sudo:session): session closed for user root May 05 04:17:53 volumio-x86 volumio[1249]: warn: Unable to locate the audio output device HDMI. Please configure a valid output device. May 05 04:17:53 volumio-x86 volumio[1249]: Invalid card number. May 05 04:17:53 volumio-x86 volumio[1249]: info: Hardware Mixer selected but no Hardware mixer available, detecting default mixer May 05 04:17:53 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 05 04:17:53 volumio-x86 volumio[1249]: Invalid card number. May 05 04:17:53 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 05 04:17:53 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 05 04:17:53 volumio-x86 volumio[1249]: info: Loading plugin "wizard"... May 05 04:17:53 volumio-x86 volumio[1249]: info: Loading plugin "networkfs"... May 05 04:17:53 volumio-x86 volumio[1249]: info: Starting Udev Watcher for removable devices May 05 04:17:53 volumio-x86 sudo[1679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //127.0.0.1/Internal Storage/musics /mnt/NAS/local May 05 04:17:53 volumio-x86 sudo[1679]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:54 volumio-x86 volumio[1249]: info: Ignoring mount for partition: 09C1-B27D May 05 04:17:54 volumio-x86 volumio[1249]: error: Cannot associate FS Label, not mounting May 05 04:17:54 volumio-x86 volumio[1249]: info: Ignoring mount for partition: 506A92866A92690C May 05 04:17:54 volumio-x86 volumio[1249]: info: Ignoring mount for partition: 新加卷 May 05 04:17:54 volumio-x86 volumio[1249]: info: Ignoring mount for partition: boot May 05 04:17:54 volumio-x86 volumio[1249]: info: Ignoring mount for partition: volumio May 05 04:17:54 volumio-x86 volumio[1249]: info: Ignoring mount for partition: volumio_data May 05 04:17:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 05 04:17:54 volumio-x86 volumio[1249]: info: Loading plugin "volumio_command_line_client"... May 05 04:17:54 volumio-x86 volumio[1249]: info: Loading plugin "upnp"... May 05 04:17:54 volumio-x86 kernel: FS-Cache: Loaded May 05 04:17:54 volumio-x86 kernel: Key type dns_resolver registered May 05 04:17:54 volumio-x86 volumio[1249]: info: [1746389874028] Starting Upmpd Daemon May 05 04:17:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 05 04:17:54 volumio-x86 volumio[1249]: info: Loading plugin "my_music"... May 05 04:17:54 volumio-x86 volumio[1249]: info: Loading plugin "mpd"... May 05 04:17:54 volumio-x86 kernel: Key type cifs.spnego registered May 05 04:17:54 volumio-x86 kernel: Key type cifs.idmap registered May 05 04:17:54 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. May 05 04:17:54 volumio-x86 kernel: CIFS: Attempting to mount //127.0.0.1/Internal Storage/musics May 05 04:17:54 volumio-x86 sudo[1679]: pam_unix(sudo:session): session closed for user root May 05 04:17:54 volumio-x86 ntpd[1484]: Soliciting pool server 45.76.221.157 May 05 04:17:54 volumio-x86 volumio-time-update[896]: volumio-time-update-util: Setting system time to: 2025-05-04 20:17:53 May 05 04:17:54 volumio-x86 sudo[1733]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-05-04 20:17:53 May 05 04:17:54 volumio-x86 sudo[1733]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 04:17:54 volumio-x86 dbus-daemon[889]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.9' (uid=0 pid=1734 comm="timedatectl set-time 2025-05-04 20:17:53 ") May 05 04:17:54 volumio-x86 systemd[1]: Starting Time & Date Service... May 05 04:17:54 volumio-x86 dbus-daemon[889]: [system] Successfully activated service 'org.freedesktop.timedate1' May 05 04:17:54 volumio-x86 systemd[1]: Started Time & Date Service. May 04 20:19:00 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:19:00 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 04 20:19:00 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 04 20:19:00 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 04 20:19:00 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs May 04 20:19:00 volumio-x86 volumio[1249]: info: Received Get System Version May 04 20:19:00 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 04 20:19:06 volumio-x86 volumio[1249]: info: CALLMETHOD: miscellanea appearance setVolumio3UI [object Object] May 04 20:19:06 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , setVolumio3UI May 04 20:19:06 volumio-x86 volumio[1249]: info: Setting active UI to: {"uiPrettyName":"Contemporary","uiName":"contemporary","uiPath":"/volumio/http/www3"} May 04 20:19:07 volumio-x86 volumio[1249]: info: CoreCommandRouter::Reload Ui May 04 20:19:08 volumio-x86 volumio[1249]: 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: 4 May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 20:19:08 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetVisibleSources May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs May 04 20:19:08 volumio-x86 volumio[1249]: info: Received Get System Version May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 04 20:19:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds May 04 20:19:09 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 20:19:09 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:10 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 04 20:19:10 volumio-x86 volumio[1249]: info: Received Get System Info May 04 20:19:10 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 20:19:10 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 20:19:10 volumio-x86 volumio[1249]: info: Discovery: Getting this device information May 04 20:19:10 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 20:19:10 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:10 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 20:19:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 04 20:19:14 volumio-x86 volumio[1249]: info: CURURI: music-library May 04 20:19:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetQueue May 04 20:19:14 volumio-x86 volumio[1249]: info: CoreStateMachine::getQueue May 04 20:19:14 volumio-x86 volumio[1249]: info: CorePlayQueue::getQueue May 04 20:19:14 volumio-x86 volumio[1249]: info: Listing playlists May 04 20:19:14 volumio-x86 volumio[1249]: info: Preload queue cleared May 04 20:19:15 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 04 20:19:15 volumio-x86 volumio[1249]: info: CURURI: music-library/INTERNAL May 04 20:19:15 volumio-x86 volumio[1249]: info: Preload queue cleared May 04 20:19:19 volumio-x86 volumio[1249]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 04 20:19:19 volumio-x86 volumio[1249]: info: Retrying Login Due to Network Error May 04 20:19:19 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 04 20:19:19 volumio-x86 volumio[1249]: info: CURURI: music-library May 04 20:19:19 volumio-x86 volumio[1249]: info: Preload queue cleared May 04 20:19:20 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 20:19:20 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:22 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 04 20:19:22 volumio-x86 volumio[1249]: info: CURURI: artists:// May 04 20:19:22 volumio-x86 volumio[1249]: info: Preload queue cleared May 04 20:19:26 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 04 20:19:26 volumio-x86 volumio[1249]: info: CURURI: artists:// May 04 20:19:26 volumio-x86 volumio[1249]: info: Preload queue cleared May 04 20:19:27 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 04 20:19:27 volumio-x86 volumio[1249]: info: CURURI: music-library May 04 20:19:27 volumio-x86 volumio[1249]: info: Preload queue cleared May 04 20:19:29 volumio-x86 volumio[1249]: info: MyVolumio login type: Token May 04 20:19:31 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 20:19:31 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:32 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 04 20:19:32 volumio-x86 volumio[1249]: info: CURURI: music-library/INTERNAL May 04 20:19:32 volumio-x86 volumio[1249]: info: Preload queue cleared May 04 20:19:34 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , deleteFolder May 04 20:19:34 volumio-x86 sudo[2811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /mnt/INTERNAL/musics May 04 20:19:34 volumio-x86 sudo[2811]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 20:19:35 volumio-x86 sudo[2811]: pam_unix(sudo:session): session closed for user root May 04 20:19:42 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 20:19:42 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:49 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 04 20:19:49 volumio-x86 volumio[1249]: info: CURURI: music-library May 04 20:19:49 volumio-x86 volumio[1249]: info: Preload queue cleared May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:19:52 volumio-x86 volumio[1249]: info: Retrieving Cloud Streaming UI May 04 20:19:52 volumio-x86 volumio[1249]: info: Getting Tidal Cloud Configuration May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:19:52 volumio-x86 volumio[1249]: info: Getting Qobuz Cloud Configuration May 04 20:19:52 volumio-x86 volumio[1249]: info: Asking plugin for UI Config May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:19:52 volumio-x86 volumio[1249]: info: Getting Spotify Cloud Configuration May 04 20:19:52 volumio-x86 volumio[1249]: info: Asking plugin for UI Config May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:19:52 volumio-x86 volumio[1249]: info: Saving Spotify Acccount May 04 20:19:52 volumio-x86 volumio[1249]: info: Got Tidal Cloud Configuration May 04 20:19:52 volumio-x86 volumio[1249]: info: Got it May 04 20:19:52 volumio-x86 volumio[1249]: info: Got it May 04 20:19:52 volumio-x86 volumio[1249]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:19:52 volumio-x86 volumio[1249]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:19:52 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 04 20:19:53 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 20:19:53 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand update May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:54 volumio-x86 volumio[1249]: info: May 04 20:19:54 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:54 volumio-x86 volumio[1249]: info: sendMpdCommand update took 1 milliseconds May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:54 volumio-x86 volumio[1249]: info: May 04 20:19:54 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:54 volumio-x86 volumio[1249]: info: MPD Database updated - AlbumList cache refreshed May 04 20:19:54 volumio-x86 volumio[1249]: info: May 04 20:19:54 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: database May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:54 volumio-x86 volumio[1249]: info: May 04 20:19:54 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:54 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:54 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:54 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:54 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:54 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatetrue May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:54 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:54 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:54 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: ------------------------------ 145ms May 04 20:19:54 volumio-x86 volumio[1249]: info: ------------------------------ 145ms May 04 20:19:54 volumio-x86 volumio[1249]: info: MPD Database updated - AlbumList cache refreshed May 04 20:19:54 volumio-x86 volumio[1249]: info: May 04 20:19:54 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: database May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:54 volumio-x86 volumio[1249]: info: May 04 20:19:54 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:54 volumio-x86 volumio[1249]: info: sendMpdCommand status took 145 milliseconds May 04 20:19:54 volumio-x86 volumio[1249]: info: sendMpdCommand status took 145 milliseconds May 04 20:19:54 volumio-x86 volumio[1249]: info: sendMpdCommand status took 145 milliseconds May 04 20:19:54 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:54 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:54 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:54 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:54 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:54 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:54 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:54 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:54 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:54 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:54 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:54 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:54 volumio-x86 volumio[1249]: info: ------------------------------ 181ms May 04 20:19:54 volumio-x86 volumio[1249]: info: ------------------------------ 182ms May 04 20:19:54 volumio-x86 volumio[1249]: info: ------------------------------ 38ms May 04 20:19:54 volumio-x86 volumio[1249]: info: ------------------------------ 38ms May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand update May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:55 volumio-x86 volumio[1249]: info: May 04 20:19:55 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:55 volumio-x86 volumio[1249]: info: sendMpdCommand update took 1 milliseconds May 04 20:19:55 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:55 volumio-x86 volumio[1249]: info: May 04 20:19:55 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:55 volumio-x86 volumio[1249]: info: sendMpdCommand status took 0 milliseconds May 04 20:19:55 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:55 volumio-x86 volumio[1249]: info: sendMpdCommand status took 0 milliseconds May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:55 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatetrue May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:55 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:55 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:55 volumio-x86 volumio[1249]: info: ------------------------------ 47ms May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:55 volumio-x86 volumio[1249]: info: May 04 20:19:55 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:55 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:55 volumio-x86 volumio[1249]: info: sendMpdCommand status took 47 milliseconds May 04 20:19:55 volumio-x86 volumio[1249]: info: sendMpdCommand status took 48 milliseconds May 04 20:19:55 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:55 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:55 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:55 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:55 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:55 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:55 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:55 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:55 volumio-x86 volumio[1249]: info: ------------------------------ 75ms May 04 20:19:55 volumio-x86 volumio[1249]: info: ------------------------------ 28ms May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:55 volumio-x86 volumio[1249]: info: May 04 20:19:55 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:55 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:55 volumio-x86 volumio[1249]: info: sendMpdCommand status took 3 milliseconds May 04 20:19:55 volumio-x86 volumio[1249]: info: sendMpdCommand status took 3 milliseconds May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:55 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:55 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:55 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:55 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:55 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:55 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:55 volumio-x86 volumio[1249]: info: ------------------------------ 13ms May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand rescan May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:56 volumio-x86 volumio[1249]: info: May 04 20:19:56 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:56 volumio-x86 volumio[1249]: info: sendMpdCommand rescan took 0 milliseconds May 04 20:19:56 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:56 volumio-x86 volumio[1249]: info: May 04 20:19:56 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:56 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:56 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:56 volumio-x86 volumio[1249]: info: sendMpdCommand status took 0 milliseconds May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:56 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:56 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:56 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:56 volumio-x86 volumio[1249]: info: ------------------------------ 33ms May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:56 volumio-x86 volumio[1249]: info: May 04 20:19:56 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:56 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:56 volumio-x86 volumio[1249]: info: sendMpdCommand status took 33 milliseconds May 04 20:19:56 volumio-x86 volumio[1249]: info: sendMpdCommand status took 33 milliseconds May 04 20:19:56 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:56 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:56 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:56 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:56 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:56 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:56 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:56 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:56 volumio-x86 volumio[1249]: info: ------------------------------ 56ms May 04 20:19:56 volumio-x86 volumio[1249]: info: ------------------------------ 24ms May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:56 volumio-x86 volumio[1249]: info: May 04 20:19:56 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:56 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:19:56 volumio-x86 volumio[1249]: info: sendMpdCommand status took 2 milliseconds May 04 20:19:56 volumio-x86 volumio[1249]: info: sendMpdCommand status took 2 milliseconds May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:56 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:56 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:56 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:56 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:56 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:56 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:56 volumio-x86 volumio[1249]: info: ------------------------------ 21ms May 04 20:19:57 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand update May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:57 volumio-x86 volumio[1249]: info: May 04 20:19:57 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:57 volumio-x86 volumio[1249]: info: sendMpdCommand update took 1 milliseconds May 04 20:19:57 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:57 volumio-x86 volumio[1249]: info: May 04 20:19:57 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:57 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:57 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:57 volumio-x86 volumio[1249]: info: sendMpdCommand status took 1 milliseconds May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:57 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatetrue May 04 20:19:57 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:57 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:57 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:57 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:57 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:57 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:57 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:57 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:57 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:57 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:57 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:57 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:57 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:57 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:57 volumio-x86 volumio[1249]: info: ------------------------------ 60ms May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:57 volumio-x86 volumio[1249]: info: May 04 20:19:57 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:57 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:57 volumio-x86 volumio[1249]: info: sendMpdCommand status took 60 milliseconds May 04 20:19:57 volumio-x86 volumio[1249]: info: sendMpdCommand status took 60 milliseconds May 04 20:19:57 volumio-x86 volumio[1249]: info: sendMpdCommand status took 0 milliseconds May 04 20:19:57 volumio-x86 volumio[1249]: info: sendMpdCommand status took 0 milliseconds May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:57 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:57 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:57 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:58 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:58 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:58 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:58 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:58 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:58 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:58 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:58 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:58 volumio-x86 volumio[1249]: info: ------------------------------ 94ms May 04 20:19:58 volumio-x86 volumio[1249]: info: ------------------------------ 34ms May 04 20:19:58 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:58 volumio-x86 volumio[1249]: info: May 04 20:19:58 volumio-x86 volumio[1249]: ---------------------------- MPD announces state update: update May 04 20:19:58 volumio-x86 volumio[1249]: info: ControllerMpd::getState May 04 20:19:58 volumio-x86 volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 20:19:58 volumio-x86 volumio[1249]: info: sendMpdCommand status took 6 milliseconds May 04 20:19:58 volumio-x86 volumio[1249]: info: sendMpdCommand status took 5 milliseconds May 04 20:19:58 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:58 volumio-x86 volumio[1249]: info: Command Router : Notfying DB Updatefalse May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreCommandRouter::Close All Modals sent May 04 20:19:58 volumio-x86 volumio[1249]: verbose: ControllerMpd::parseState May 04 20:19:58 volumio-x86 volumio[1249]: info: ControllerMpd::pushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreCommandRouter::servicePushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:58 volumio-x86 volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 04 20:19:58 volumio-x86 volumio[1249]: verbose: CURRENT POSITION 0 May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState stateService stop May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreStateMachine::pushState May 04 20:19:58 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:19:58 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 20:19:58 volumio-x86 volumio[1249]: info: ------------------------------ 16ms May 04 20:19:59 volumio-x86 volumio[1249]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 04 20:19:59 volumio-x86 volumio[1249]: info: Retrying Login Due to Network Error May 04 20:20:00 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:20:04 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:20:04 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 20:20:04 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:20:06 volumio-x86 volumio[1249]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.108 UA: Mozilla/5.0 (iPad; CPU OS 12_5_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/12.1.2 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 5 May 04 20:20:06 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 20:20:06 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:20:07 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 04 20:20:07 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetVisibleSources May 04 20:20:07 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 20:20:07 volumio-x86 volumio[1249]: info: Listing playlists May 04 20:20:08 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:20:09 volumio-x86 volumio[1249]: info: MyVolumio login type: Token May 04 20:20:12 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:20:14 volumio-x86 volumio[1249]: info: Retrieving Cloud Streaming UI May 04 20:20:14 volumio-x86 volumio[1249]: info: Getting Tidal Cloud Configuration May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:20:14 volumio-x86 volumio[1249]: info: Getting Qobuz Cloud Configuration May 04 20:20:14 volumio-x86 volumio[1249]: info: Asking plugin for UI Config May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:20:14 volumio-x86 volumio[1249]: info: Getting Spotify Cloud Configuration May 04 20:20:14 volumio-x86 volumio[1249]: info: Asking plugin for UI Config May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:20:14 volumio-x86 volumio[1249]: info: Saving Spotify Acccount May 04 20:20:14 volumio-x86 volumio[1249]: info: Got Tidal Cloud Configuration May 04 20:20:14 volumio-x86 volumio[1249]: info: Got it May 04 20:20:14 volumio-x86 volumio[1249]: info: Got it May 04 20:20:14 volumio-x86 volumio[1249]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 20:20:14 volumio-x86 volumio[1249]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources May 04 20:20:14 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources May 04 20:20:16 volumio-x86 volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 20:20:16 volumio-x86 volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 20:20:16 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:20:16 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:20:16 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 04 20:20:19 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 04 20:20:19 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 04 20:20:20 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:20:20 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:20:24 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:20:24 volumio-x86 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 20:20:24 volumio-x86 volumio[1249]: info: Error browsing device Synology for shares : Error: Command failed: echo volumio | smbclient -L Synology.local. May 04 20:20:24 volumio-x86 volumio[1249]: Unable to initialize messaging context May 04 20:20:24 volumio-x86 volumio[1249]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 20:20:24 volumio-x86 volumio[1249]: Error: dns service error: unknown May 04 20:20:24 volumio-x86 volumio[1249]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) May 04 20:20:24 volumio-x86 volumio[1249]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 04 20:20:24 volumio-x86 volumio[1249]: errorCode: -65537 May 04 20:20:24 volumio-x86 volumio[1249]: } May 04 20:20:24 volumio-x86 volumio[1249]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 20:20:24 volumio-x86 sudo[3020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-04 20:19 May 04 20:20:24 volumio-x86 sudo[3020]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"