-- Logs begin at Sun 2025-02-23 08:25:10 UTC, end at Sun 2025-02-23 16:25:09 UTC. -- Feb 23 16:24:57 volumio-fn 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 Feb 23 16:24:57 volumio-fn kernel: Command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=5b01fac8-abe8-45a5-a96b-067ed7a68d96 bootpart=UUID=8264-17E7 datapart=UUID=109d31d2-2200-4050-b7ca-cc337f8045fa 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 Feb 23 16:24:57 volumio-fn kernel: KERNEL supported cpus: Feb 23 16:24:57 volumio-fn kernel: Intel GenuineIntel Feb 23 16:24:57 volumio-fn kernel: AMD AuthenticAMD Feb 23 16:24:57 volumio-fn kernel: Hygon HygonGenuine Feb 23 16:24:57 volumio-fn kernel: Centaur CentaurHauls Feb 23 16:24:57 volumio-fn kernel: zhaoxin Shanghai Feb 23 16:24:57 volumio-fn kernel: BIOS-provided physical RAM map: Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bec88fff] usable Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x00000000bec89000-0x00000000bed8afff] reserved Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x00000000bed8b000-0x00000000bf6ebfff] usable Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x00000000bf6ec000-0x00000000bf7ebfff] reserved Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x00000000bf7ec000-0x00000000bf8ebfff] type 20 Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x00000000bf8ec000-0x00000000bf96bfff] reserved Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x00000000bf96c000-0x00000000bf97dfff] ACPI data Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x00000000bf97e000-0x00000000bf9fdfff] ACPI NVS Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x00000000bf9fe000-0x00000000bff7bfff] usable Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x00000000bff7c000-0x00000000bfffffff] reserved Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved Feb 23 16:24:57 volumio-fn kernel: BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable Feb 23 16:24:57 volumio-fn kernel: NX (Execute Disable) protection: active Feb 23 16:24:57 volumio-fn kernel: APIC: Static calls initialized Feb 23 16:24:57 volumio-fn kernel: efi: EFI v2.7 by EDK II Feb 23 16:24:57 volumio-fn kernel: efi: TPMFinalLog=0xbf9e6000 SMBIOS=0xbf720000 ACPI=0xbf97d000 ACPI 2.0=0xbf97d014 MEMATTR=0xbdf8e198 Feb 23 16:24:57 volumio-fn kernel: efi: Remove mem135: MMIO range=[0xffc00000-0xffffffff] (4MB) from e820 map Feb 23 16:24:57 volumio-fn kernel: e820: remove [mem 0xffc00000-0xffffffff] reserved Feb 23 16:24:57 volumio-fn kernel: SMBIOS 2.8 present. Feb 23 16:24:57 volumio-fn kernel: DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 0.0.0 02/06/2015 Feb 23 16:24:57 volumio-fn kernel: Hypervisor detected: KVM Feb 23 16:24:57 volumio-fn kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Feb 23 16:24:57 volumio-fn kernel: kvm-clock: using sched offset of 9260926800 cycles Feb 23 16:24:57 volumio-fn kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Feb 23 16:24:57 volumio-fn kernel: tsc: Detected 2494.222 MHz processor Feb 23 16:24:57 volumio-fn kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Feb 23 16:24:57 volumio-fn kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Feb 23 16:24:57 volumio-fn kernel: last_pfn = 0x140000 max_arch_pfn = 0x400000000 Feb 23 16:24:57 volumio-fn kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Feb 23 16:24:57 volumio-fn kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Feb 23 16:24:57 volumio-fn kernel: last_pfn = 0xbff7c max_arch_pfn = 0x400000000 Feb 23 16:24:57 volumio-fn kernel: Using GB pages for direct mapping Feb 23 16:24:57 volumio-fn kernel: Secure boot could not be determined Feb 23 16:24:57 volumio-fn kernel: RAMDISK: [mem 0x2fae7000-0x33d6afff] Feb 23 16:24:57 volumio-fn kernel: ACPI: Early table checksum verification disabled Feb 23 16:24:57 volumio-fn kernel: ACPI: RSDP 0x00000000BF97D014 000024 (v02 BOCHS ) Feb 23 16:24:57 volumio-fn kernel: ACPI: XSDT 0x00000000BF97C0E8 00004C (v01 BOCHS BXPC 00000001 01000013) Feb 23 16:24:57 volumio-fn kernel: ACPI: FACP 0x00000000BF979000 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 23 16:24:57 volumio-fn kernel: ACPI: DSDT 0x00000000BF97A000 001B6E (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 23 16:24:57 volumio-fn kernel: ACPI: FACS 0x00000000BF9B4000 000040 Feb 23 16:24:57 volumio-fn kernel: ACPI: APIC 0x00000000BF978000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 23 16:24:57 volumio-fn kernel: ACPI: TPM2 0x00000000BF977000 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Feb 23 16:24:57 volumio-fn kernel: ACPI: WAET 0x00000000BF976000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 23 16:24:57 volumio-fn kernel: ACPI: BGRT 0x00000000BF975000 000038 (v01 INTEL EDK2 00000002 01000013) Feb 23 16:24:57 volumio-fn kernel: ACPI: Reserving FACP table memory at [mem 0xbf979000-0xbf979073] Feb 23 16:24:57 volumio-fn kernel: ACPI: Reserving DSDT table memory at [mem 0xbf97a000-0xbf97bb6d] Feb 23 16:24:57 volumio-fn kernel: ACPI: Reserving FACS table memory at [mem 0xbf9b4000-0xbf9b403f] Feb 23 16:24:57 volumio-fn kernel: ACPI: Reserving APIC table memory at [mem 0xbf978000-0xbf97808f] Feb 23 16:24:57 volumio-fn kernel: ACPI: Reserving TPM2 table memory at [mem 0xbf977000-0xbf97704b] Feb 23 16:24:57 volumio-fn kernel: ACPI: Reserving WAET table memory at [mem 0xbf976000-0xbf976027] Feb 23 16:24:57 volumio-fn kernel: ACPI: Reserving BGRT table memory at [mem 0xbf975000-0xbf975037] Feb 23 16:24:57 volumio-fn kernel: Zone ranges: Feb 23 16:24:57 volumio-fn kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Feb 23 16:24:57 volumio-fn kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Feb 23 16:24:57 volumio-fn kernel: Normal [mem 0x0000000100000000-0x000000013fffffff] Feb 23 16:24:57 volumio-fn kernel: Movable zone start for each node Feb 23 16:24:57 volumio-fn kernel: Early memory node ranges Feb 23 16:24:57 volumio-fn kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Feb 23 16:24:57 volumio-fn kernel: node 0: [mem 0x0000000000100000-0x00000000bec88fff] Feb 23 16:24:57 volumio-fn kernel: node 0: [mem 0x00000000bed8b000-0x00000000bf6ebfff] Feb 23 16:24:57 volumio-fn kernel: node 0: [mem 0x00000000bf9fe000-0x00000000bff7bfff] Feb 23 16:24:57 volumio-fn kernel: node 0: [mem 0x0000000100000000-0x000000013fffffff] Feb 23 16:24:57 volumio-fn kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] Feb 23 16:24:57 volumio-fn kernel: On node 0, zone DMA: 1 pages in unavailable ranges Feb 23 16:24:57 volumio-fn kernel: On node 0, zone DMA: 96 pages in unavailable ranges Feb 23 16:24:57 volumio-fn kernel: On node 0, zone DMA32: 258 pages in unavailable ranges Feb 23 16:24:57 volumio-fn kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Feb 23 16:24:57 volumio-fn kernel: On node 0, zone Normal: 132 pages in unavailable ranges Feb 23 16:24:57 volumio-fn kernel: ACPI: PM-Timer IO Port: 0xb008 Feb 23 16:24:57 volumio-fn kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Feb 23 16:24:57 volumio-fn kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Feb 23 16:24:57 volumio-fn kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Feb 23 16:24:57 volumio-fn kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Feb 23 16:24:57 volumio-fn kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Feb 23 16:24:57 volumio-fn kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Feb 23 16:24:57 volumio-fn kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Feb 23 16:24:57 volumio-fn kernel: ACPI: Using ACPI (MADT) for SMP configuration information Feb 23 16:24:57 volumio-fn kernel: e820: update [mem 0xbdf85000-0xbdf8dfff] usable ==> reserved Feb 23 16:24:57 volumio-fn kernel: TSC deadline timer available Feb 23 16:24:57 volumio-fn kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Feb 23 16:24:57 volumio-fn kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Feb 23 16:24:57 volumio-fn kernel: kvm-guest: KVM setup pv remote TLB flush Feb 23 16:24:57 volumio-fn kernel: kvm-guest: setup PV sched yield Feb 23 16:24:57 volumio-fn kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] Feb 23 16:24:57 volumio-fn kernel: PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000fffff] Feb 23 16:24:57 volumio-fn kernel: PM: hibernation: Registered nosave memory: [mem 0xbdf85000-0xbdf8dfff] Feb 23 16:24:57 volumio-fn kernel: PM: hibernation: Registered nosave memory: [mem 0xbec89000-0xbed8afff] Feb 23 16:24:57 volumio-fn kernel: PM: hibernation: Registered nosave memory: [mem 0xbf6ec000-0xbf7ebfff] Feb 23 16:24:57 volumio-fn kernel: PM: hibernation: Registered nosave memory: [mem 0xbf7ec000-0xbf8ebfff] Feb 23 16:24:57 volumio-fn kernel: PM: hibernation: Registered nosave memory: [mem 0xbf8ec000-0xbf96bfff] Feb 23 16:24:57 volumio-fn kernel: PM: hibernation: Registered nosave memory: [mem 0xbf96c000-0xbf97dfff] Feb 23 16:24:57 volumio-fn kernel: PM: hibernation: Registered nosave memory: [mem 0xbf97e000-0xbf9fdfff] Feb 23 16:24:57 volumio-fn kernel: PM: hibernation: Registered nosave memory: [mem 0xbff7c000-0xbfffffff] Feb 23 16:24:57 volumio-fn kernel: PM: hibernation: Registered nosave memory: [mem 0xc0000000-0xffffffff] Feb 23 16:24:57 volumio-fn kernel: [mem 0xc0000000-0xffffffff] available for PCI devices Feb 23 16:24:57 volumio-fn kernel: Booting paravirtualized kernel on KVM Feb 23 16:24:57 volumio-fn kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Feb 23 16:24:57 volumio-fn kernel: setup_percpu: NR_CPUS:8 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Feb 23 16:24:57 volumio-fn kernel: percpu: Embedded 56 pages/cpu s191400 r8192 d29784 u524288 Feb 23 16:24:57 volumio-fn kernel: pcpu-alloc: s191400 r8192 d29784 u524288 alloc=1*2097152 Feb 23 16:24:57 volumio-fn kernel: pcpu-alloc: [0] 0 1 2 3 Feb 23 16:24:57 volumio-fn kernel: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=5b01fac8-abe8-45a5-a96b-067ed7a68d96 bootpart=UUID=8264-17E7 datapart=UUID=109d31d2-2200-4050-b7ca-cc337f8045fa 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 Feb 23 16:24:57 volumio-fn kernel: Unknown kernel command line parameters "splash BOOT_IMAGE=/vmlinuz biosdevname=0 imgpart=UUID=5b01fac8-abe8-45a5-a96b-067ed7a68d96 bootpart=UUID=8264-17E7 datapart=UUID=109d31d2-2200-4050-b7ca-cc337f8045fa hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh use_kmsg=no", will be passed to user space. Feb 23 16:24:57 volumio-fn kernel: random: crng init done Feb 23 16:24:57 volumio-fn kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: Built 1 zonelists, mobility grouping on. Total pages: 1028761 Feb 23 16:24:57 volumio-fn kernel: mem auto-init: stack:all(zero), heap alloc:off, heap free:off Feb 23 16:24:57 volumio-fn kernel: software IO TLB: area num 4. Feb 23 16:24:57 volumio-fn kernel: Memory: 3920536K/4189212K available (14336K kernel code, 1878K rwdata, 4640K rodata, 2988K init, 1148K bss, 268420K reserved, 0K cma-reserved) Feb 23 16:24:57 volumio-fn kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Feb 23 16:24:57 volumio-fn kernel: Kernel/User page tables isolation: enabled Feb 23 16:24:57 volumio-fn kernel: ftrace: allocating 40433 entries in 158 pages Feb 23 16:24:57 volumio-fn kernel: ftrace: allocated 158 pages with 5 groups Feb 23 16:24:57 volumio-fn kernel: Dynamic Preempt: voluntary Feb 23 16:24:57 volumio-fn kernel: rcu: Preemptible hierarchical RCU implementation. Feb 23 16:24:57 volumio-fn kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Feb 23 16:24:57 volumio-fn kernel: Trampoline variant of Tasks RCU enabled. Feb 23 16:24:57 volumio-fn kernel: Rude variant of Tasks RCU enabled. Feb 23 16:24:57 volumio-fn kernel: Tracing variant of Tasks RCU enabled. Feb 23 16:24:57 volumio-fn kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Feb 23 16:24:57 volumio-fn kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Feb 23 16:24:57 volumio-fn kernel: NR_IRQS: 4352, nr_irqs: 456, preallocated irqs: 16 Feb 23 16:24:57 volumio-fn kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Feb 23 16:24:57 volumio-fn kernel: Console: colour dummy device 80x25 Feb 23 16:24:57 volumio-fn kernel: printk: console [tty0] enabled Feb 23 16:24:57 volumio-fn kernel: ACPI: Core revision 20230628 Feb 23 16:24:57 volumio-fn kernel: APIC: Switch to symmetric I/O mode setup Feb 23 16:24:57 volumio-fn kernel: x2apic enabled Feb 23 16:24:57 volumio-fn kernel: APIC: Switched APIC routing to: physical x2apic Feb 23 16:24:57 volumio-fn kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Feb 23 16:24:57 volumio-fn kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Feb 23 16:24:57 volumio-fn kernel: kvm-guest: setup PV IPIs Feb 23 16:24:57 volumio-fn kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x23f3e76dd04, max_idle_ns: 440795285707 ns Feb 23 16:24:57 volumio-fn kernel: Calibrating delay loop (skipped) preset value.. 4988.44 BogoMIPS (lpj=9976888) Feb 23 16:24:57 volumio-fn kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Feb 23 16:24:57 volumio-fn kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Feb 23 16:24:57 volumio-fn kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Feb 23 16:24:57 volumio-fn kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Feb 23 16:24:57 volumio-fn kernel: Spectre V2 : Mitigation: Retpolines Feb 23 16:24:57 volumio-fn kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Feb 23 16:24:57 volumio-fn kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Feb 23 16:24:57 volumio-fn kernel: Spectre V2 : Enabling Restricted Speculation for firmware calls Feb 23 16:24:57 volumio-fn kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Feb 23 16:24:57 volumio-fn kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Feb 23 16:24:57 volumio-fn kernel: MDS: Mitigation: Clear CPU buffers Feb 23 16:24:57 volumio-fn kernel: MMIO Stale Data: Unknown: No mitigations Feb 23 16:24:57 volumio-fn kernel: SRBDS: Unknown: Dependent on hypervisor status Feb 23 16:24:57 volumio-fn kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Feb 23 16:24:57 volumio-fn kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Feb 23 16:24:57 volumio-fn kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Feb 23 16:24:57 volumio-fn kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Feb 23 16:24:57 volumio-fn kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Feb 23 16:24:57 volumio-fn kernel: Freeing SMP alternatives memory: 32K Feb 23 16:24:57 volumio-fn kernel: pid_max: default: 32768 minimum: 301 Feb 23 16:24:57 volumio-fn kernel: LSM: initializing lsm=capability,yama,integrity Feb 23 16:24:57 volumio-fn kernel: Yama: becoming mindful. Feb 23 16:24:57 volumio-fn kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E3-1265L v3 @ 2.50GHz (family: 0x6, model: 0x3c, stepping: 0x3) Feb 23 16:24:57 volumio-fn kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Feb 23 16:24:57 volumio-fn kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Feb 23 16:24:57 volumio-fn kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Feb 23 16:24:57 volumio-fn kernel: Performance Events: Haswell events, full-width counters, Intel PMU driver. Feb 23 16:24:57 volumio-fn kernel: ... version: 2 Feb 23 16:24:57 volumio-fn kernel: ... bit width: 48 Feb 23 16:24:57 volumio-fn kernel: ... generic registers: 4 Feb 23 16:24:57 volumio-fn kernel: ... value mask: 0000ffffffffffff Feb 23 16:24:57 volumio-fn kernel: ... max period: 00007fffffffffff Feb 23 16:24:57 volumio-fn kernel: ... fixed-purpose events: 3 Feb 23 16:24:57 volumio-fn kernel: ... event mask: 000000070000000f Feb 23 16:24:57 volumio-fn kernel: signal: max sigframe size: 1776 Feb 23 16:24:57 volumio-fn kernel: rcu: Hierarchical SRCU implementation. Feb 23 16:24:57 volumio-fn kernel: rcu: Max phase no-delay instances is 1000. Feb 23 16:24:57 volumio-fn kernel: smp: Bringing up secondary CPUs ... Feb 23 16:24:57 volumio-fn kernel: smpboot: x86: Booting SMP configuration: Feb 23 16:24:57 volumio-fn kernel: .... node #0, CPUs: #1 #2 #3 Feb 23 16:24:57 volumio-fn kernel: smp: Brought up 1 node, 4 CPUs Feb 23 16:24:57 volumio-fn kernel: smpboot: Max logical packages: 1 Feb 23 16:24:57 volumio-fn kernel: smpboot: Total of 4 processors activated (19953.77 BogoMIPS) Feb 23 16:24:57 volumio-fn kernel: devtmpfs: initialized Feb 23 16:24:57 volumio-fn kernel: x86/mm: Memory block size: 128MB Feb 23 16:24:57 volumio-fn kernel: ACPI: PM: Registering ACPI NVS region [mem 0xbf97e000-0xbf9fdfff] (524288 bytes) Feb 23 16:24:57 volumio-fn kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Feb 23 16:24:57 volumio-fn kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: pinctrl core: initialized pinctrl subsystem Feb 23 16:24:57 volumio-fn kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Feb 23 16:24:57 volumio-fn kernel: audit: initializing netlink subsys (disabled) Feb 23 16:24:57 volumio-fn kernel: audit: type=2000 audit(1740299091.941:1): state=initialized audit_enabled=0 res=1 Feb 23 16:24:57 volumio-fn kernel: thermal_sys: Registered thermal governor 'fair_share' Feb 23 16:24:57 volumio-fn kernel: thermal_sys: Registered thermal governor 'bang_bang' Feb 23 16:24:57 volumio-fn kernel: thermal_sys: Registered thermal governor 'step_wise' Feb 23 16:24:57 volumio-fn kernel: thermal_sys: Registered thermal governor 'user_space' Feb 23 16:24:57 volumio-fn kernel: EISA bus registered Feb 23 16:24:57 volumio-fn kernel: cpuidle: using governor ladder Feb 23 16:24:57 volumio-fn kernel: cpuidle: using governor menu Feb 23 16:24:57 volumio-fn kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Feb 23 16:24:57 volumio-fn kernel: PCI: Using configuration type 1 for base access Feb 23 16:24:57 volumio-fn kernel: core: PMU erratum BJ122, BV98, HSD29 workaround disabled, HT off Feb 23 16:24:57 volumio-fn kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Feb 23 16:24:57 volumio-fn kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Feb 23 16:24:57 volumio-fn kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Feb 23 16:24:57 volumio-fn kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Feb 23 16:24:57 volumio-fn kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Feb 23 16:24:57 volumio-fn kernel: ACPI: Added _OSI(Module Device) Feb 23 16:24:57 volumio-fn kernel: ACPI: Added _OSI(Processor Device) Feb 23 16:24:57 volumio-fn kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Feb 23 16:24:57 volumio-fn kernel: ACPI: Added _OSI(Processor Aggregator Device) Feb 23 16:24:57 volumio-fn kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Feb 23 16:24:57 volumio-fn kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Feb 23 16:24:57 volumio-fn kernel: ACPI: Interpreter enabled Feb 23 16:24:57 volumio-fn kernel: ACPI: PM: (supports S0 S5) Feb 23 16:24:57 volumio-fn kernel: ACPI: Using IOAPIC for interrupt routing Feb 23 16:24:57 volumio-fn kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Feb 23 16:24:57 volumio-fn kernel: PCI: Using E820 reservations for host bridge windows Feb 23 16:24:57 volumio-fn kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Feb 23 16:24:57 volumio-fn kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Feb 23 16:24:57 volumio-fn kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Feb 23 16:24:57 volumio-fn kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Feb 23 16:24:57 volumio-fn kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [2] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [4] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [5] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [6] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [7] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [8] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [9] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [10] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [11] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [12] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [13] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [14] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [15] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [16] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [17] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [18] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [19] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [20] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [21] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [22] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [23] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [24] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [25] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [26] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [27] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [28] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [29] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [30] registered Feb 23 16:24:57 volumio-fn kernel: acpiphp: Slot [31] registered Feb 23 16:24:57 volumio-fn kernel: PCI host bridge to bus 0000:00 Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: root bus resource [mem 0x7000000000-0x707fffffff window] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: root bus resource [mem 0xfed40000-0xfed44fff] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:01.1: reg 0x20: [io 0xc1e0-0xc1ef] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:02.0: [8086:100e] type 00 class 0x020000 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:02.0: reg 0x10: [mem 0xc1040000-0xc105ffff] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:02.0: reg 0x14: [io 0xc180-0xc1bf] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfffc0000-0xffffffff pref] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:03.0: [1234:1111] type 00 class 0x030000 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:03.0: reg 0x10: [mem 0xc0000000-0xc0ffffff pref] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:03.0: reg 0x18: [mem 0xc1065000-0xc1065fff] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:03.0: reg 0x30: [mem 0xffff0000-0xffffffff pref] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:03.0: BAR 0: assigned to efifb Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:03.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:04.0: [1af4:1002] type 00 class 0x00ff00 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:04.0: reg 0x10: [io 0xc140-0xc17f] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:04.0: reg 0x20: [mem 0x7000000000-0x7000003fff 64bit pref] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:05.0: [1af4:1004] type 00 class 0x010000 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:05.0: reg 0x10: [io 0xc100-0xc13f] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:05.0: reg 0x14: [mem 0xc1064000-0xc1064fff] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:05.0: reg 0x20: [mem 0x7000004000-0x7000007fff 64bit pref] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:06.0: [1000:0012] type 00 class 0x010000 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:06.0: reg 0x10: [io 0xc000-0xc0ff] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:06.0: reg 0x14: [mem 0xc1063000-0xc10633ff] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:06.0: reg 0x18: [mem 0xc1060000-0xc1061fff] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:1e.0: [1b36:000d] type 00 class 0x0c0330 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:1e.0: reg 0x10: [mem 0x7000008000-0x700000bfff 64bit] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:1f.0: [8086:2922] type 00 class 0x010601 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:1f.0: reg 0x20: [io 0xc1c0-0xc1df] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:1f.0: reg 0x24: [mem 0xc1062000-0xc1062fff] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: on NUMA node 0 Feb 23 16:24:57 volumio-fn kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Feb 23 16:24:57 volumio-fn kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Feb 23 16:24:57 volumio-fn kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Feb 23 16:24:57 volumio-fn kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Feb 23 16:24:57 volumio-fn kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Feb 23 16:24:57 volumio-fn kernel: iommu: Default domain type: Translated Feb 23 16:24:57 volumio-fn kernel: iommu: DMA domain TLB invalidation policy: lazy mode Feb 23 16:24:57 volumio-fn kernel: SCSI subsystem initialized Feb 23 16:24:57 volumio-fn kernel: libata version 3.00 loaded. Feb 23 16:24:57 volumio-fn kernel: ACPI: bus type USB registered Feb 23 16:24:57 volumio-fn kernel: usbcore: registered new interface driver usbfs Feb 23 16:24:57 volumio-fn kernel: usbcore: registered new interface driver hub Feb 23 16:24:57 volumio-fn kernel: usbcore: registered new device driver usb Feb 23 16:24:57 volumio-fn kernel: efivars: Registered efivars operations Feb 23 16:24:57 volumio-fn kernel: PCI: Using ACPI for IRQ routing Feb 23 16:24:57 volumio-fn kernel: PCI: pci_cache_line_size set to 64 bytes Feb 23 16:24:57 volumio-fn kernel: e820: reserve RAM buffer [mem 0xbdf85000-0xbfffffff] Feb 23 16:24:57 volumio-fn kernel: e820: reserve RAM buffer [mem 0xbec89000-0xbfffffff] Feb 23 16:24:57 volumio-fn kernel: e820: reserve RAM buffer [mem 0xbf6ec000-0xbfffffff] Feb 23 16:24:57 volumio-fn kernel: e820: reserve RAM buffer [mem 0xbff7c000-0xbfffffff] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:03.0: vgaarb: setting as boot VGA device Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:03.0: vgaarb: bridge control possible Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:03.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Feb 23 16:24:57 volumio-fn kernel: vgaarb: loaded Feb 23 16:24:57 volumio-fn kernel: clocksource: Switched to clocksource kvm-clock Feb 23 16:24:57 volumio-fn kernel: VFS: Disk quotas dquot_6.6.0 Feb 23 16:24:57 volumio-fn kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Feb 23 16:24:57 volumio-fn kernel: pnp: PnP ACPI init Feb 23 16:24:57 volumio-fn kernel: pnp 00:02: [dma 2] Feb 23 16:24:57 volumio-fn kernel: pnp: PnP ACPI: found 4 devices Feb 23 16:24:57 volumio-fn kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Feb 23 16:24:57 volumio-fn kernel: NET: Registered PF_INET protocol family Feb 23 16:24:57 volumio-fn kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: TCP: Hash tables configured (established 32768 bind 32768) Feb 23 16:24:57 volumio-fn kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Feb 23 16:24:57 volumio-fn kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:02.0: can't claim BAR 6 [mem 0xfffc0000-0xffffffff pref]: no compatible bridge window Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:02.0: BAR 6: assigned [mem 0xc1000000-0xc103ffff pref] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: resource 8 [mem 0x7000000000-0x707fffffff window] Feb 23 16:24:57 volumio-fn kernel: pci_bus 0000:00: resource 9 [mem 0xfed40000-0xfed44fff] Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Feb 23 16:24:57 volumio-fn kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 10 Feb 23 16:24:57 volumio-fn kernel: pci 0000:00:1e.0: quirk_usb_early_handoff+0x0/0x770 took 25093 usecs Feb 23 16:24:57 volumio-fn kernel: PCI: CLS 0 bytes, default 64 Feb 23 16:24:57 volumio-fn kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Feb 23 16:24:57 volumio-fn kernel: software IO TLB: mapped [mem 0x00000000b7dfe000-0x00000000bbdfe000] (64MB) Feb 23 16:24:57 volumio-fn kernel: Trying to unpack rootfs image as initramfs... Feb 23 16:24:57 volumio-fn kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Feb 23 16:24:57 volumio-fn kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x23f3e76dd04, max_idle_ns: 440795285707 ns Feb 23 16:24:57 volumio-fn kernel: Initialise system trusted keyrings Feb 23 16:24:57 volumio-fn kernel: workingset: timestamp_bits=46 max_order=20 bucket_order=0 Feb 23 16:24:57 volumio-fn kernel: zbud: loaded Feb 23 16:24:57 volumio-fn kernel: Key type asymmetric registered Feb 23 16:24:57 volumio-fn kernel: Asymmetric key parser 'x509' registered Feb 23 16:24:57 volumio-fn kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) Feb 23 16:24:57 volumio-fn kernel: io scheduler mq-deadline registered Feb 23 16:24:57 volumio-fn kernel: io scheduler kyber registered Feb 23 16:24:57 volumio-fn kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Feb 23 16:24:57 volumio-fn kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 Feb 23 16:24:57 volumio-fn kernel: ACPI: button: Power Button [PWRF] Feb 23 16:24:57 volumio-fn kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Feb 23 16:24:57 volumio-fn kernel: Linux agpgart interface v0.103 Feb 23 16:24:57 volumio-fn kernel: ata_piix 0000:00:01.1: version 2.13 Feb 23 16:24:57 volumio-fn kernel: scsi host0: ata_piix Feb 23 16:24:57 volumio-fn kernel: scsi host1: ata_piix Feb 23 16:24:57 volumio-fn kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 Feb 23 16:24:57 volumio-fn kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 Feb 23 16:24:57 volumio-fn kernel: xhci_hcd 0000:00:1e.0: xHCI Host Controller Feb 23 16:24:57 volumio-fn kernel: xhci_hcd 0000:00:1e.0: new USB bus registered, assigned bus number 1 Feb 23 16:24:57 volumio-fn kernel: xhci_hcd 0000:00:1e.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010 Feb 23 16:24:57 volumio-fn kernel: xhci_hcd 0000:00:1e.0: xHCI Host Controller Feb 23 16:24:57 volumio-fn kernel: xhci_hcd 0000:00:1e.0: new USB bus registered, assigned bus number 2 Feb 23 16:24:57 volumio-fn kernel: xhci_hcd 0000:00:1e.0: Host supports USB 3.0 SuperSpeed Feb 23 16:24:57 volumio-fn kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Feb 23 16:24:57 volumio-fn kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 23 16:24:57 volumio-fn kernel: usb usb1: Product: xHCI Host Controller Feb 23 16:24:57 volumio-fn kernel: usb usb1: Manufacturer: Linux 6.6.32-volumio xhci-hcd Feb 23 16:24:57 volumio-fn kernel: usb usb1: SerialNumber: 0000:00:1e.0 Feb 23 16:24:57 volumio-fn kernel: hub 1-0:1.0: USB hub found Feb 23 16:24:57 volumio-fn kernel: hub 1-0:1.0: 4 ports detected Feb 23 16:24:57 volumio-fn kernel: usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. Feb 23 16:24:57 volumio-fn kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Feb 23 16:24:57 volumio-fn kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 23 16:24:57 volumio-fn kernel: usb usb2: Product: xHCI Host Controller Feb 23 16:24:57 volumio-fn kernel: usb usb2: Manufacturer: Linux 6.6.32-volumio xhci-hcd Feb 23 16:24:57 volumio-fn kernel: usb usb2: SerialNumber: 0000:00:1e.0 Feb 23 16:24:57 volumio-fn kernel: hub 2-0:1.0: USB hub found Feb 23 16:24:57 volumio-fn kernel: hub 2-0:1.0: 4 ports detected Feb 23 16:24:57 volumio-fn kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Feb 23 16:24:57 volumio-fn kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Feb 23 16:24:57 volumio-fn kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Feb 23 16:24:57 volumio-fn kernel: mousedev: PS/2 mouse device common for all mice Feb 23 16:24:57 volumio-fn kernel: rtc_cmos 00:03: RTC can wake from S4 Feb 23 16:24:57 volumio-fn kernel: rtc_cmos 00:03: registered as rtc0 Feb 23 16:24:57 volumio-fn kernel: rtc_cmos 00:03: setting system clock to 2025-02-23T16:24:51 UTC (1740327891) Feb 23 16:24:57 volumio-fn kernel: rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram Feb 23 16:24:57 volumio-fn kernel: i2c_dev: i2c /dev entries driver Feb 23 16:24:57 volumio-fn kernel: platform eisa.0: Probing EISA bus 0 Feb 23 16:24:57 volumio-fn kernel: platform eisa.0: EISA: Cannot allocate resource for mainboard Feb 23 16:24:57 volumio-fn kernel: intel_pstate: CPU model not supported Feb 23 16:24:57 volumio-fn kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 Feb 23 16:24:57 volumio-fn kernel: ledtrig-cpu: registered to indicate activity on CPUs Feb 23 16:24:57 volumio-fn kernel: efifb: probing for efifb Feb 23 16:24:57 volumio-fn kernel: efifb: framebuffer at 0xc0000000, using 1408k, total 1408k Feb 23 16:24:57 volumio-fn kernel: efifb: mode is 800x600x24, linelength=2400, pages=1 Feb 23 16:24:57 volumio-fn kernel: efifb: scrolling: redraw Feb 23 16:24:57 volumio-fn kernel: efifb: Truecolor: size=0:8:8:8, shift=0:16:8:0 Feb 23 16:24:57 volumio-fn kernel: Console: switching to colour frame buffer device 100x37 Feb 23 16:24:57 volumio-fn kernel: fb0: EFI VGA frame buffer device Feb 23 16:24:57 volumio-fn kernel: NET: Registered PF_INET6 protocol family Feb 23 16:24:57 volumio-fn kernel: Segment Routing with IPv6 Feb 23 16:24:57 volumio-fn kernel: In-situ OAM (IOAM) with IPv6 Feb 23 16:24:57 volumio-fn kernel: mip6: Mobile IPv6 Feb 23 16:24:57 volumio-fn kernel: NET: Registered PF_PACKET protocol family Feb 23 16:24:57 volumio-fn kernel: mpls_gso: MPLS GSO support Feb 23 16:24:57 volumio-fn kernel: IPI shorthand broadcast: enabled Feb 23 16:24:57 volumio-fn kernel: sched_clock: Marking stable (294592943, 1727269)->(323730260, -27410048) Feb 23 16:24:57 volumio-fn kernel: Loading compiled-in X.509 certificates Feb 23 16:24:57 volumio-fn kernel: clk: Disabling unused clocks Feb 23 16:24:57 volumio-fn kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Feb 23 16:24:57 volumio-fn kernel: usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 Feb 23 16:24:57 volumio-fn kernel: usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 Feb 23 16:24:57 volumio-fn kernel: usb 1-1: Product: QEMU USB Tablet Feb 23 16:24:57 volumio-fn kernel: usb 1-1: Manufacturer: QEMU Feb 23 16:24:57 volumio-fn kernel: usb 1-1: SerialNumber: 28754-0000:00:1e.0-1 Feb 23 16:24:57 volumio-fn kernel: usb 1-3: new high-speed USB device number 3 using xhci_hcd Feb 23 16:24:57 volumio-fn kernel: Freeing initrd memory: 68112K Feb 23 16:24:57 volumio-fn kernel: Freeing unused kernel image (initmem) memory: 2988K Feb 23 16:24:57 volumio-fn kernel: Write protecting the kernel read-only data: 20480k Feb 23 16:24:57 volumio-fn kernel: Freeing unused kernel image (rodata/data gap) memory: 1504K Feb 23 16:24:57 volumio-fn kernel: Run /init as init process Feb 23 16:24:57 volumio-fn kernel: with arguments: Feb 23 16:24:57 volumio-fn kernel: /init Feb 23 16:24:57 volumio-fn kernel: splash Feb 23 16:24:57 volumio-fn kernel: with environment: Feb 23 16:24:57 volumio-fn kernel: HOME=/ Feb 23 16:24:57 volumio-fn kernel: TERM=linux Feb 23 16:24:57 volumio-fn kernel: BOOT_IMAGE=/vmlinuz Feb 23 16:24:57 volumio-fn kernel: biosdevname=0 Feb 23 16:24:57 volumio-fn kernel: imgpart=UUID=5b01fac8-abe8-45a5-a96b-067ed7a68d96 Feb 23 16:24:57 volumio-fn kernel: bootpart=UUID=8264-17E7 Feb 23 16:24:57 volumio-fn kernel: datapart=UUID=109d31d2-2200-4050-b7ca-cc337f8045fa Feb 23 16:24:57 volumio-fn kernel: hwdevice=x86 Feb 23 16:24:57 volumio-fn kernel: uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg Feb 23 16:24:57 volumio-fn kernel: imgfile=/volumio_current.sqsh Feb 23 16:24:57 volumio-fn kernel: use_kmsg=no Feb 23 16:24:57 volumio-fn kernel: usb 1-3: New USB device found, idVendor=8087, idProduct=8000, bcdDevice= 0.05 Feb 23 16:24:57 volumio-fn kernel: usb 1-3: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Feb 23 16:24:57 volumio-fn kernel: hub 1-3:1.0: USB hub found Feb 23 16:24:57 volumio-fn kernel: hub 1-3:1.0: 6 ports detected Feb 23 16:24:57 volumio-fn kernel: e1000: Intel(R) PRO/1000 Network Driver Feb 23 16:24:57 volumio-fn kernel: e1000: Copyright (c) 1999-2006 Intel Corporation. Feb 23 16:24:57 volumio-fn kernel: input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 Feb 23 16:24:57 volumio-fn kernel: input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 Feb 23 16:24:57 volumio-fn kernel: FDC 0 is a S82078B Feb 23 16:24:57 volumio-fn kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0xb100, revision 0 Feb 23 16:24:57 volumio-fn kernel: ahci 0000:00:1f.0: version 3.0 Feb 23 16:24:57 volumio-fn kernel: ACPI: bus type drm_connector registered Feb 23 16:24:57 volumio-fn kernel: usb 1-4: new high-speed USB device number 4 using xhci_hcd Feb 23 16:24:57 volumio-fn kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11 Feb 23 16:24:57 volumio-fn kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Feb 23 16:24:57 volumio-fn kernel: ahci 0000:00:1f.0: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Feb 23 16:24:57 volumio-fn kernel: ahci 0000:00:1f.0: flags: 64bit ncq only Feb 23 16:24:57 volumio-fn kernel: scsi host2: ahci Feb 23 16:24:57 volumio-fn kernel: scsi host3: ahci Feb 23 16:24:57 volumio-fn kernel: scsi host4: ahci Feb 23 16:24:57 volumio-fn kernel: scsi host5: ahci Feb 23 16:24:57 volumio-fn kernel: scsi host6: ahci Feb 23 16:24:57 volumio-fn kernel: scsi host7: ahci Feb 23 16:24:57 volumio-fn kernel: Console: switching to colour dummy device 80x25 Feb 23 16:24:57 volumio-fn kernel: bochs-drm 0000:00:03.0: vgaarb: deactivate vga console Feb 23 16:24:57 volumio-fn kernel: ata3: SATA max UDMA/133 abar m4096@0xc1062000 port 0xc1062100 irq 29 Feb 23 16:24:57 volumio-fn kernel: ata4: SATA max UDMA/133 abar m4096@0xc1062000 port 0xc1062180 irq 29 Feb 23 16:24:57 volumio-fn kernel: ata5: SATA max UDMA/133 abar m4096@0xc1062000 port 0xc1062200 irq 29 Feb 23 16:24:57 volumio-fn kernel: ata6: SATA max UDMA/133 abar m4096@0xc1062000 port 0xc1062280 irq 29 Feb 23 16:24:57 volumio-fn kernel: ata7: SATA max UDMA/133 abar m4096@0xc1062000 port 0xc1062300 irq 29 Feb 23 16:24:57 volumio-fn kernel: ata8: SATA max UDMA/133 abar m4096@0xc1062000 port 0xc1062380 irq 29 Feb 23 16:24:57 volumio-fn kernel: [drm] Found bochs VGA, ID 0xb0c5. Feb 23 16:24:57 volumio-fn kernel: [drm] Framebuffer size 16384 kB @ 0xc0000000, mmio @ 0xc1065000. Feb 23 16:24:57 volumio-fn kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Feb 23 16:24:57 volumio-fn kernel: [drm] Found EDID data blob. Feb 23 16:24:57 volumio-fn kernel: [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:03.0 on minor 0 Feb 23 16:24:57 volumio-fn kernel: fbcon: bochs-drmdrmfb (fb0) is primary device Feb 23 16:24:57 volumio-fn kernel: Console: switching to colour frame buffer device 160x50 Feb 23 16:24:57 volumio-fn kernel: bochs-drm 0000:00:03.0: [drm] fb0: bochs-drmdrmfb frame buffer device Feb 23 16:24:57 volumio-fn kernel: usb 1-4: New USB device found, idVendor=8087, idProduct=8008, bcdDevice= 0.05 Feb 23 16:24:57 volumio-fn kernel: usb 1-4: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Feb 23 16:24:57 volumio-fn kernel: hub 1-4:1.0: USB hub found Feb 23 16:24:57 volumio-fn kernel: hub 1-4:1.0: 6 ports detected Feb 23 16:24:57 volumio-fn kernel: hid: raw HID events driver (C) Jiri Kosina Feb 23 16:24:57 volumio-fn kernel: ata8: SATA link down (SStatus 0 SControl 300) Feb 23 16:24:57 volumio-fn kernel: ata4: SATA link down (SStatus 0 SControl 300) Feb 23 16:24:57 volumio-fn kernel: ata6: SATA link down (SStatus 0 SControl 300) Feb 23 16:24:57 volumio-fn kernel: ata5: SATA link down (SStatus 0 SControl 300) Feb 23 16:24:57 volumio-fn kernel: ata7: SATA link down (SStatus 0 SControl 300) Feb 23 16:24:57 volumio-fn kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Feb 23 16:24:57 volumio-fn kernel: ata3.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100 Feb 23 16:24:57 volumio-fn kernel: ata3.00: 33554432 sectors, multi 16: LBA48 NCQ (depth 32) Feb 23 16:24:57 volumio-fn kernel: ata3.00: applying bridge limits Feb 23 16:24:57 volumio-fn kernel: ata3.00: configured for UDMA/100 Feb 23 16:24:57 volumio-fn kernel: scsi 2:0:0:0: Direct-Access ATA QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 Feb 23 16:24:57 volumio-fn kernel: sd 2:0:0:0: [sda] 33554432 512-byte logical blocks: (17.2 GB/16.0 GiB) Feb 23 16:24:57 volumio-fn kernel: sd 2:0:0:0: [sda] Write Protect is off Feb 23 16:24:57 volumio-fn kernel: sd 2:0:0:0: [sda] Mode Sense: 00 3a 00 00 Feb 23 16:24:57 volumio-fn kernel: sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Feb 23 16:24:57 volumio-fn kernel: sd 2:0:0:0: [sda] Preferred minimum I/O size 512 bytes Feb 23 16:24:57 volumio-fn kernel: sda: sda1 sda2 sda3 Feb 23 16:24:57 volumio-fn kernel: sd 2:0:0:0: [sda] Attached SCSI disk Feb 23 16:24:57 volumio-fn kernel: usbcore: registered new interface driver usbhid Feb 23 16:24:57 volumio-fn kernel: usbhid: USB HID core driver Feb 23 16:24:57 volumio-fn kernel: input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1e.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input5 Feb 23 16:24:57 volumio-fn kernel: hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1e.0-1/input0 Feb 23 16:24:57 volumio-fn kernel: e1000 0000:00:02.0 eth0: (PCI:33MHz:32-bit) 22:31:7e:fe:29:12 Feb 23 16:24:57 volumio-fn kernel: e1000 0000:00:02.0 eth0: Intel(R) PRO/1000 Network Connection Feb 23 16:24:57 volumio-fn kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Feb 23 16:24:57 volumio-fn kernel: sdhci: Secure Digital Host Controller Interface driver Feb 23 16:24:57 volumio-fn kernel: sdhci: Copyright(c) Pierre Ossman Feb 23 16:24:57 volumio-fn kernel: fuse: init (API version 7.39) Feb 23 16:24:57 volumio-fn kernel: usbcore: registered new interface driver usb-storage Feb 23 16:24:57 volumio-fn kernel: usbcore: registered new interface driver uas Feb 23 16:24:57 volumio-fn kernel: [drm] radeon kernel modesetting enabled. Feb 23 16:24:57 volumio-fn kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Feb 23 16:24:57 volumio-fn kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Feb 23 16:24:57 volumio-fn kernel: EXT4-fs (sda2): recovery complete Feb 23 16:24:57 volumio-fn kernel: EXT4-fs (sda2): mounted filesystem 5b01fac8-abe8-45a5-a96b-067ed7a68d96 r/w with ordered data mode. Quota mode: none. Feb 23 16:24:57 volumio-fn kernel: loop: module loaded Feb 23 16:24:57 volumio-fn kernel: block device autoloading is deprecated and will be removed. Feb 23 16:24:57 volumio-fn kernel: loop0: detected capacity change from 0 to 1725144 Feb 23 16:24:57 volumio-fn kernel: EXT4-fs (sda3): 2 orphan inodes deleted Feb 23 16:24:57 volumio-fn kernel: EXT4-fs (sda3): recovery complete Feb 23 16:24:57 volumio-fn kernel: EXT4-fs (sda3): mounted filesystem 109d31d2-2200-4050-b7ca-cc337f8045fa r/w with ordered data mode. Quota mode: none. Feb 23 16:24:57 volumio-fn systemd[1]: Inserted module 'autofs4' Feb 23 16:24:57 volumio-fn 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) Feb 23 16:24:57 volumio-fn systemd[1]: Detected virtualization microsoft. Feb 23 16:24:57 volumio-fn systemd[1]: Detected architecture x86-64. Feb 23 16:24:57 volumio-fn systemd[1]: Set hostname to . Feb 23 16:24:57 volumio-fn 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. Feb 23 16:24:57 volumio-fn systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Feb 23 16:24:57 volumio-fn 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. Feb 23 16:24:57 volumio-fn systemd[1]: Listening on udev Control Socket. Feb 23 16:24:57 volumio-fn systemd[1]: Listening on Journal Socket (/dev/log). Feb 23 16:24:57 volumio-fn systemd[1]: Started Forward Password Requests to Wall Directory Watch. Feb 23 16:24:57 volumio-fn systemd-journald[465]: Journal started Feb 23 16:24:57 volumio-fn systemd-journald[465]: Runtime journal (/run/log/journal/724bcbf01eebf9d6210f389b672e577a) is 3.7M, max 30.0M, 26.2M free. Feb 23 16:24:57 volumio-fn systemd[1]: Mounted Huge Pages File System. Feb 23 16:24:57 volumio-fn systemd[1]: Mounted POSIX Message Queue File System. Feb 23 16:24:57 volumio-fn systemd[1]: Mounted Kernel Configuration File System. Feb 23 16:24:57 volumio-fn systemd[1]: Mounted FUSE Control File System. Feb 23 16:24:57 volumio-fn fake-hwclock[463]: Current system time: 2025-02-23 16:24:57 Feb 23 16:24:57 volumio-fn fake-hwclock[463]: fake-hwclock saved clock information is in the past: 2025-02-22 04:09:10 Feb 23 16:24:57 volumio-fn fake-hwclock[463]: To set system time to this saved clock anyway, use "force" Feb 23 16:24:57 volumio-fn systemd[1]: Mounted Kernel Debug File System. Feb 23 16:24:57 volumio-fn systemd[1]: Started Restore / save the current clock. Feb 23 16:24:57 volumio-fn systemd[1]: Starting Load/Save Random Seed... Feb 23 16:24:57 volumio-fn systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Feb 23 16:24:57 volumio-fn systemd[1]: Starting Create System Users... Feb 23 16:24:57 volumio-fn systemd[1]: Started Apply Kernel Variables. Feb 23 16:24:57 volumio-fn systemd[1]: Started Load/Save Random Seed. Feb 23 16:24:57 volumio-fn systemd[1]: Started Create System Users. Feb 23 16:24:57 volumio-fn systemd[1]: Starting Create Static Device Nodes in /dev... Feb 23 16:24:57 volumio-fn systemd[1]: dynamicswap.service: Succeeded. Feb 23 16:24:57 volumio-fn systemd[1]: Started Create Static Device Nodes in /dev. Feb 23 16:24:57 volumio-fn systemd[1]: Starting udev Kernel Device Manager... Feb 23 16:24:57 volumio-fn systemd[1]: Reached target Local File Systems (Pre). Feb 23 16:24:57 volumio-fn systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Feb 23 16:24:57 volumio-fn systemd[1]: Mounting /var/log... Feb 23 16:24:57 volumio-fn systemd[1]: Mounting /var/spool/cups... Feb 23 16:24:57 volumio-fn systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Feb 23 16:24:57 volumio-fn systemd[1]: Mounting /tmp... Feb 23 16:24:57 volumio-fn systemd[1]: Mounted RPC Pipe File System. Feb 23 16:24:57 volumio-fn systemd[1]: Started udev Coldplug all Devices. Feb 23 16:24:57 volumio-fn systemd[1]: Mounted /var/log. Feb 23 16:24:57 volumio-fn kernel: RPC: Registered named UNIX socket transport module. Feb 23 16:24:57 volumio-fn kernel: RPC: Registered udp transport module. Feb 23 16:24:57 volumio-fn kernel: RPC: Registered tcp transport module. Feb 23 16:24:57 volumio-fn kernel: RPC: Registered tcp-with-tls transport module. Feb 23 16:24:57 volumio-fn kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Feb 23 16:24:57 volumio-fn systemd[1]: Mounted /var/spool/cups. Feb 23 16:24:57 volumio-fn systemd[1]: Mounted /tmp. Feb 23 16:24:57 volumio-fn systemd[1]: Mounting /var/spool/cups/tmp... Feb 23 16:24:57 volumio-fn systemd[1]: Starting Flush Journal to Persistent Storage... Feb 23 16:24:57 volumio-fn systemd[1]: Starting Helper to synchronize boot up for ifupdown... Feb 23 16:24:57 volumio-fn systemd[1]: Mounted /var/spool/cups/tmp. Feb 23 16:24:57 volumio-fn systemd-udevd[490]: Network interface NamePolicy= disabled on kernel command line, ignoring. Feb 23 16:24:57 volumio-fn systemd[1]: Started Helper to synchronize boot up for ifupdown. Feb 23 16:24:57 volumio-fn systemd-journald[465]: Runtime journal (/run/log/journal/724bcbf01eebf9d6210f389b672e577a) is 3.7M, max 30.0M, 26.2M free. Feb 23 16:24:57 volumio-fn systemd[1]: Started Flush Journal to Persistent Storage. Feb 23 16:24:57 volumio-fn systemd[1]: Started udev Kernel Device Manager. Feb 23 16:24:57 volumio-fn systemd[1]: Starting Show Plymouth Boot Screen... Feb 23 16:24:57 volumio-fn systemd[1]: plymouth-start.service: Succeeded. Feb 23 16:24:57 volumio-fn systemd[1]: Started Show Plymouth Boot Screen. Feb 23 16:24:57 volumio-fn systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Feb 23 16:24:57 volumio-fn systemd[1]: Reached target Local Encrypted Volumes. Feb 23 16:24:57 volumio-fn systemd[1]: Reached target Paths. Feb 23 16:24:57 volumio-fn systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Feb 23 16:24:57 volumio-fn kernel: pstore: Using crash dump compression: deflate Feb 23 16:24:57 volumio-fn kernel: pstore: Registered efi_pstore as persistent store backend Feb 23 16:24:57 volumio-fn systemd-udevd[500]: Using default interface naming scheme 'v240'. Feb 23 16:24:57 volumio-fn systemd-udevd[529]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 23 16:24:57 volumio-fn systemd-udevd[500]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 23 16:24:57 volumio-fn kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Feb 23 16:24:57 volumio-fn kernel: sd 2:0:0:0: Attached scsi generic sg0 type 0 Feb 23 16:24:57 volumio-fn kernel: cryptd: max_cpu_qlen set to 1000 Feb 23 16:24:57 volumio-fn kernel: AVX2 version of gcm_enc/dec engaged. Feb 23 16:24:57 volumio-fn kernel: AES CTR mode by8 optimization enabled Feb 23 16:24:57 volumio-fn systemd-udevd[526]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 16:24:57 volumio-fn systemd-udevd[530]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 16:24:57 volumio-fn systemd-udevd[502]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 16:24:57 volumio-fn systemd-udevd[505]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 16:24:57 volumio-fn systemd-udevd[521]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 16:24:57 volumio-fn systemd-udevd[528]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 16:24:57 volumio-fn systemd-udevd[519]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 16:24:58 volumio-fn systemd[1]: Found device QEMU_HARDDISK boot. Feb 23 16:24:58 volumio-fn systemd[1]: Condition check resulted in 82540EM Gigabit Ethernet Controller (QEMU Virtual Machine) being skipped. Feb 23 16:24:58 volumio-fn systemd[1]: Starting File System Check on /dev/disk/by-uuid/8264-17E7... Feb 23 16:24:58 volumio-fn systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Feb 23 16:24:58 volumio-fn systemd[1]: Started File System Check Daemon to report status. Feb 23 16:24:58 volumio-fn systemd-fsck[603]: fsck.fat 4.1 (2017-01-24) Feb 23 16:24:58 volumio-fn systemd-fsck[603]: 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Feb 23 16:24:58 volumio-fn systemd-fsck[603]: Automatically removing dirty bit. Feb 23 16:24:58 volumio-fn systemd-fsck[603]: There are differences between boot sector and its backup. Feb 23 16:24:58 volumio-fn systemd-fsck[603]: This is mostly harmless. Differences: (offset:original/backup) Feb 23 16:24:58 volumio-fn systemd-fsck[603]: 3:53/6d, 4:59/6b, 5:53/66, 6:4c/73, 7:49/2e, 8:4e/66, 9:55/61, 10:58/74 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 90:fa/0e, 91:fc/1f, 92:31/be, 93:c9/77, 94:8e/7c, 95:d1/ac, 96:bc/22 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 97:76/c0, 98:7b/74, 99:52/0b, 100:06/56, 101:57/b4, 102:1e/0e, 103:56/bb Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 104:8e/07, 105:c1/00, 106:b1/cd, 107:26/10, 108:bf/5e, 109:78/eb Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 110:7b/f0, 111:f3/32, 112:a5/e4, 113:8e/cd, 114:d9/16, 115:bb/cd Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 116:78/19, 117:00/eb, 118:0f/fe, 119:b4/54, 120:37/68, 121:0f/69 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 122:a0/73, 123:56/20, 124:20/69, 125:d2/73, 126:78/20, 127:1b/6e Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 128:31/6f, 129:c0/74, 130:b1/20, 131:06/61, 132:89/20, 133:3f/62 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 134:89/6f, 135:47/6f, 136:02/74, 137:f3/61, 138:64/62, 139:a5/6c Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 140:8a/65, 141:0e/20, 142:18/64, 143:7c/69, 144:88/73, 145:4d/6b Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 146:f8/2e, 147:50/20, 148:50/20, 150:50/6c, 151:cd/65, 152:13/61 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 153:eb/73, 154:62/65, 155:8b/20, 156:55/69, 157:aa/6e, 158:8b/73 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 159:75/65, 160:a8/72, 161:c1/74, 162:ee/20, 163:04/61, 164:01/20 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 165:f2/62, 166:83/6f, 167:fa/6f, 168:4f/74, 169:76/61, 170:31/62 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 171:81/6c, 172:fa/65, 173:b2/20, 174:07/66, 175:73/6c, 176:2b/6f Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 177:f6/70, 178:45/70, 179:b4/79, 180:7f/20, 181:75/61, 182:25/6e Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 183:38/64, 184:4d/0d, 185:b8/0a, 186:74/70, 187:20/72, 188:66/65 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 189:3d/73, 190:21/73, 191:47/20, 192:50/61, 193:54/6e, 194:75/79 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 195:10/20, 196:80/6b, 197:7d/65, 198:b8/79, 199:ed/20, 200:75/74 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 201:0a/6f, 202:66/20, 203:ff/74, 204:75/72, 205:ec/79, 206:66/20 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 207:ff/61, 208:75/67, 209:e8/61, 210:eb/69, 211:0f/6e, 212:51/20 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 213:51/2e, 214:66/2e, 215:ff/2e, 216:75/20, 217:bc/0d, 218:eb/0a Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 219:07/00, 220:51/00, 221:51/00, 222:66/00, 223:ff/00, 224:36/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 225:1c/00, 226:7c/00, 227:b4/00, 228:08/00, 229:e8/00, 230:e9/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 232:72/00, 233:13/00, 234:20/00, 235:e4/00, 236:75/00, 237:0f/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 238:c1/00, 239:ea/00, 240:08/00, 241:42/00, 242:89/00, 243:16/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 244:1a/00, 245:7c/00, 246:83/00, 247:e1/00, 248:3f/00, 249:89/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 250:0e/00, 251:18/00, 252:7c/00, 253:fb/00, 254:bb/00, 255:aa/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 256:55/00, 257:b4/00, 258:41/00, 259:e8/00, 260:cb/00, 262:72/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 263:10/00, 264:81/00, 265:fb/00, 266:55/00, 267:aa/00, 268:75/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 269:0a/00, 270:f6/00, 271:c1/00, 272:01/00, 273:74/00, 274:05/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 275:c6/00, 276:06/00, 277:46/00, 278:7d/00, 280:66/00, 281:b8/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 282:2d/00, 283:15/00, 286:66/00, 287:ba/00, 292:bb/00, 294:80/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 295:e8/00, 296:0e/00, 298:66/00, 299:81/00, 300:3e/00, 301:1c/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 302:80/00, 303:d5/00, 304:cf/00, 305:c7/00, 306:62/00, 307:75/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 308:74/00, 309:e9/00, 310:f8/00, 311:02/00, 312:66/00, 313:03/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 314:06/00, 315:60/00, 316:7b/00, 317:66/00, 318:13/00, 319:16/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 320:64/00, 321:7b/00, 322:b9/00, 323:10/00, 325:eb/00, 326:2b/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 327:66/00, 328:52/00, 329:66/00, 330:50/00, 331:06/00, 332:53/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 333:6a/00, 334:01/00, 335:6a/00, 336:10/00, 337:89/00, 338:e6/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 339:66/00, 340:60/00, 341:b4/00, 342:42/00, 343:e8/00, 344:77/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 346:66/00, 347:61/00, 348:8d/00, 349:64/00, 350:10/00, 351:72/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 352:01/00, 353:c3/00, 354:66/00, 355:60/00, 356:31/00, 357:c0/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 358:e8/00, 359:68/00, 361:66/00, 362:61/00, 363:e2/00, 364:da/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 365:c6/00, 366:06/00, 367:46/00, 368:7d/00, 369:2b/00, 370:66/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 371:60/00, 372:66/00, 373:0f/00, 374:b7/00, 375:36/00, 376:18/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 377:7c/00, 378:66/00, 379:0f/00, 380:b7/00, 381:3e/00, 382:1a/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 383:7c/00, 384:66/00, 385:f7/00, 386:f6/00, 387:31/00, 388:c9/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 389:87/00, 390:ca/00, 391:66/00, 392:f7/00, 393:f7/00, 394:66/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 395:3d/00, 396:ff/00, 397:03/00, 400:77/00, 401:17/00, 402:c0/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 403:e4/00, 404:06/00, 405:41/00, 406:08/00, 407:e1/00, 408:88/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 409:c5/00, 410:88/00, 411:d6/00, 412:b8/00, 413:01/00, 414:02/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 415:e8/00, 416:2f/00, 418:66/00, 419:61/00, 420:72/00, 421:01/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 422:c3/00, 423:e2/00, 424:c9/00, 425:31/00, 426:f6/00, 427:8e/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 428:d6/00, 429:bc/00, 430:68/00, 431:7b/00, 432:8e/00, 433:de/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 434:66/00, 435:8f/00, 436:06/00, 437:78/00, 439:be/00, 440:da/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 441:7d/00, 442:ac/00, 443:20/00, 444:c0/00, 445:74/00, 446:09/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 447:b4/00, 448:0e/00, 449:bb/00, 450:07/00, 452:cd/00, 453:10/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 454:eb/00, 455:f2/00, 456:31/00, 457:c0/00, 458:cd/00, 459:16/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 460:cd/00, 461:19/00, 462:f4/00, 463:eb/00, 464:fd/00, 465:8a/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 466:16/00, 467:74/00, 468:7b/00, 469:06/00, 470:cd/00, 471:13/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 472:07/00, 473:c3/00, 474:42/00, 475:6f/00, 476:6f/00, 477:74/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 478:20/00, 479:65/00, 480:72/00, 481:72/00, 482:6f/00, 483:72/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 484:0d/00, 485:0a/00, 504:fe/00, 505:02/00, 506:b2/00, 507:3e/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: , 508:18/00, 509:37/00 Feb 23 16:24:58 volumio-fn systemd-fsck[603]: Not automatically fixing this. Feb 23 16:24:58 volumio-fn systemd-fsck[603]: Performing changes. Feb 23 16:24:58 volumio-fn systemd-fsck[603]: /dev/sda1: 19 files, 159615/344788 clusters Feb 23 16:24:58 volumio-fn systemd[1]: Started File System Check on /dev/disk/by-uuid/8264-17E7. Feb 23 16:24:58 volumio-fn systemd-udevd[503]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 16:24:58 volumio-fn systemd[1]: Mounting /boot... Feb 23 16:24:58 volumio-fn kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Feb 23 16:24:58 volumio-fn systemd[1]: Mounted /boot. Feb 23 16:24:58 volumio-fn systemd[1]: Reached target Local File Systems. Feb 23 16:24:58 volumio-fn systemd[1]: Starting Create Volatile Files and Directories... Feb 23 16:24:58 volumio-fn systemd[1]: Started ifup for eth0. Feb 23 16:24:58 volumio-fn systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Feb 23 16:24:58 volumio-fn systemd[1]: Starting Preprocess NFS configuration... Feb 23 16:24:58 volumio-fn systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Feb 23 16:24:58 volumio-fn systemd[1]: Starting Raise network interfaces... Feb 23 16:24:58 volumio-fn systemd[1]: nfs-config.service: Succeeded. Feb 23 16:24:58 volumio-fn systemd[1]: Started Preprocess NFS configuration. Feb 23 16:24:58 volumio-fn systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Feb 23 16:24:58 volumio-fn systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Feb 23 16:24:58 volumio-fn systemd[1]: Reached target NFS client services. Feb 23 16:24:58 volumio-fn systemd[1]: Received SIGRTMIN+20 from PID 355 (plymouthd). Feb 23 16:24:58 volumio-fn systemd[1]: plymouth-read-write.service: Succeeded. Feb 23 16:24:58 volumio-fn systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Feb 23 16:24:58 volumio-fn systemd[1]: Started Create Volatile Files and Directories. Feb 23 16:24:58 volumio-fn systemd[1]: Starting RPC bind portmap service... Feb 23 16:24:58 volumio-fn systemd[1]: Starting Update UTMP about System Boot/Shutdown... Feb 23 16:24:58 volumio-fn systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Feb 23 16:24:58 volumio-fn systemd[1]: Started Update UTMP about System Boot/Shutdown. Feb 23 16:24:58 volumio-fn systemd[1]: Reached target System Initialization. Feb 23 16:24:58 volumio-fn systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Feb 23 16:24:58 volumio-fn systemd[1]: Listening on D-Bus System Message Bus Socket. Feb 23 16:24:58 volumio-fn systemd[1]: Started Daily apt download activities. Feb 23 16:24:58 volumio-fn systemd[1]: Started Daily apt upgrade and clean activities. Feb 23 16:24:58 volumio-fn systemd[1]: Started Daily Cleanup of Temporary Directories. Feb 23 16:24:58 volumio-fn systemd[1]: Listening on triggerhappy.socket. Feb 23 16:24:58 volumio-fn systemd[1]: Reached target Sockets. Feb 23 16:24:58 volumio-fn systemd[1]: Reached target Basic System. Feb 23 16:24:58 volumio-fn systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Feb 23 16:24:58 volumio-fn systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Feb 23 16:24:58 volumio-fn systemd[1]: Starting Volumio Time Update Utility... Feb 23 16:24:58 volumio-fn systemd[1]: Started Volumio Iptables Module. Feb 23 16:24:58 volumio-fn systemd[1]: Started D-Bus System Message Bus. Feb 23 16:24:58 volumio-fn systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Feb 23 16:24:58 volumio-fn systemd[1]: Started UPnP Renderer front-end to MPD. Feb 23 16:24:58 volumio-fn systemd[1]: Starting WPA supplicant... Feb 23 16:24:58 volumio-fn systemd[1]: Starting Wireless Services... Feb 23 16:24:58 volumio-fn systemd[1]: Started MPD Monitor Service. Feb 23 16:24:58 volumio-fn systemd[1]: Starting Login Service... Feb 23 16:24:58 volumio-fn systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Feb 23 16:24:58 volumio-fn systemd[1]: Starting DHCP Client Daemon... Feb 23 16:24:58 volumio-fn systemd[1]: Starting triggerhappy global hotkey daemon... Feb 23 16:24:58 volumio-fn systemd[1]: Started Daily man-db regeneration. Feb 23 16:24:58 volumio-fn systemd[1]: Reached target Timers. Feb 23 16:24:58 volumio-fn kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Feb 23 16:24:58 volumio-fn systemd[1]: Started volumio-remote-updater.service. Feb 23 16:24:58 volumio-fn volumio-time-update[634]: volumio-time-update-util: Fetching time from Volumio... Feb 23 16:24:58 volumio-fn systemd[1]: Started Volumio Log Rotation Service. Feb 23 16:24:58 volumio-fn systemd[1]: Starting Daily man-db regeneration... Feb 23 16:24:58 volumio-fn kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Feb 23 16:24:58 volumio-fn kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Feb 23 16:24:58 volumio-fn thd[643]: Unable to parse trigger line: Feb 23 16:24:58 volumio-fn thd[643]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Feb 23 16:24:58 volumio-fn thd[643]: Unable to parse trigger line: Feb 23 16:24:58 volumio-fn thd[643]: Unable to parse trigger line: Feb 23 16:24:58 volumio-fn thd[643]: Found socket passed from systemd Feb 23 16:24:58 volumio-fn systemd-logind[641]: New seat seat0. Feb 23 16:24:58 volumio-fn systemd-logind[641]: Watching system buttons on /dev/input/event0 (Power Button) Feb 23 16:24:58 volumio-fn systemd-logind[641]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Feb 23 16:24:58 volumio-fn sh[609]: command failed: No such device (-19) Feb 23 16:24:58 volumio-fn ifup[612]: command failed: No such device (-19) Feb 23 16:24:58 volumio-fn avahi-daemon[633]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Feb 23 16:24:58 volumio-fn avahi-daemon[633]: Successfully dropped root privileges. Feb 23 16:24:58 volumio-fn avahi-daemon[633]: avahi-daemon 0.7 starting up. Feb 23 16:24:58 volumio-fn mpd_monitor.sh[640]: MPD error: Connection refused Feb 23 16:24:58 volumio-fn kernel: 8021q: 802.1Q VLAN Support v1.8 Feb 23 16:24:58 volumio-fn mpd_monitor.sh[640]: mpd: no process found Feb 23 16:24:58 volumio-fn sh[609]: sending commands to master dhcpcd process Feb 23 16:24:58 volumio-fn dhcpcd[699]: sending commands to master dhcpcd process Feb 23 16:24:58 volumio-fn haveged[632]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K Feb 23 16:24:58 volumio-fn haveged[632]: haveged: cpu: (L4 VC); data: 32K (L2 L4 V); inst: 32K (L2 L4 V); idx: 24/40; sz: 31410/52825 Feb 23 16:24:58 volumio-fn haveged[632]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00119 Feb 23 16:24:58 volumio-fn haveged[632]: haveged: fills: 0, generated: 0 Feb 23 16:24:58 volumio-fn ifup[612]: command failed: No such device (-19) Feb 23 16:24:58 volumio-fn systemd[1]: Started Login Service. Feb 23 16:24:58 volumio-fn wpa_supplicant[638]: Successfully initialized wpa_supplicant Feb 23 16:24:58 volumio-fn systemd[1]: Started triggerhappy global hotkey daemon. Feb 23 16:24:58 volumio-fn avahi-daemon[633]: Successfully called chroot(). Feb 23 16:24:58 volumio-fn systemd[1]: Started RPC bind portmap service. Feb 23 16:24:58 volumio-fn avahi-daemon[633]: Successfully dropped remaining capabilities. Feb 23 16:24:58 volumio-fn avahi-daemon[633]: Loading service file /services/volumio.service. Feb 23 16:24:58 volumio-fn systemd[1]: Started WPA supplicant. Feb 23 16:24:58 volumio-fn systemd[1]: Started Avahi mDNS/DNS-SD Stack. Feb 23 16:24:58 volumio-fn avahi-daemon[633]: Network interface enumeration completed. Feb 23 16:24:58 volumio-fn sh[609]: eth0=eth0 Feb 23 16:24:58 volumio-fn systemd[1]: Listening on mpd.socket. Feb 23 16:24:58 volumio-fn avahi-daemon[633]: Server startup complete. Host name is volumio-fn.local. Local service cookie is 450471332. Feb 23 16:24:58 volumio-fn systemd[1]: Reached target Remote File Systems (Pre). Feb 23 16:24:58 volumio-fn avahi-daemon[633]: Service "Volumio-FN" (/services/volumio.service) successfully established. Feb 23 16:24:58 volumio-fn systemd[1]: Reached target Remote File Systems. Feb 23 16:24:58 volumio-fn systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Feb 23 16:24:58 volumio-fn systemd[1]: Reached target RPC Port Mapper. Feb 23 16:24:58 volumio-fn systemd[1]: iptables.service: Succeeded. Feb 23 16:24:58 volumio-fn systemd[1]: Started Raise network interfaces. Feb 23 16:24:58 volumio-fn systemd[1]: Reached target Network. Feb 23 16:24:58 volumio-fn systemd[1]: Starting Music Player Daemon... Feb 23 16:24:58 volumio-fn systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Feb 23 16:24:58 volumio-fn systemd[1]: Starting Permit User Sessions... Feb 23 16:24:58 volumio-fn systemd[1]: Starting Network Time Service... Feb 23 16:24:58 volumio-fn systemd[1]: Reached target Network is Online. Feb 23 16:24:58 volumio-fn systemd[1]: Starting Daily apt download activities... Feb 23 16:24:58 volumio-fn dhcpcd[642]: no interfaces have a carrier Feb 23 16:24:58 volumio-fn dhcpcd[642]: forked to background, child pid 786 Feb 23 16:24:58 volumio-fn dhcpcd[642]: no interfaces have a carrier Feb 23 16:24:58 volumio-fn dhcpcd[642]: forked to background, child pid 786 Feb 23 16:24:58 volumio-fn systemd[1]: Starting Samba NMB Daemon... Feb 23 16:24:58 volumio-fn kernel: 8021q: adding VLAN 0 to HW filter on device eth0 Feb 23 16:24:58 volumio-fn systemd[1]: Starting /etc/rc.local Compatibility... Feb 23 16:24:58 volumio-fn systemd[1]: Starting LSB: Brings up/down network automatically... Feb 23 16:24:58 volumio-fn systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 16:24:58 volumio-fn dhcpcd[786]: eth0: waiting for carrier Feb 23 16:24:58 volumio-fn dhcpcd[786]: control command: /sbin/dhcpcd eth0 Feb 23 16:24:58 volumio-fn dhcpcd[786]: eth0: carrier acquired Feb 23 16:24:58 volumio-fn systemd[1]: Started DHCP Client Daemon. Feb 23 16:24:58 volumio-fn kernel: e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX Feb 23 16:24:58 volumio-fn dhcpcd[786]: DUID 00:04:9f:5b:be:7f:da:f8:49:b9:9d:4b:55:71:28:aa:04:60 Feb 23 16:24:58 volumio-fn dhcpcd[786]: eth0: IAID 7e:fe:29:12 Feb 23 16:24:58 volumio-fn dhcpcd[786]: eth0: adding address fe80::67c4:36b4:84c7:a29a Feb 23 16:24:58 volumio-fn dhcpcd[786]: ipv6_addaddr1: Permission denied Feb 23 16:24:58 volumio-fn systemd[1]: Started /etc/rc.local Compatibility. Feb 23 16:24:58 volumio-fn volumio-remote-updater[645]: Error: No active session Feb 23 16:24:58 volumio-fn volumio-remote-updater[645]: [2025-02-23 16:24:58] [info] asio async_connect error: system:111 (Connection refused) Feb 23 16:24:58 volumio-fn volumio-remote-updater[645]: [2025-02-23 16:24:58] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 23 16:24:58 volumio-fn volumio-remote-updater[645]: [2025-02-23 16:24:58] [error] handle_connect error: Underlying Transport Error Feb 23 16:24:58 volumio-fn systemd[1]: Started Permit User Sessions. Feb 23 16:24:58 volumio-fn systemd[1]: Starting Hold until boot process finishes up... Feb 23 16:24:58 volumio-fn volumio[637]: Could not open config: /tmp/upmpdcli.conf Feb 23 16:24:58 volumio-fn dhcpcd[786]: eth0: soliciting an IPv6 router Feb 23 16:24:58 volumio-fn systemd[1]: Starting Terminate Plymouth Boot Screen... Feb 23 16:24:58 volumio-fn volumio-time-update[634]: volumio-time-update-util: Date not found in response Feb 23 16:24:58 volumio-fn volumio-time-update[634]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 16:24:58 volumio-fn systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 23 16:24:58 volumio-fn systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 23 16:24:58 volumio-fn systemd[1]: plymouth-quit-wait.service: Succeeded. Feb 23 16:24:58 volumio-fn systemd[1]: Started Hold until boot process finishes up. Feb 23 16:24:58 volumio-fn systemd[1]: plymouth-quit.service: Succeeded. Feb 23 16:24:58 volumio-fn systemd[1]: Started Terminate Plymouth Boot Screen. Feb 23 16:24:58 volumio-fn systemd[1]: Received SIGRTMIN+21 from PID 355 (n/a). Feb 23 16:24:58 volumio-fn systemd[1]: Received SIGRTMIN+21 from PID 355 (n/a). Feb 23 16:24:58 volumio-fn systemd[1]: Started Getty on tty1. Feb 23 16:24:58 volumio-fn systemd[1]: Reached target Login Prompts. Feb 23 16:24:58 volumio-fn ifplugd(eth0)[827]: ifplugd 0.28 initializing. Feb 23 16:24:58 volumio-fn ifplugd(eth0)[827]: Using interface eth0/22:31:7E:FE:29:12 with driver (version: 6.6.32-volumio) Feb 23 16:24:58 volumio-fn ifplugd(eth0)[827]: Using detection mode: SIOCETHTOOL Feb 23 16:24:58 volumio-fn ifplugd(eth0)[827]: Initialization complete, link beat detected. Feb 23 16:24:58 volumio-fn systemd[1]: man-db.service: Succeeded. Feb 23 16:24:58 volumio-fn systemd[1]: Started Daily man-db regeneration. Feb 23 16:24:58 volumio-fn loadcpufreq[756]: Loading cpufreq kernel modules...failed. Feb 23 16:24:58 volumio-fn systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Feb 23 16:24:58 volumio-fn ntpd[783]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 23 16:24:58 volumio-fn ntpd[783]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Feb 23 16:24:58 volumio-fn systemd[1]: Starting LSB: set CPUFreq kernel parameters... Feb 23 16:24:58 volumio-fn ntpd[853]: proto: precision = 0.050 usec (-24) Feb 23 16:24:58 volumio-fn systemd[1]: Started Network Time Service. Feb 23 16:24:58 volumio-fn ntpd[853]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 23 16:24:58 volumio-fn ntpd[853]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 23 16:24:58 volumio-fn ntpd[853]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 789 days ago Feb 23 16:24:58 volumio-fn ntpd[853]: Listen and drop on 0 v6wildcard [::]:123 Feb 23 16:24:58 volumio-fn ntpd[853]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 23 16:24:58 volumio-fn ntpd[853]: Listen normally on 2 lo 127.0.0.1:123 Feb 23 16:24:58 volumio-fn ntpd[853]: Listening on routing socket on fd #19 for interface updates Feb 23 16:24:58 volumio-fn ntpd[853]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 23 16:24:58 volumio-fn ntpd[853]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 23 16:24:58 volumio-fn ifplugd(eth0)[827]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Feb 23 16:24:58 volumio-fn cpufrequtils[852]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Feb 23 16:24:58 volumio-fn systemd[1]: Started LSB: set CPUFreq kernel parameters. Feb 23 16:24:59 volumio-fn ifplugd(eth0)[827]: client: ifup: interface eth0 already configured Feb 23 16:24:59 volumio-fn sudo[779]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 16:24:59 volumio-fn sudo[779]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:24:59 volumio-fn sudo[779]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 23 16:24:59 volumio-fn sudo[779]: pam_unix(sudo:session): session closed for user root Feb 23 16:24:59 volumio-fn ifplugd(eth0)[827]: Program executed successfully. Feb 23 16:24:59 volumio-fn ifplugd[789]: Network Interface Plugging Daemon...start eth0...done. Feb 23 16:24:59 volumio-fn systemd[1]: Started LSB: Brings up/down network automatically. Feb 23 16:24:59 volumio-fn systemd[1]: apt-daily.service: Succeeded. Feb 23 16:24:59 volumio-fn systemd[1]: Started Daily apt download activities. Feb 23 16:24:59 volumio-fn wireless.js[639]: WIRELESS: No wireless interface, exiting Feb 23 16:24:59 volumio-fn nmbd[793]: [2025/02/23 16:24:59.491709, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Feb 23 16:24:59 volumio-fn nmbd[793]: started asyncdns process 940 Feb 23 16:24:59 volumio-fn nmbd[793]: [2025/02/23 16:24:59.492251, 0] ../lib/util/become_daemon.c:149(daemon_status) Feb 23 16:24:59 volumio-fn systemd[1]: Starting Daily apt upgrade and clean activities... Feb 23 16:24:59 volumio-fn nmbd[793]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Feb 23 16:24:59 volumio-fn nmbd[793]: [2025/02/23 16:24:59.492280, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Feb 23 16:24:59 volumio-fn nmbd[793]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Feb 23 16:24:59 volumio-fn dhcpcd[786]: eth0: rebinding lease of 192.168.3.27 Feb 23 16:24:59 volumio-fn iw[941]: command failed: No such device (-19) Feb 23 16:24:59 volumio-fn iwconfig[945]: Error for wireless request "Set Power Management" (8B2C) : Feb 23 16:24:59 volumio-fn iwconfig[945]: SET failed on device wlan0 ; No such device. Feb 23 16:24:59 volumio-fn systemd[1]: wireless.service: Succeeded. Feb 23 16:24:59 volumio-fn systemd[1]: Started Wireless Services. Feb 23 16:24:59 volumio-fn systemd[1]: Started Volumio Backend Module. Feb 23 16:24:59 volumio-fn systemd[1]: Started Volumio Cpu Tweaker. Feb 23 16:24:59 volumio-fn systemd[1]: Started Intel SST and HDA soundcard init service. Feb 23 16:24:59 volumio-fn systemd[1]: Started Start Volumio Kiosk. Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: Setting RT Priority for mpd Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: Setting MPD Affinity Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: pid 879's current affinity mask: f Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: pid 879's new affinity mask: 3 Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: Error setting new values. Common errors: Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: - Do you have proper administration rights? (super-user?) Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: - Is the governor you requested available and modprobed? Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: - Trying to set an invalid policy? Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: - Trying to set a specific frequency, but userspace governor is not available, Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: for example because of hardware which cannot be set to a specific frequency Feb 23 16:24:59 volumio-fn volumio-cpu-tweak[951]: or because the userspace governor isn't loaded? Feb 23 16:24:59 volumio-fn systemd[1]: volumio_cpu_tweak.service: Succeeded. Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: aplay: device_list:272: no soundcards found... Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: cat: '/sys/class/sound/card*/number': No such file or directory Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: Invalid card number. Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: cat: /proc/asound/cards: No such file or directory Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: cat: '/sys/class/sound/card*/number': No such file or directory Feb 23 16:24:59 volumio-fn soundcard-init.sh[952]: cat: '/sys/class/sound/card*/id': No such file or directory Feb 23 16:24:59 volumio-fn systemd[1]: soundcard-init.service: Succeeded. Feb 23 16:24:59 volumio-fn startx[954]: X.Org X Server 1.20.4 Feb 23 16:24:59 volumio-fn startx[954]: X Protocol Version 11, Revision 0 Feb 23 16:24:59 volumio-fn startx[954]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Feb 23 16:24:59 volumio-fn startx[954]: Current Operating System: Linux volumio-fn 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Feb 23 16:24:59 volumio-fn startx[954]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=5b01fac8-abe8-45a5-a96b-067ed7a68d96 bootpart=UUID=8264-17E7 datapart=UUID=109d31d2-2200-4050-b7ca-cc337f8045fa 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 Feb 23 16:24:59 volumio-fn startx[954]: Build Date: 18 December 2021 09:05:36AM Feb 23 16:24:59 volumio-fn startx[954]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Feb 23 16:24:59 volumio-fn startx[954]: Current version of pixman: 0.36.0 Feb 23 16:24:59 volumio-fn startx[954]: Before reporting problems, check http://wiki.x.org Feb 23 16:24:59 volumio-fn startx[954]: to make sure that you have the latest version. Feb 23 16:24:59 volumio-fn startx[954]: Markers: (--) probed, (**) from config file, (==) default setting, Feb 23 16:24:59 volumio-fn startx[954]: (++) from command line, (!!) notice, (II) informational, Feb 23 16:24:59 volumio-fn startx[954]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Feb 23 16:24:59 volumio-fn startx[954]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Feb 23 16:24:59 2025 Feb 23 16:24:59 volumio-fn startx[954]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Feb 23 16:24:59 volumio-fn systemd[1]: apt-daily-upgrade.service: Succeeded. Feb 23 16:24:59 volumio-fn systemd[1]: Started Daily apt upgrade and clean activities. Feb 23 16:24:59 volumio-fn startx[954]: pci id for fd 14: 1234:1111, driver (null) Feb 23 16:24:59 volumio-fn ntpd[853]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Feb 23 16:25:00 volumio-fn mpd[879]: Feb 23 16:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 23 16:25:00 volumio-fn kernel: broken atomic modeset userspace detected, disabling atomic Feb 23 16:25:00 volumio-fn startx[954]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Feb 23 16:25:00 volumio-fn systemd[1]: Started Music Player Daemon. Feb 23 16:25:00 volumio-fn mpd_monitor.sh[640]: MPD restarted due to no mpc output. Feb 23 16:25:00 volumio-fn volumio[950]: info: ------------------------------------------- Feb 23 16:25:00 volumio-fn volumio[950]: info: ----- Volumio3 ---- Feb 23 16:25:00 volumio-fn volumio[950]: info: ------------------------------------------- Feb 23 16:25:00 volumio-fn volumio[950]: info: ----- System startup ---- Feb 23 16:25:00 volumio-fn volumio[950]: info: ------------------------------------------- Feb 23 16:25:00 volumio-fn ntpd[853]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Feb 23 16:25:01 volumio-fn volumio[950]: info: MYVOLUMIO Environment detected Feb 23 16:25:01 volumio-fn volumio[950]: info: Plugin folders cleanup Feb 23 16:25:01 volumio-fn volumio[950]: info: Scanning into folder /volumio/app/plugins/ Feb 23 16:25:01 volumio-fn volumio[950]: info: Scanning category audio_interface Feb 23 16:25:01 volumio-fn volumio[950]: info: Scanning category miscellanea Feb 23 16:25:01 volumio-fn volumio[950]: info: Scanning category music_service Feb 23 16:25:01 volumio-fn volumio[950]: info: Scanning category plugins.json Feb 23 16:25:01 volumio-fn volumio[950]: info: Scanning category system_controller Feb 23 16:25:01 volumio-fn volumio[950]: info: Scanning category user_interface Feb 23 16:25:01 volumio-fn volumio[950]: info: Scanning into folder /data/plugins/ Feb 23 16:25:01 volumio-fn volumio[950]: info: Plugin folders cleanup completed Feb 23 16:25:01 volumio-fn volumio[950]: info: ------------------------------------------- Feb 23 16:25:01 volumio-fn volumio[950]: info: ----- Core plugins startup ---- Feb 23 16:25:01 volumio-fn volumio[950]: info: ------------------------------------------- Feb 23 16:25:01 volumio-fn volumio[950]: info: Loading plugins from folder /volumio/app/plugins/ Feb 23 16:25:01 volumio-fn volumio[950]: info: Adding plugin upnp to MyMusic Plugins Feb 23 16:25:01 volumio-fn volumio[950]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 23 16:25:01 volumio-fn volumio[950]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 23 16:25:01 volumio-fn volumio[950]: info: Loading plugins from folder /data/plugins/ Feb 23 16:25:01 volumio-fn volumio[950]: info: Loading plugin "system"... Feb 23 16:25:01 volumio-fn volumio[950]: info: Loading plugin "appearance"... Feb 23 16:25:01 volumio-fn ntpd[853]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 23 16:25:02 volumio-fn volumio[950]: info: Loading plugin "network"... Feb 23 16:25:02 volumio-fn volumio[950]: info: Refreshing Cached IP Addresses Feb 23 16:25:02 volumio-fn sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 16:25:02 volumio-fn sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:02 volumio-fn sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 16:25:02 volumio-fn sudo[1212]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:02 volumio-fn sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:02 volumio-fn volumio[950]: info: Loading plugin "services"... Feb 23 16:25:02 volumio-fn sudo[1223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 23 16:25:02 volumio-fn sudo[1223]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:02 volumio-fn volumio[950]: info: Loading plugin "alsa_controller"... Feb 23 16:25:02 volumio-fn sudo[1223]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:02 volumio-fn sudo[1214]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:02 volumio-fn volumio[950]: aplay: device_list:272: no soundcards found... Feb 23 16:25:02 volumio-fn volumio[950]: warn: Unable to locate the audio output device DAC Audio. Please configure a valid output device. Feb 23 16:25:02 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 16:25:02 volumio-fn volumio[950]: info: Loading plugin "wizard"... Feb 23 16:25:02 volumio-fn volumio[950]: info: Loading plugin "networkfs"... Feb 23 16:25:02 volumio-fn volumio[950]: info: Starting Udev Watcher for removable devices Feb 23 16:25:02 volumio-fn volumio[950]: info: Ignoring mount for partition: boot Feb 23 16:25:02 volumio-fn volumio[950]: info: Ignoring mount for partition: volumio Feb 23 16:25:02 volumio-fn volumio[950]: info: Ignoring mount for partition: volumio_data Feb 23 16:25:02 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 16:25:02 volumio-fn volumio[950]: info: Loading plugin "volumio_command_line_client"... Feb 23 16:25:02 volumio-fn sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=xkxiaoli,password=Stone198568,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.68/music /mnt/NAS/feiniu Feb 23 16:25:02 volumio-fn sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:02 volumio-fn volumio[950]: info: Loading plugin "upnp"... Feb 23 16:25:02 volumio-fn volumio[950]: info: [1740327902717] Starting Upmpd Daemon Feb 23 16:25:02 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 16:25:02 volumio-fn volumio[950]: info: Loading plugin "my_music"... Feb 23 16:25:02 volumio-fn volumio[950]: info: Loading plugin "mpd"... Feb 23 16:25:02 volumio-fn kernel: FS-Cache: Loaded Feb 23 16:25:02 volumio-fn kernel: Key type dns_resolver registered Feb 23 16:25:02 volumio-fn sudo[1242]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:02 volumio-fn kernel: Key type cifs.spnego registered Feb 23 16:25:02 volumio-fn kernel: Key type cifs.idmap registered Feb 23 16:25:02 volumio-fn 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. Feb 23 16:25:02 volumio-fn kernel: CIFS: Attempting to mount //192.168.3.68/music Feb 23 16:25:02 volumio-fn kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 23 16:25:02 volumio-fn kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 23 16:25:02 volumio-fn volumio[950]: info: Loading plugin "upnp_browser"... Feb 23 16:25:02 volumio-fn ntpd[853]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "alarm-clock"... Feb 23 16:25:03 volumio-fn dbus-daemon[636]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.6' (uid=0 pid=1182 comm="/usr/lib/chromium/chromium --show-component-extens") Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "airplay_emulation"... Feb 23 16:25:03 volumio-fn volumio[950]: info: Starting Shairport Sync Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "last_100"... Feb 23 16:25:03 volumio-fn systemd[1]: Starting Bluetooth service... Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "webradio"... Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "i2s_dacs"... Feb 23 16:25:03 volumio-fn volumio[950]: info: I2S DAC not set, start Auto-detection Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "volumiodiscovery"... Feb 23 16:25:03 volumio-fn volumio[950]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 23 16:25:03 volumio-fn volumio[950]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 16:25:03 volumio-fn volumio[950]: *** WARNING *** For more information see Feb 23 16:25:03 volumio-fn volumio[950]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 23 16:25:03 volumio-fn volumio[950]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 16:25:03 volumio-fn volumio[950]: *** WARNING *** For more information see Feb 23 16:25:03 volumio-fn node[950]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 23 16:25:03 volumio-fn node[950]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 16:25:03 volumio-fn node[950]: *** WARNING *** For more information see Feb 23 16:25:03 volumio-fn node[950]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 23 16:25:03 volumio-fn node[950]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 16:25:03 volumio-fn node[950]: *** WARNING *** For more information see Feb 23 16:25:03 volumio-fn volumio[950]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 23 16:25:03 volumio-fn volumio[950]: info: Discovery: Started advertising with name: Volumio-FN Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "outputs"... Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "albumart"... Feb 23 16:25:03 volumio-fn volumio[950]: info: Plugin example_plugin is not enabled Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "inputs"... Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "updater_comm"... Feb 23 16:25:03 volumio-fn volumio[950]: Forking 3 albumart workers Feb 23 16:25:03 volumio-fn bluetoothd[1271]: Bluetooth daemon 5.50 Feb 23 16:25:03 volumio-fn kernel: Bluetooth: Core ver 2.22 Feb 23 16:25:03 volumio-fn kernel: NET: Registered PF_BLUETOOTH protocol family Feb 23 16:25:03 volumio-fn kernel: Bluetooth: HCI device and connection manager initialized Feb 23 16:25:03 volumio-fn kernel: Bluetooth: HCI socket layer initialized Feb 23 16:25:03 volumio-fn kernel: Bluetooth: L2CAP socket layer initialized Feb 23 16:25:03 volumio-fn kernel: Bluetooth: SCO socket layer initialized Feb 23 16:25:03 volumio-fn bluetoothd[1271]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Feb 23 16:25:03 volumio-fn dbus-daemon[636]: [system] Successfully activated service 'org.bluez' Feb 23 16:25:03 volumio-fn systemd[1]: Started Bluetooth service. Feb 23 16:25:03 volumio-fn bluetoothd[1271]: Starting SDP server Feb 23 16:25:03 volumio-fn bluetoothd[1271]: Excluding (cli) sap Feb 23 16:25:03 volumio-fn kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Feb 23 16:25:03 volumio-fn kernel: Bluetooth: BNEP filters: protocol multicast Feb 23 16:25:03 volumio-fn kernel: Bluetooth: BNEP socket layer initialized Feb 23 16:25:03 volumio-fn bluetoothd[1271]: Bluetooth management interface 1.22 initialized Feb 23 16:25:03 volumio-fn dbus-daemon[636]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.9' (uid=0 pid=1271 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Feb 23 16:25:03 volumio-fn systemd[1]: Starting Hostname Service... Feb 23 16:25:03 volumio-fn volumio[950]: Starting albumart workers Feb 23 16:25:03 volumio-fn volumio[950]: Starting albumart workers Feb 23 16:25:03 volumio-fn dbus-daemon[636]: [system] Successfully activated service 'org.freedesktop.hostname1' Feb 23 16:25:03 volumio-fn systemd[1]: Started Hostname Service. Feb 23 16:25:03 volumio-fn volumio[950]: Starting albumart workers Feb 23 16:25:03 volumio-fn volumio[950]: info: Plugin mpdemulation is not enabled Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "rest_api"... Feb 23 16:25:03 volumio-fn volumio-remote-updater[645]: [2025-02-23 16:25:03] [connect] Successful connection Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading plugin "websocket"... Feb 23 16:25:03 volumio-fn volumio[950]: info: Starting Socket.io Server version 2.3.0 Feb 23 16:25:03 volumio-fn volumio[950]: info: Loading i18n strings for locale zh Feb 23 16:25:03 volumio-fn volumio[950]: Updating browse sources language Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 16:25:03 volumio-fn volumio-time-update[634]: volumio-time-update-util: Fetching time from Volumio... Feb 23 16:25:03 volumio-fn volumio-time-update[634]: volumio-time-update-util: Date not found in response Feb 23 16:25:03 volumio-fn volumio-time-update[634]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::initPlayerControls Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 16:25:03 volumio-fn volumio[950]: Express server listening on port 3000 Feb 23 16:25:03 volumio-fn volumio[950]: [Metrics] WebUI: 3s 303.93ms Feb 23 16:25:03 volumio-fn volumio[950]: info: Setting Device type: x86 Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreStateMachine::resetVolumioState Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreStateMachine::getcurrentVolume Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 16:25:03 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 16:25:03 volumio-fn volumio[950]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 23 16:25:03 volumio-fn volumio[950]: info: Completed loading Core Plugins Feb 23 16:25:03 volumio-fn volumio[950]: info: Preparing to generate the ALSA configuration file Feb 23 16:25:03 volumio-fn volumio[950]: info: Volumio Network Manager: Network status updated: 0 Feb 23 16:25:03 volumio-fn volumio[950]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Feb 23 16:25:03 volumio-fn volumio[950]: info: Cannot mount NAS feiniu at system boot, trial number 1 ,retrying in 5 seconds Feb 23 16:25:03 volumio-fn volumio[950]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 23 16:25:03 volumio-fn volumio[950]: wlan0 Interface doesn't support scanning. Feb 23 16:25:03 volumio-fn volumio[950]: info: Cannot use regular scanning, forcing with ap-force Feb 23 16:25:03 volumio-fn sudo[1445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 23 16:25:03 volumio-fn sudo[1445]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:03 volumio-fn sudo[1445]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:03 volumio-fn volumio[950]: command failed: No such device (-19) Feb 23 16:25:03 volumio-fn volumio[950]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 23 16:25:03 volumio-fn volumio[950]: command failed: No such device (-19) Feb 23 16:25:03 volumio-fn volumio[950]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Feb 23 16:25:03 volumio-fn volumio-remote-updater[645]: [2025-02-23 16:25:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1740327903 101 Feb 23 16:25:04 volumio-fn volumio[950]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Feb 23 16:25:04 volumio-fn volumio[950]: info: VolumeController:: Volume=undefined Mute =false Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 16:25:04 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 0 Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreStateMachine::updateTrackBlock Feb 23 16:25:04 volumio-fn volumio[950]: info: CorePlayQueue::getTrackBlock Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 16:25:04 volumio-fn volumio[950]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Feb 23 16:25:04 volumio-fn volumio[950]: info: Reloading queue from file Feb 23 16:25:04 volumio-fn volumio[950]: info: VolumeController:: Volume=undefined Mute =false Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 16:25:04 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 0 Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreStateMachine::setRepeat null single undefined Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 16:25:04 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 0 Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreStateMachine::setRandom null Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 16:25:04 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 0 Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 16:25:04 volumio-fn volumio[950]: info: Asound.conf file unchanged, so no further update is needed Feb 23 16:25:04 volumio-fn volumio[950]: info: Output device has changed, restarting MPD Feb 23 16:25:04 volumio-fn sudo[1456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 16:25:04 volumio-fn sudo[1456]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:04 volumio-fn volumio[950]: info: Output device has changed, restarting Shairport Sync Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 16:25:04 volumio-fn sudo[1456]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:04 volumio-fn sudo[1458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 16:25:04 volumio-fn sudo[1458]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:04 volumio-fn volumio[950]: aplay: device_list:272: no soundcards found... Feb 23 16:25:04 volumio-fn volumio[950]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 16:25:04 volumio-fn volumio[950]: aplay: device_list:272: no soundcards found... Feb 23 16:25:04 volumio-fn volumio[950]: info: ___________ START PLUGINS ___________ Feb 23 16:25:04 volumio-fn systemd[1]: Stopping Music Player Daemon... Feb 23 16:25:04 volumio-fn volumio[950]: info: ControllerMpd::onStart: Initializing MPD Feb 23 16:25:04 volumio-fn volumio[950]: info: Creating MPD Configuration file Feb 23 16:25:04 volumio-fn sudo[1465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 16:25:04 volumio-fn sudo[1465]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:04 volumio-fn sudo[1465]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 16:25:04 volumio-fn volumio[950]: info: [1740327904098] CoreMusicLibrary::Adding element 媒体服务器 Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: aplay: device_list:272: no soundcards found... Feb 23 16:25:04 volumio-fn volumio[950]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 16:25:04 volumio-fn volumio[950]: aplay: device_list:272: no soundcards found... Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 16:25:04 volumio-fn sudo[1468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 16:25:04 volumio-fn sudo[1468]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:04 volumio-fn volumio[950]: aplay: device_list:272: no soundcards found... Feb 23 16:25:04 volumio-fn volumio[950]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 16:25:04 volumio-fn volumio[950]: aplay: device_list:272: no soundcards found... Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 16:25:04 volumio-fn volumio[950]: info: [1740327904121] CoreMusicLibrary::Adding element Last_100 Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 16:25:04 volumio-fn volumio[950]: info: [1740327904122] CoreMusicLibrary::Adding element Webradio Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 16:25:04 volumio-fn volumio[950]: info: Initializing BBC Radios Feb 23 16:25:04 volumio-fn systemd[1]: mpd.service: Succeeded. Feb 23 16:25:04 volumio-fn systemd[1]: Stopped Music Player Daemon. Feb 23 16:25:04 volumio-fn systemd[1]: Starting Music Player Daemon... Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: Volumio Calling Home Feb 23 16:25:04 volumio-fn sudo[1477]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 16:25:04 volumio-fn sudo[1477]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:04 volumio-fn sudo[1477]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:04 volumio-fn volumio[950]: Unhandled rejection Error: No sockets available, cannot start. Feb 23 16:25:04 volumio-fn volumio[950]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 23 16:25:04 volumio-fn volumio[950]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 23 16:25:04 volumio-fn volumio[950]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 23 16:25:04 volumio-fn volumio[950]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 23 16:25:04 volumio-fn volumio[950]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 23 16:25:04 volumio-fn volumio[950]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 23 16:25:04 volumio-fn volumio[950]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 23 16:25:04 volumio-fn volumio[950]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 23 16:25:04 volumio-fn volumio[950]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 23 16:25:04 volumio-fn volumio[950]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 23 16:25:04 volumio-fn volumio[950]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 23 16:25:04 volumio-fn volumio[950]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 23 16:25:04 volumio-fn volumio[950]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 23 16:25:04 volumio-fn volumio[950]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 23 16:25:04 volumio-fn volumio[950]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 23 16:25:04 volumio-fn volumio[950]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 23 16:25:04 volumio-fn volumio[950]: info: MPD Permissions set Feb 23 16:25:04 volumio-fn volumio[950]: info: MPD Permissions set Feb 23 16:25:04 volumio-fn volumio[950]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn dhcpcd[786]: eth0: probing address 192.168.3.27/24 Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 16:25:04 volumio-fn volumio[950]: info: Starting Shairport Sync Feb 23 16:25:04 volumio-fn volumio[950]: info: Starting Shairport Sync Feb 23 16:25:04 volumio-fn sudo[1505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 16:25:04 volumio-fn volumio[950]: info: Starting Shairport Sync Feb 23 16:25:04 volumio-fn sudo[1505]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:04 volumio-fn sudo[1507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 16:25:04 volumio-fn sudo[1507]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:04 volumio-fn sudo[1511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 16:25:04 volumio-fn sudo[1511]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:04 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetState Feb 23 16:25:04 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 0 Feb 23 16:25:04 volumio-fn systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 23 16:25:04 volumio-fn systemd[1]: shairport-sync.service: Succeeded. Feb 23 16:25:04 volumio-fn systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 23 16:25:04 volumio-fn systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 16:25:04 volumio-fn sudo[1505]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:04 volumio-fn systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 23 16:25:04 volumio-fn systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 23 16:25:04 volumio-fn systemd[1]: shairport-sync.service: Succeeded. Feb 23 16:25:04 volumio-fn systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 23 16:25:04 volumio-fn volumio[950]: info: Shairport-Sync Started Feb 23 16:25:04 volumio-fn systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 16:25:04 volumio-fn systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 23 16:25:04 volumio-fn systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 23 16:25:04 volumio-fn systemd[1]: shairport-sync.service: Succeeded. Feb 23 16:25:04 volumio-fn volumio[950]: Error adding Membership: Error: addMembership EINVAL Feb 23 16:25:04 volumio-fn systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 23 16:25:04 volumio-fn sudo[1507]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:04 volumio-fn volumio[950]: info: Shairport-Sync Started Feb 23 16:25:04 volumio-fn systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 16:25:04 volumio-fn sudo[1511]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:04 volumio-fn volumio[950]: info: Shairport-Sync Started Feb 23 16:25:04 volumio-fn mpd[1491]: Feb 23 16:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 23 16:25:04 volumio-fn systemd[1]: Started Music Player Daemon. Feb 23 16:25:04 volumio-fn sudo[1468]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:04 volumio-fn sudo[1458]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:04 volumio-fn volumio[950]: info: Completed starting Core Plugins Feb 23 16:25:04 volumio-fn volumio[950]: info: ------------------------------------------- Feb 23 16:25:04 volumio-fn volumio[950]: info: ----- MyVolumio plugins startup ---- Feb 23 16:25:04 volumio-fn volumio[950]: info: ------------------------------------------- Feb 23 16:25:04 volumio-fn volumio[950]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 23 16:25:04 volumio-fn volumio[950]: error: MPD error: The expression evaluated to a falsy value: Feb 23 16:25:04 volumio-fn volumio[950]: assert.ok(self.idling) Feb 23 16:25:04 volumio-fn volumio[950]: error: The expression evaluated to a falsy value: Feb 23 16:25:04 volumio-fn volumio[950]: assert.ok(self.idling) Feb 23 16:25:04 volumio-fn volumio[950]: info: MPD running with PID1491 Feb 23 16:25:04 volumio-fn volumio[950]: ,establishing connection Feb 23 16:25:04 volumio-fn volumio[950]: error: updateQueue error: null Feb 23 16:25:04 volumio-fn volumio[950]: error: updateQueue error: null Feb 23 16:25:04 volumio-fn volumio[950]: 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: 3 Feb 23 16:25:05 volumio-fn volumio[950]: 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 Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetState Feb 23 16:25:05 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 0 Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 23 16:25:05 volumio-fn volumio[950]: info: Received Get System Info Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 16:25:05 volumio-fn volumio[950]: info: Discovery: Getting this device information Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetState Feb 23 16:25:05 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 0 Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetState Feb 23 16:25:05 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 0 Feb 23 16:25:05 volumio-fn volumio[950]: info: Listing playlists Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 23 16:25:05 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 16:25:06 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetState Feb 23 16:25:06 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 0 Feb 23 16:25:06 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 23 16:25:07 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 16:25:07 volumio-fn volumio[950]: info: Received Get System Info Feb 23 16:25:07 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 16:25:07 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 16:25:07 volumio-fn volumio[950]: info: Discovery: Getting this device information Feb 23 16:25:07 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetState Feb 23 16:25:07 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 0 Feb 23 16:25:07 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 16:25:08 volumio-fn dhcpcd[786]: eth0: leased 192.168.3.27 for 604800 seconds Feb 23 16:25:08 volumio-fn dhcpcd[786]: eth0: adding route to 192.168.3.0/24 Feb 23 16:25:08 volumio-fn avahi-daemon[633]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.3.27. Feb 23 16:25:08 volumio-fn dhcpcd[786]: eth0: adding default route via 192.168.3.1 Feb 23 16:25:08 volumio-fn dhcpcd[786]: eth0: dhcp_envoption 213: Operation not supported Feb 23 16:25:08 volumio-fn dhcpcd[786]: eth0: dhcp_envoption 213: Operation not supported Feb 23 16:25:08 volumio-fn avahi-daemon[633]: New relevant interface eth0.IPv4 for mDNS. Feb 23 16:25:08 volumio-fn avahi-daemon[633]: Registering new address record for 192.168.3.27 on eth0.IPv4. Feb 23 16:25:08 volumio-fn ntpd[853]: ntpd exiting on signal 15 (Terminated) Feb 23 16:25:08 volumio-fn systemd[1]: Stopping Network Time Service... Feb 23 16:25:08 volumio-fn systemd[1]: ntp.service: Succeeded. Feb 23 16:25:08 volumio-fn systemd[1]: Stopped Network Time Service. Feb 23 16:25:08 volumio-fn systemd[1]: Starting Network Time Service... Feb 23 16:25:08 volumio-fn ntpd[1556]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 23 16:25:08 volumio-fn ntpd[1556]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Feb 23 16:25:08 volumio-fn systemd[1]: Started Network Time Service. Feb 23 16:25:08 volumio-fn ntpd[1562]: proto: precision = 0.062 usec (-24) Feb 23 16:25:08 volumio-fn ntpd[1562]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 23 16:25:08 volumio-fn ntpd[1562]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 23 16:25:08 volumio-fn ntpd[1562]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 789 days ago Feb 23 16:25:08 volumio-fn ntpd[1562]: Listen and drop on 0 v6wildcard [::]:123 Feb 23 16:25:08 volumio-fn ntpd[1562]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 23 16:25:08 volumio-fn ntpd[1562]: Listen normally on 2 lo 127.0.0.1:123 Feb 23 16:25:08 volumio-fn ntpd[1562]: Listen normally on 3 eth0 192.168.3.27:123 Feb 23 16:25:08 volumio-fn ntpd[1562]: Listening on routing socket on fd #20 for interface updates Feb 23 16:25:08 volumio-fn ntpd[1562]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 23 16:25:08 volumio-fn ntpd[1562]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 23 16:25:08 volumio-fn volumio-time-update[634]: volumio-time-update-util: Fetching time from Volumio... Feb 23 16:25:08 volumio-fn sudo[1570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=xkxiaoli,password=Stone198568,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.68/music /mnt/NAS/feiniu Feb 23 16:25:08 volumio-fn sudo[1570]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:09 volumio-fn kernel: CIFS: Attempting to mount //192.168.3.68/music Feb 23 16:25:09 volumio-fn nmbd[793]: [2025/02/23 16:25:09.495046, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 23 16:25:09 volumio-fn nmbd[793]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Feb 23 16:25:09 volumio-fn systemd[1]: Started Samba NMB Daemon. Feb 23 16:25:09 volumio-fn sudo[1570]: pam_unix(sudo:session): session closed for user root Feb 23 16:25:09 volumio-fn nmbd[793]: [2025/02/23 16:25:09.502095, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Feb 23 16:25:09 volumio-fn nmbd[793]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.3.27 for name WORKGROUP<1d>. Feb 23 16:25:09 volumio-fn nmbd[793]: This response was from IP 192.168.3.68, reporting an IP address of 192.168.3.68. Feb 23 16:25:09 volumio-fn ntpd[1562]: Soliciting pool server 78.46.102.180 Feb 23 16:25:09 volumio-fn systemd[1]: Starting Samba Winbind Daemon... Feb 23 16:25:09 volumio-fn volumio[950]: verbose: New Socket.io Connection to 192.168.3.27:3000 from 192.168.3.92 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Feb 23 16:25:09 volumio-fn volumio[950]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 23 16:25:09 volumio-fn winbindd[1586]: [2025/02/23 16:25:09.613548, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Feb 23 16:25:09 volumio-fn winbindd[1586]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 23 16:25:09 volumio-fn winbindd[1586]: [2025/02/23 16:25:09.615874, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 23 16:25:09 volumio-fn winbindd[1586]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 23 16:25:09 volumio-fn systemd[1]: Started Samba Winbind Daemon. Feb 23 16:25:09 volumio-fn volumio[950]: info: Discovery: adding 48dc3a9d-712b-47cd-a3d6-e2625bb8ae04 Feb 23 16:25:09 volumio-fn volumio[950]: info: Discovery: Found device Volumio-FN Feb 23 16:25:09 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetState Feb 23 16:25:09 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 0 Feb 23 16:25:09 volumio-fn volumio[950]: info: Discovery: adding 12f61ce6-57f2-4b71-9b43-8c4ba623f262 Feb 23 16:25:09 volumio-fn volumio[950]: info: Discovery: Found device Volumio Feb 23 16:25:09 volumio-fn volumio[950]: info: Discovery: Connecting to remote: 192.168.3.92 Feb 23 16:25:09 volumio-fn systemd[1]: Starting Samba SMB Daemon... Feb 23 16:25:09 volumio-fn smbd[1591]: [2025/02/23 16:25:09.821994, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 23 16:25:09 volumio-fn smbd[1591]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 23 16:25:09 volumio-fn systemd[1]: Started Samba SMB Daemon. Feb 23 16:25:09 volumio-fn volumio-time-update[634]: volumio-time-update-util: Setting system time to: 2025-02-23 08:25:10 Feb 23 16:25:09 volumio-fn sudo[1600]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-02-23 08:25:10 Feb 23 16:25:09 volumio-fn sudo[1600]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 16:25:09 volumio-fn dbus-daemon[636]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.16' (uid=0 pid=1601 comm="timedatectl set-time 2025-02-23 08:25:10 ") Feb 23 16:25:09 volumio-fn systemd[1]: Starting Time & Date Service... Feb 23 16:25:09 volumio-fn dbus-daemon[636]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 23 16:25:09 volumio-fn systemd[1]: Started Time & Date Service. Feb 23 08:27:04 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetState Feb 23 08:27:04 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:27:07 volumio-fn volumio[950]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 08:27:07 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 23 08:27:07 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 23 08:27:07 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 23 08:27:07 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Feb 23 08:27:07 volumio-fn volumio[950]: info: Received Get System Version Feb 23 08:27:07 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 08:27:22 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetState Feb 23 08:27:22 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 08:27:25 volumio-fn volumio[950]: aplay: device_list:272: no soundcards found... Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 08:27:25 volumio-fn volumio[950]: Invalid card number. Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 23 08:27:25 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 23 08:28:18 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetState Feb 23 08:28:18 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPlay Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::play index undefined Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::startPlaybackTimer Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::clearAddPlayTracks NAS/feiniu/1-个人专辑/刀郎/刀郎 - 情人.flac Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand stop took 0 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 08:28:19 volumio-fn volumio[950]: info: Feb 23 08:28:19 volumio-fn volumio[950]: ---------------------------- MPD announces state update: player Feb 23 08:28:19 volumio-fn volumio[950]: info: Feb 23 08:28:19 volumio-fn volumio[950]: ---------------------------- MPD announces system playlist update Feb 23 08:28:19 volumio-fn volumio[950]: info: Ignoring MPD Status Update Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::getState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand status Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand clear took 0 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand add "NAS/feiniu/1-个人专辑/刀郎/刀郎 - 情人.flac" Feb 23 08:28:19 volumio-fn volumio[950]: info: Feb 23 08:28:19 volumio-fn volumio[950]: ---------------------------- MPD announces state update: player Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::getState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand status Feb 23 08:28:19 volumio-fn volumio[950]: info: Feb 23 08:28:19 volumio-fn volumio[950]: ---------------------------- MPD announces state update: player Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::getState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand status Feb 23 08:28:19 volumio-fn volumio[950]: error: updateQueue error: null Feb 23 08:28:19 volumio-fn volumio[950]: info: Feb 23 08:28:19 volumio-fn volumio[950]: ---------------------------- MPD announces system playlist update Feb 23 08:28:19 volumio-fn volumio[950]: info: Ignoring MPD Status Update Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand status took 1 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: info: ------------------------------ 1ms Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand add "NAS/feiniu/1-个人专辑/刀郎/刀郎 - 情人.flac" took 1 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand status took 1 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::parseState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand play Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::parseState Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::servicePushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: 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} Feb 23 08:28:19 volumio-fn volumio[950]: verbose: CURRENT POSITION 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState stateService stop Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState currentStatus stop Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: No code Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::servicePushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: 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} Feb 23 08:28:19 volumio-fn volumio[950]: verbose: CURRENT POSITION 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState stateService stop Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState currentStatus stop Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: No code Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: ------------------------------ 17ms Feb 23 08:28:19 volumio-fn volumio[950]: info: ------------------------------ 16ms Feb 23 08:28:19 volumio-fn volumio[950]: info: Feb 23 08:28:19 volumio-fn volumio[950]: ---------------------------- MPD announces system playlist update Feb 23 08:28:19 volumio-fn volumio[950]: info: Ignoring MPD Status Update Feb 23 08:28:19 volumio-fn volumio[950]: info: Feb 23 08:28:19 volumio-fn volumio[950]: ---------------------------- MPD announces system playlist update Feb 23 08:28:19 volumio-fn volumio[950]: info: Ignoring MPD Status Update Feb 23 08:28:19 volumio-fn volumio[950]: error: Upnp client error: Error: This socket has been ended by the other party Feb 23 08:28:19 volumio-fn volumio[950]: info: Feb 23 08:28:19 volumio-fn volumio[950]: ---------------------------- MPD announces state update: player Feb 23 08:28:19 volumio-fn volumio[950]: info: Feb 23 08:28:19 volumio-fn volumio[950]: ---------------------------- MPD announces state update: player Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand status took 18 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: info: ------------------------------ 18ms Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand play took 17 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::getState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand status Feb 23 08:28:19 volumio-fn volumio[950]: info: ------------------------------ 2ms Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::getState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand status Feb 23 08:28:19 volumio-fn volumio[950]: info: ------------------------------ 1ms Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::parseState Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::servicePushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: 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} Feb 23 08:28:19 volumio-fn volumio[950]: verbose: CURRENT POSITION 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState stateService stop Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState currentStatus stop Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: No code Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: ------------------------------ 27ms Feb 23 08:28:19 volumio-fn volumio[950]: info: Feb 23 08:28:19 volumio-fn volumio[950]: ---------------------------- MPD announces state update: player Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::getState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand status Feb 23 08:28:19 volumio-fn volumio[950]: info: Feb 23 08:28:19 volumio-fn volumio[950]: ---------------------------- MPD announces state update: player Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::getState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand status Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand status took 14 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand status took 15 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::parseState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::parseState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand status took 10 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand status took 10 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand clearerror took 6 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand clearerror took 5 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::parseState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::parseState Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::parseTrackInfo Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::parseTrackInfo Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::servicePushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"情人","artist":"刀郎","album":"2002年的第一场雪","uri":"NAS/feiniu/1-个人专辑/刀郎/刀郎 - 情人.flac","trackType":"flac"} Feb 23 08:28:19 volumio-fn volumio[950]: verbose: CURRENT POSITION 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState stateService pause Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState currentStatus stop Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::servicePushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"情人","artist":"刀郎","album":"2002年的第一场雪","uri":"NAS/feiniu/1-个人专辑/刀郎/刀郎 - 情人.flac","trackType":"flac"} Feb 23 08:28:19 volumio-fn volumio[950]: verbose: CURRENT POSITION 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState stateService pause Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState currentStatus stop Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: ------------------------------ 31ms Feb 23 08:28:19 volumio-fn volumio[950]: info: ------------------------------ 31ms Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand clearerror took 14 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand clearerror took 13 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::parseTrackInfo Feb 23 08:28:19 volumio-fn volumio[950]: verbose: ControllerMpd::parseTrackInfo Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::servicePushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"情人","artist":"刀郎","album":"2002年的第一场雪","uri":"NAS/feiniu/1-个人专辑/刀郎/刀郎 - 情人.flac","trackType":"flac"} Feb 23 08:28:19 volumio-fn volumio[950]: verbose: CURRENT POSITION 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState stateService pause Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState currentStatus stop Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: ControllerMpd::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::servicePushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"情人","artist":"刀郎","album":"2002年的第一场雪","uri":"NAS/feiniu/1-个人专辑/刀郎/刀郎 - 情人.flac","trackType":"flac"} Feb 23 08:28:19 volumio-fn volumio[950]: verbose: CURRENT POSITION 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState stateService pause Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::syncState currentStatus stop Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreStateMachine::pushState Feb 23 08:28:19 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:19 volumio-fn volumio[950]: info: CoreCommandRouter::volumioPushState Feb 23 08:28:19 volumio-fn volumio[950]: info: ------------------------------ 32ms Feb 23 08:28:19 volumio-fn volumio[950]: info: ------------------------------ 32ms Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 08:28:22 volumio-fn volumio[950]: aplay: device_list:272: no soundcards found... Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 08:28:22 volumio-fn volumio[950]: Invalid card number. Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 23 08:28:22 volumio-fn volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 23 08:28:35 volumio-fn volumio[950]: info: CoreCommandRouter::volumioGetState Feb 23 08:28:35 volumio-fn volumio[950]: info: CorePlayQueue::getTrack 3 Feb 23 08:28:50 volumio-fn volumio[950]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 08:28:50 volumio-fn volumio[950]: Error: connect ETIMEDOUT 199.16.158.9:443 Feb 23 08:28:50 volumio-fn volumio[950]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 23 08:28:50 volumio-fn volumio[950]: errno: -110, Feb 23 08:28:50 volumio-fn volumio[950]: code: 'ETIMEDOUT', Feb 23 08:28:50 volumio-fn volumio[950]: syscall: 'connect', Feb 23 08:28:50 volumio-fn volumio[950]: address: '199.16.158.9', Feb 23 08:28:50 volumio-fn volumio[950]: port: 443 Feb 23 08:28:50 volumio-fn volumio[950]: } Feb 23 08:28:50 volumio-fn volumio[950]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 08:28:50 volumio-fn sudo[2514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-23 08:27 Feb 23 08:28:50 volumio-fn sudo[2514]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"