Sep 16 19:04:29 volprox kernel: Linux version 6.12.35-volumio (gkkpch@busteros) (gcc (Debian 8.3.0-6) 8.3.0, GNU ld (GNU Binutils for Debian) 2.31.1) #14.44 SMP PREEMPT_DYNAMIC Fri Jul 4 14:52:54 CEST 2025 Sep 16 19:04:29 volprox kernel: Command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=3ddf10b5-43a4-45f6-a8fa-fde595f0bef6 bootpart=UUID=14E6-4F3A datapart=UUID=33973cba-33c1-4101-a3cf-953d0681254b 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 initrd=volumio.initrd Sep 16 19:04:29 volprox kernel: KERNEL supported cpus: Sep 16 19:04:29 volprox kernel: Intel GenuineIntel Sep 16 19:04:29 volprox kernel: AMD AuthenticAMD Sep 16 19:04:29 volprox kernel: Hygon HygonGenuine Sep 16 19:04:29 volprox kernel: Centaur CentaurHauls Sep 16 19:04:29 volprox kernel: zhaoxin Shanghai Sep 16 19:04:29 volprox kernel: BIOS-provided physical RAM map: Sep 16 19:04:29 volprox kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Sep 16 19:04:29 volprox kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Sep 16 19:04:29 volprox kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Sep 16 19:04:29 volprox kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bffddfff] usable Sep 16 19:04:29 volprox kernel: BIOS-e820: [mem 0x00000000bffde000-0x00000000bfffffff] reserved Sep 16 19:04:29 volprox kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Sep 16 19:04:29 volprox kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Sep 16 19:04:29 volprox kernel: BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable Sep 16 19:04:29 volprox kernel: NX (Execute Disable) protection: active Sep 16 19:04:29 volprox kernel: APIC: Static calls initialized Sep 16 19:04:29 volprox kernel: SMBIOS 2.8 present. Sep 16 19:04:29 volprox kernel: DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 Sep 16 19:04:29 volprox kernel: DMI: Memory slots populated: 1/1 Sep 16 19:04:29 volprox kernel: Hypervisor detected: KVM Sep 16 19:04:29 volprox kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Sep 16 19:04:29 volprox kernel: kvm-clock: using sched offset of 4820072616 cycles Sep 16 19:04:29 volprox kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 16 19:04:29 volprox kernel: tsc: Detected 3912.012 MHz processor Sep 16 19:04:29 volprox kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 16 19:04:29 volprox kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 16 19:04:29 volprox kernel: last_pfn = 0x140000 max_arch_pfn = 0x400000000 Sep 16 19:04:29 volprox kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Sep 16 19:04:29 volprox kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Sep 16 19:04:29 volprox kernel: last_pfn = 0xbffde max_arch_pfn = 0x400000000 Sep 16 19:04:29 volprox kernel: found SMP MP-table at [mem 0x000f5440-0x000f544f] Sep 16 19:04:29 volprox kernel: RAMDISK: [mem 0x7b3bf000-0x7fffffff] Sep 16 19:04:29 volprox kernel: ACPI: Early table checksum verification disabled Sep 16 19:04:29 volprox kernel: ACPI: RSDP 0x00000000000F5240 000014 (v00 BOCHS ) Sep 16 19:04:29 volprox kernel: ACPI: RSDT 0x00000000BFFE3C9E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 19:04:29 volprox kernel: ACPI: FACP 0x00000000BFFE3A70 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 19:04:29 volprox kernel: ACPI: DSDT 0x00000000BFFDF040 004A30 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 19:04:29 volprox kernel: ACPI: FACS 0x00000000BFFDF000 000040 Sep 16 19:04:29 volprox kernel: ACPI: APIC 0x00000000BFFE3AE4 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 19:04:29 volprox kernel: ACPI: SSDT 0x00000000BFFE3B74 0000CA (v01 BOCHS VMGENID 00000001 BXPC 00000001) Sep 16 19:04:29 volprox kernel: ACPI: HPET 0x00000000BFFE3C3E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 19:04:29 volprox kernel: ACPI: WAET 0x00000000BFFE3C76 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 19:04:29 volprox kernel: ACPI: Reserving FACP table memory at [mem 0xbffe3a70-0xbffe3ae3] Sep 16 19:04:29 volprox kernel: ACPI: Reserving DSDT table memory at [mem 0xbffdf040-0xbffe3a6f] Sep 16 19:04:29 volprox kernel: ACPI: Reserving FACS table memory at [mem 0xbffdf000-0xbffdf03f] Sep 16 19:04:29 volprox kernel: ACPI: Reserving APIC table memory at [mem 0xbffe3ae4-0xbffe3b73] Sep 16 19:04:29 volprox kernel: ACPI: Reserving SSDT table memory at [mem 0xbffe3b74-0xbffe3c3d] Sep 16 19:04:29 volprox kernel: ACPI: Reserving HPET table memory at [mem 0xbffe3c3e-0xbffe3c75] Sep 16 19:04:29 volprox kernel: ACPI: Reserving WAET table memory at [mem 0xbffe3c76-0xbffe3c9d] Sep 16 19:04:29 volprox kernel: Zone ranges: Sep 16 19:04:29 volprox kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Sep 16 19:04:29 volprox kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Sep 16 19:04:29 volprox kernel: Normal [mem 0x0000000100000000-0x000000013fffffff] Sep 16 19:04:29 volprox kernel: Movable zone start for each node Sep 16 19:04:29 volprox kernel: Early memory node ranges Sep 16 19:04:29 volprox kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Sep 16 19:04:29 volprox kernel: node 0: [mem 0x0000000000100000-0x00000000bffddfff] Sep 16 19:04:29 volprox kernel: node 0: [mem 0x0000000100000000-0x000000013fffffff] Sep 16 19:04:29 volprox kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] Sep 16 19:04:29 volprox kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 16 19:04:29 volprox kernel: On node 0, zone DMA: 97 pages in unavailable ranges Sep 16 19:04:29 volprox kernel: On node 0, zone Normal: 34 pages in unavailable ranges Sep 16 19:04:29 volprox kernel: ACPI: PM-Timer IO Port: 0x608 Sep 16 19:04:29 volprox kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Sep 16 19:04:29 volprox kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Sep 16 19:04:29 volprox kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Sep 16 19:04:29 volprox kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Sep 16 19:04:29 volprox kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Sep 16 19:04:29 volprox kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Sep 16 19:04:29 volprox kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Sep 16 19:04:29 volprox kernel: ACPI: Using ACPI (MADT) for SMP configuration information Sep 16 19:04:29 volprox kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Sep 16 19:04:29 volprox kernel: CPU topo: Max. logical packages: 1 Sep 16 19:04:29 volprox kernel: CPU topo: Max. logical dies: 1 Sep 16 19:04:29 volprox kernel: CPU topo: Max. dies per package: 1 Sep 16 19:04:29 volprox kernel: CPU topo: Max. threads per core: 1 Sep 16 19:04:29 volprox kernel: CPU topo: Num. cores per package: 4 Sep 16 19:04:29 volprox kernel: CPU topo: Num. threads per package: 4 Sep 16 19:04:29 volprox kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Sep 16 19:04:29 volprox kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Sep 16 19:04:29 volprox kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] Sep 16 19:04:29 volprox kernel: PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] Sep 16 19:04:29 volprox kernel: PM: hibernation: Registered nosave memory: [mem 0xbffde000-0xffffffff] Sep 16 19:04:29 volprox kernel: [mem 0xc0000000-0xfeffbfff] available for PCI devices Sep 16 19:04:29 volprox kernel: Booting paravirtualized kernel on KVM Sep 16 19:04:29 volprox kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Sep 16 19:04:29 volprox kernel: setup_percpu: NR_CPUS:64 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Sep 16 19:04:29 volprox kernel: percpu: Embedded 59 pages/cpu s201432 r8192 d32040 u524288 Sep 16 19:04:29 volprox kernel: pcpu-alloc: s201432 r8192 d32040 u524288 alloc=1*2097152 Sep 16 19:04:29 volprox kernel: pcpu-alloc: [0] 0 1 2 3 Sep 16 19:04:29 volprox kernel: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=3ddf10b5-43a4-45f6-a8fa-fde595f0bef6 bootpart=UUID=14E6-4F3A datapart=UUID=33973cba-33c1-4101-a3cf-953d0681254b 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 initrd=volumio.initrd Sep 16 19:04:29 volprox kernel: Unknown kernel command line parameters "splash BOOT_IMAGE=vmlinuz bootdelay=5 biosdevname=0 imgpart=UUID=3ddf10b5-43a4-45f6-a8fa-fde595f0bef6 bootpart=UUID=14E6-4F3A datapart=UUID=33973cba-33c1-4101-a3cf-953d0681254b hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh use_kmsg=no", will be passed to user space. Sep 16 19:04:29 volprox kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 16 19:04:29 volprox kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 16 19:04:29 volprox kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048444 Sep 16 19:04:29 volprox kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 16 19:04:29 volprox kernel: software IO TLB: area num 4. Sep 16 19:04:29 volprox kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 16 19:04:29 volprox kernel: Kernel/User page tables isolation: enabled Sep 16 19:04:29 volprox kernel: ftrace: allocating 45160 entries in 177 pages Sep 16 19:04:29 volprox kernel: ftrace: allocated 177 pages with 4 groups Sep 16 19:04:29 volprox kernel: Dynamic Preempt: voluntary Sep 16 19:04:29 volprox kernel: rcu: Preemptible hierarchical RCU implementation. Sep 16 19:04:29 volprox kernel: rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=4. Sep 16 19:04:29 volprox kernel: Trampoline variant of Tasks RCU enabled. Sep 16 19:04:29 volprox kernel: Rude variant of Tasks RCU enabled. Sep 16 19:04:29 volprox kernel: Tracing variant of Tasks RCU enabled. Sep 16 19:04:29 volprox kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Sep 16 19:04:29 volprox kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 16 19:04:29 volprox kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 16 19:04:29 volprox kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 16 19:04:29 volprox kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 16 19:04:29 volprox kernel: NR_IRQS: 4352, nr_irqs: 456, preallocated irqs: 16 Sep 16 19:04:29 volprox kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 16 19:04:29 volprox kernel: Console: colour VGA+ 80x25 Sep 16 19:04:29 volprox kernel: printk: legacy console [tty0] enabled Sep 16 19:04:29 volprox kernel: ACPI: Core revision 20240827 Sep 16 19:04:29 volprox kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Sep 16 19:04:29 volprox kernel: APIC: Switch to symmetric I/O mode setup Sep 16 19:04:29 volprox kernel: x2apic enabled Sep 16 19:04:29 volprox kernel: APIC: Switched APIC routing to: physical x2apic Sep 16 19:04:29 volprox kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Sep 16 19:04:29 volprox kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x70c75a21ee6, max_idle_ns: 881590662274 ns Sep 16 19:04:29 volprox kernel: Calibrating delay loop (skipped) preset value.. 7824.02 BogoMIPS (lpj=15648048) Sep 16 19:04:29 volprox kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Sep 16 19:04:29 volprox kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Sep 16 19:04:29 volprox kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Sep 16 19:04:29 volprox kernel: Spectre V2 : Mitigation: Retpolines Sep 16 19:04:29 volprox kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Sep 16 19:04:29 volprox kernel: Speculative Store Bypass: Vulnerable Sep 16 19:04:29 volprox kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Sep 16 19:04:29 volprox kernel: MMIO Stale Data: Unknown: No mitigations Sep 16 19:04:29 volprox kernel: ITS: Mitigation: Aligned branch/return thunks Sep 16 19:04:29 volprox kernel: x86/fpu: x87 FPU will use FXSAVE Sep 16 19:04:29 volprox kernel: Freeing SMP alternatives memory: 36K Sep 16 19:04:29 volprox kernel: pid_max: default: 32768 minimum: 301 Sep 16 19:04:29 volprox kernel: LSM: initializing lsm=capability,yama Sep 16 19:04:29 volprox kernel: Yama: becoming mindful. Sep 16 19:04:29 volprox kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 16 19:04:29 volprox kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 16 19:04:29 volprox kernel: smpboot: CPU0: Intel QEMU Virtual CPU version 2.5+ (family: 0xf, model: 0x6b, stepping: 0x1) Sep 16 19:04:29 volprox kernel: Performance Events: unsupported Netburst CPU model 107 no PMU driver, software events only. Sep 16 19:04:29 volprox kernel: signal: max sigframe size: 1440 Sep 16 19:04:29 volprox kernel: rcu: Hierarchical SRCU implementation. Sep 16 19:04:29 volprox kernel: rcu: Max phase no-delay instances is 1000. Sep 16 19:04:29 volprox kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 16 19:04:29 volprox kernel: NMI watchdog: Perf NMI watchdog permanently disabled Sep 16 19:04:29 volprox kernel: smp: Bringing up secondary CPUs ... Sep 16 19:04:29 volprox kernel: smpboot: x86: Booting SMP configuration: Sep 16 19:04:29 volprox kernel: .... node #0, CPUs: #1 #2 #3 Sep 16 19:04:29 volprox kernel: smp: Brought up 1 node, 4 CPUs Sep 16 19:04:29 volprox kernel: smpboot: Total of 4 processors activated (31296.09 BogoMIPS) Sep 16 19:04:29 volprox kernel: Memory: 3941876K/4193776K available (16384K kernel code, 2020K rwdata, 5356K rodata, 3124K init, 860K bss, 246380K reserved, 0K cma-reserved) Sep 16 19:04:29 volprox kernel: devtmpfs: initialized Sep 16 19:04:29 volprox kernel: x86/mm: Memory block size: 128MB Sep 16 19:04:29 volprox kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Sep 16 19:04:29 volprox kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 16 19:04:29 volprox kernel: pinctrl core: initialized pinctrl subsystem Sep 16 19:04:29 volprox kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 16 19:04:29 volprox kernel: audit: initializing netlink subsys (disabled) Sep 16 19:04:29 volprox kernel: audit: type=2000 audit(1758017059.474:1): state=initialized audit_enabled=0 res=1 Sep 16 19:04:29 volprox kernel: thermal_sys: Registered thermal governor 'fair_share' Sep 16 19:04:29 volprox kernel: thermal_sys: Registered thermal governor 'bang_bang' Sep 16 19:04:29 volprox kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 16 19:04:29 volprox kernel: thermal_sys: Registered thermal governor 'user_space' Sep 16 19:04:29 volprox kernel: cpuidle: using governor ladder Sep 16 19:04:29 volprox kernel: cpuidle: using governor menu Sep 16 19:04:29 volprox kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 16 19:04:29 volprox kernel: PCI: Using configuration type 1 for base access Sep 16 19:04:29 volprox kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Sep 16 19:04:29 volprox kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 16 19:04:29 volprox kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Sep 16 19:04:29 volprox kernel: ACPI: Added _OSI(Module Device) Sep 16 19:04:29 volprox kernel: ACPI: Added _OSI(Processor Device) Sep 16 19:04:29 volprox kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 16 19:04:29 volprox kernel: ACPI: 2 ACPI AML tables successfully acquired and loaded Sep 16 19:04:29 volprox kernel: ACPI: Interpreter enabled Sep 16 19:04:29 volprox kernel: ACPI: PM: (supports S0 S5) Sep 16 19:04:29 volprox kernel: ACPI: Using IOAPIC for interrupt routing Sep 16 19:04:29 volprox kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 16 19:04:29 volprox kernel: PCI: Using E820 reservations for host bridge windows Sep 16 19:04:29 volprox kernel: ACPI: Enabled 3 GPEs in block 00 to 0F Sep 16 19:04:29 volprox kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 16 19:04:29 volprox kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Sep 16 19:04:29 volprox kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Sep 16 19:04:29 volprox kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Sep 16 19:04:29 volprox kernel: acpiphp: Slot [3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [7] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [17] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [18] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [6] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [8] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [9] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [10] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [11] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [12] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [13] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [14] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [15] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [16] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [19] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [20] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [21] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [22] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [23] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [24] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [25] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [26] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [27] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [28] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [29] registered Sep 16 19:04:29 volprox kernel: PCI host bridge to bus 0000:00 Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: root bus resource [mem 0x140000000-0x1bfffffff window] Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 16 19:04:29 volprox kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint Sep 16 19:04:29 volprox kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint Sep 16 19:04:29 volprox kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint Sep 16 19:04:29 volprox kernel: pci 0000:00:01.1: BAR 4 [io 0xf0a0-0xf0af] Sep 16 19:04:29 volprox kernel: pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk Sep 16 19:04:29 volprox kernel: pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk Sep 16 19:04:29 volprox kernel: pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk Sep 16 19:04:29 volprox kernel: pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk Sep 16 19:04:29 volprox kernel: pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint Sep 16 19:04:29 volprox kernel: pci 0000:00:01.2: BAR 4 [io 0xf040-0xf05f] Sep 16 19:04:29 volprox kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint Sep 16 19:04:29 volprox kernel: pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI Sep 16 19:04:29 volprox kernel: pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB Sep 16 19:04:29 volprox kernel: pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Sep 16 19:04:29 volprox kernel: pci 0000:00:02.0: BAR 0 [mem 0xfc000000-0xfcffffff pref] Sep 16 19:04:29 volprox kernel: pci 0000:00:02.0: BAR 2 [mem 0xfeaa8000-0xfeaa8fff] Sep 16 19:04:29 volprox kernel: pci 0000:00:02.0: ROM [mem 0xfea80000-0xfea8ffff pref] Sep 16 19:04:29 volprox kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Sep 16 19:04:29 volprox kernel: pci 0000:00:03.0: [1af4:1002] type 00 class 0x00ff00 conventional PCI endpoint Sep 16 19:04:29 volprox kernel: pci 0000:00:03.0: BAR 0 [io 0xf000-0xf03f] Sep 16 19:04:29 volprox kernel: pci 0000:00:03.0: BAR 4 [mem 0xfd600000-0xfd603fff 64bit pref] Sep 16 19:04:29 volprox kernel: pci 0000:00:05.0: [1b36:0001] type 01 class 0x060400 conventional PCI bridge Sep 16 19:04:29 volprox kernel: pci 0000:00:05.0: BAR 0 [mem 0xfeaa9000-0xfeaa90ff 64bit] Sep 16 19:04:29 volprox kernel: pci 0000:00:05.0: PCI bridge to [bus 01] Sep 16 19:04:29 volprox kernel: pci 0000:00:05.0: bridge window [io 0xe000-0xefff] Sep 16 19:04:29 volprox kernel: pci 0000:00:05.0: bridge window [mem 0xfe800000-0xfe9fffff] Sep 16 19:04:29 volprox kernel: pci 0000:00:05.0: bridge window [mem 0xfd400000-0xfd5fffff 64bit pref] Sep 16 19:04:29 volprox kernel: pci 0000:00:07.0: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Sep 16 19:04:29 volprox kernel: pci 0000:00:07.0: BAR 4 [io 0xf060-0xf07f] Sep 16 19:04:29 volprox kernel: pci 0000:00:07.0: BAR 5 [mem 0xfeaaa000-0xfeaaafff] Sep 16 19:04:29 volprox kernel: pci 0000:00:11.0: [8086:a2f0] type 00 class 0x040300 conventional PCI endpoint Sep 16 19:04:29 volprox kernel: pci 0000:00:11.0: BAR 0 [mem 0xfeaa0000-0xfeaa3fff 64bit] Sep 16 19:04:29 volprox kernel: pci 0000:00:11.0: BAR 4 [mem 0xfea90000-0xfea9ffff 64bit] Sep 16 19:04:29 volprox kernel: pci 0000:00:12.0: [8086:10d3] type 00 class 0x020000 PCIe Endpoint Sep 16 19:04:29 volprox kernel: pci 0000:00:12.0: BAR 0 [mem 0xfea40000-0xfea5ffff] Sep 16 19:04:29 volprox kernel: pci 0000:00:12.0: BAR 1 [mem 0xfea60000-0xfea7ffff] Sep 16 19:04:29 volprox kernel: pci 0000:00:12.0: BAR 2 [io 0xf080-0xf09f] Sep 16 19:04:29 volprox kernel: pci 0000:00:12.0: BAR 3 [mem 0xfeaa4000-0xfeaa7fff] Sep 16 19:04:29 volprox kernel: pci 0000:00:12.0: ROM [mem 0xfea00000-0xfea3ffff pref] Sep 16 19:04:29 volprox kernel: pci 0000:00:12.0: enabling Extended Tags Sep 16 19:04:29 volprox kernel: pci 0000:00:1e.0: [1b36:0001] type 01 class 0x060400 conventional PCI bridge Sep 16 19:04:29 volprox kernel: pci 0000:00:1e.0: BAR 0 [mem 0xfeaab000-0xfeaab0ff 64bit] Sep 16 19:04:29 volprox kernel: pci 0000:00:1e.0: PCI bridge to [bus 02] Sep 16 19:04:29 volprox kernel: pci 0000:00:1e.0: bridge window [io 0xd000-0xdfff] Sep 16 19:04:29 volprox kernel: pci 0000:00:1e.0: bridge window [mem 0xfe600000-0xfe7fffff] Sep 16 19:04:29 volprox kernel: pci 0000:00:1e.0: bridge window [mem 0xfd200000-0xfd3fffff 64bit pref] Sep 16 19:04:29 volprox kernel: pci 0000:00:1f.0: [1b36:0001] type 01 class 0x060400 conventional PCI bridge Sep 16 19:04:29 volprox kernel: pci 0000:00:1f.0: BAR 0 [mem 0xfeaac000-0xfeaac0ff 64bit] Sep 16 19:04:29 volprox kernel: pci 0000:00:1f.0: PCI bridge to [bus 03] Sep 16 19:04:29 volprox kernel: pci 0000:00:1f.0: bridge window [io 0xc000-0xcfff] Sep 16 19:04:29 volprox kernel: pci 0000:00:1f.0: bridge window [mem 0xfe400000-0xfe5fffff] Sep 16 19:04:29 volprox kernel: pci 0000:00:1f.0: bridge window [mem 0xfd000000-0xfd1fffff 64bit pref] Sep 16 19:04:29 volprox kernel: pci_bus 0000:01: extended config space not accessible Sep 16 19:04:29 volprox kernel: acpiphp: Slot [0] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [1-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [3-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [4-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [5] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [6-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [7-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [8-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [9-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [10-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [11-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [12-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [13-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [14-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [15-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [16-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [17-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [18-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [19-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [20-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [21-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [22-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [23-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [24-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [25-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [26-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [27-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [28-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [29-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [30] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [31] registered Sep 16 19:04:29 volprox kernel: pci 0000:00:05.0: PCI bridge to [bus 01] Sep 16 19:04:29 volprox kernel: pci_bus 0000:02: extended config space not accessible Sep 16 19:04:29 volprox kernel: acpiphp: Slot [0-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [1-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [2-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [3-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [4-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [5-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [6-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [7-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [8-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [9-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [10-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [11-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [12-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [13-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [14-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [15-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [16-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [17-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [18-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [19-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [20-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [21-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [22-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [23-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [24-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [25-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [26-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [27-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [28-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [29-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [30-2] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [31-2] registered Sep 16 19:04:29 volprox kernel: pci 0000:00:1e.0: PCI bridge to [bus 02] Sep 16 19:04:29 volprox kernel: pci_bus 0000:03: extended config space not accessible Sep 16 19:04:29 volprox kernel: acpiphp: Slot [0-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [1-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [2-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [3-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [4-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [5-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [6-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [7-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [8-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [9-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [10-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [11-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [12-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [13-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [14-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [15-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [16-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [17-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [18-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [19-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [20-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [21-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [22-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [23-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [24-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [25-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [26-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [27-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [28-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [29-4] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [30-3] registered Sep 16 19:04:29 volprox kernel: acpiphp: Slot [31-3] registered Sep 16 19:04:29 volprox kernel: pci 0000:00:1f.0: PCI bridge to [bus 03] Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: on NUMA node 0 Sep 16 19:04:29 volprox kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Sep 16 19:04:29 volprox kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Sep 16 19:04:29 volprox kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Sep 16 19:04:29 volprox kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Sep 16 19:04:29 volprox kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Sep 16 19:04:29 volprox kernel: iommu: Default domain type: Translated Sep 16 19:04:29 volprox kernel: iommu: DMA domain TLB invalidation policy: lazy mode Sep 16 19:04:29 volprox kernel: SCSI subsystem initialized Sep 16 19:04:29 volprox kernel: libata version 3.00 loaded. Sep 16 19:04:29 volprox kernel: ACPI: bus type USB registered Sep 16 19:04:29 volprox kernel: usbcore: registered new interface driver usbfs Sep 16 19:04:29 volprox kernel: usbcore: registered new interface driver hub Sep 16 19:04:29 volprox kernel: usbcore: registered new device driver usb Sep 16 19:04:29 volprox kernel: PCI: Using ACPI for IRQ routing Sep 16 19:04:29 volprox kernel: PCI: pci_cache_line_size set to 64 bytes Sep 16 19:04:29 volprox kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Sep 16 19:04:29 volprox kernel: e820: reserve RAM buffer [mem 0xbffde000-0xbfffffff] Sep 16 19:04:29 volprox kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Sep 16 19:04:29 volprox kernel: pci 0000:00:02.0: vgaarb: bridge control possible Sep 16 19:04:29 volprox kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Sep 16 19:04:29 volprox kernel: vgaarb: loaded Sep 16 19:04:29 volprox kernel: hpet: 3 channels of 0 reserved for per-cpu timers Sep 16 19:04:29 volprox kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Sep 16 19:04:29 volprox kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Sep 16 19:04:29 volprox kernel: clocksource: Switched to clocksource kvm-clock Sep 16 19:04:29 volprox kernel: VFS: Disk quotas dquot_6.6.0 Sep 16 19:04:29 volprox kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 16 19:04:29 volprox kernel: pnp: PnP ACPI init Sep 16 19:04:29 volprox kernel: pnp 00:02: [dma 2] Sep 16 19:04:29 volprox kernel: pnp: PnP ACPI: found 4 devices Sep 16 19:04:29 volprox kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Sep 16 19:04:29 volprox kernel: NET: Registered PF_INET protocol family Sep 16 19:04:29 volprox kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 16 19:04:29 volprox kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 16 19:04:29 volprox kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 16 19:04:29 volprox kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 16 19:04:29 volprox kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 16 19:04:29 volprox kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 16 19:04:29 volprox kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 16 19:04:29 volprox kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 16 19:04:29 volprox kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 16 19:04:29 volprox kernel: pci 0000:00:05.0: PCI bridge to [bus 01] Sep 16 19:04:29 volprox kernel: pci 0000:00:05.0: bridge window [io 0xe000-0xefff] Sep 16 19:04:29 volprox kernel: pci 0000:00:05.0: bridge window [mem 0xfe800000-0xfe9fffff] Sep 16 19:04:29 volprox kernel: pci 0000:00:05.0: bridge window [mem 0xfd400000-0xfd5fffff 64bit pref] Sep 16 19:04:29 volprox kernel: pci 0000:00:1e.0: PCI bridge to [bus 02] Sep 16 19:04:29 volprox kernel: pci 0000:00:1e.0: bridge window [io 0xd000-0xdfff] Sep 16 19:04:29 volprox kernel: pci 0000:00:1e.0: bridge window [mem 0xfe600000-0xfe7fffff] Sep 16 19:04:29 volprox kernel: pci 0000:00:1e.0: bridge window [mem 0xfd200000-0xfd3fffff 64bit pref] Sep 16 19:04:29 volprox kernel: pci 0000:00:1f.0: PCI bridge to [bus 03] Sep 16 19:04:29 volprox kernel: pci 0000:00:1f.0: bridge window [io 0xc000-0xcfff] Sep 16 19:04:29 volprox kernel: pci 0000:00:1f.0: bridge window [mem 0xfe400000-0xfe5fffff] Sep 16 19:04:29 volprox kernel: pci 0000:00:1f.0: bridge window [mem 0xfd000000-0xfd1fffff 64bit pref] Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] Sep 16 19:04:29 volprox kernel: pci_bus 0000:00: resource 8 [mem 0x140000000-0x1bfffffff window] Sep 16 19:04:29 volprox kernel: pci_bus 0000:01: resource 0 [io 0xe000-0xefff] Sep 16 19:04:29 volprox kernel: pci_bus 0000:01: resource 1 [mem 0xfe800000-0xfe9fffff] Sep 16 19:04:29 volprox kernel: pci_bus 0000:01: resource 2 [mem 0xfd400000-0xfd5fffff 64bit pref] Sep 16 19:04:29 volprox kernel: pci_bus 0000:02: resource 0 [io 0xd000-0xdfff] Sep 16 19:04:29 volprox kernel: pci_bus 0000:02: resource 1 [mem 0xfe600000-0xfe7fffff] Sep 16 19:04:29 volprox kernel: pci_bus 0000:02: resource 2 [mem 0xfd200000-0xfd3fffff 64bit pref] Sep 16 19:04:29 volprox kernel: pci_bus 0000:03: resource 0 [io 0xc000-0xcfff] Sep 16 19:04:29 volprox kernel: pci_bus 0000:03: resource 1 [mem 0xfe400000-0xfe5fffff] Sep 16 19:04:29 volprox kernel: pci_bus 0000:03: resource 2 [mem 0xfd000000-0xfd1fffff 64bit pref] Sep 16 19:04:29 volprox kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Sep 16 19:04:29 volprox kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Sep 16 19:04:29 volprox kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11 Sep 16 19:04:29 volprox kernel: PCI: CLS 64 bytes, default 64 Sep 16 19:04:29 volprox kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Sep 16 19:04:29 volprox kernel: software IO TLB: mapped [mem 0x00000000bbfde000-0x00000000bffde000] (64MB) Sep 16 19:04:29 volprox kernel: Trying to unpack rootfs image as initramfs... Sep 16 19:04:29 volprox kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x70c75a21ee6, max_idle_ns: 881590662274 ns Sep 16 19:04:29 volprox kernel: Initialise system trusted keyrings Sep 16 19:04:29 volprox kernel: workingset: timestamp_bits=46 max_order=20 bucket_order=0 Sep 16 19:04:29 volprox kernel: Key type asymmetric registered Sep 16 19:04:29 volprox kernel: Asymmetric key parser 'x509' registered Sep 16 19:04:29 volprox kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 16 19:04:29 volprox kernel: io scheduler mq-deadline registered Sep 16 19:04:29 volprox kernel: io scheduler kyber registered Sep 16 19:04:29 volprox kernel: ledtrig-cpu: registered to indicate activity on CPUs Sep 16 19:04:29 volprox kernel: shpchp 0000:00:05.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0.S28_) Sep 16 19:04:29 volprox kernel: shpchp 0000:00:05.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0) Sep 16 19:04:29 volprox kernel: shpchp 0000:00:05.0: Cannot get control of SHPC hotplug Sep 16 19:04:29 volprox kernel: shpchp 0000:00:1e.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0.SF0_) Sep 16 19:04:29 volprox kernel: shpchp 0000:00:1e.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0) Sep 16 19:04:29 volprox kernel: shpchp 0000:00:1e.0: Cannot get control of SHPC hotplug Sep 16 19:04:29 volprox kernel: shpchp 0000:00:1f.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0.SF8_) Sep 16 19:04:29 volprox kernel: shpchp 0000:00:1f.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0) Sep 16 19:04:29 volprox kernel: shpchp 0000:00:1f.0: Cannot get control of SHPC hotplug Sep 16 19:04:29 volprox kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Sep 16 19:04:29 volprox kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 Sep 16 19:04:29 volprox kernel: ACPI: button: Power Button [PWRF] Sep 16 19:04:29 volprox kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Sep 16 19:04:29 volprox kernel: Linux agpgart interface v0.103 Sep 16 19:04:29 volprox kernel: ata_piix 0000:00:01.1: version 2.13 Sep 16 19:04:29 volprox kernel: scsi host0: ata_piix Sep 16 19:04:29 volprox kernel: scsi host1: ata_piix Sep 16 19:04:29 volprox kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xf0a0 irq 14 lpm-pol 0 Sep 16 19:04:29 volprox kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xf0a8 irq 15 lpm-pol 0 Sep 16 19:04:29 volprox kernel: uhci_hcd 0000:00:01.2: UHCI Host Controller Sep 16 19:04:29 volprox kernel: uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 Sep 16 19:04:29 volprox kernel: uhci_hcd 0000:00:01.2: detected 2 ports Sep 16 19:04:29 volprox kernel: uhci_hcd 0000:00:01.2: irq 11, io port 0x0000f040 Sep 16 19:04:29 volprox kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.12 Sep 16 19:04:29 volprox kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Sep 16 19:04:29 volprox kernel: usb usb1: Product: UHCI Host Controller Sep 16 19:04:29 volprox kernel: usb usb1: Manufacturer: Linux 6.12.35-volumio uhci_hcd Sep 16 19:04:29 volprox kernel: usb usb1: SerialNumber: 0000:00:01.2 Sep 16 19:04:29 volprox kernel: hub 1-0:1.0: USB hub found Sep 16 19:04:29 volprox kernel: hub 1-0:1.0: 2 ports detected Sep 16 19:04:29 volprox kernel: usbcore: registered new interface driver usb-storage Sep 16 19:04:29 volprox kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Sep 16 19:04:29 volprox kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Sep 16 19:04:29 volprox kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Sep 16 19:04:29 volprox kernel: mousedev: PS/2 mouse device common for all mice Sep 16 19:04:29 volprox kernel: rtc_cmos 00:03: RTC can wake from S4 Sep 16 19:04:29 volprox kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 Sep 16 19:04:29 volprox kernel: rtc_cmos 00:03: registered as rtc0 Sep 16 19:04:29 volprox kernel: rtc_cmos 00:03: setting system clock to 2025-09-16T10:04:18 UTC (1758017058) Sep 16 19:04:29 volprox kernel: rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Sep 16 19:04:29 volprox kernel: i2c_dev: i2c /dev entries driver Sep 16 19:04:29 volprox kernel: intel_pstate: CPU model not supported Sep 16 19:04:29 volprox kernel: hid: raw HID events driver (C) Jiri Kosina Sep 16 19:04:29 volprox kernel: NET: Registered PF_INET6 protocol family Sep 16 19:04:29 volprox kernel: Segment Routing with IPv6 Sep 16 19:04:29 volprox kernel: In-situ OAM (IOAM) with IPv6 Sep 16 19:04:29 volprox kernel: mip6: Mobile IPv6 Sep 16 19:04:29 volprox kernel: NET: Registered PF_PACKET protocol family Sep 16 19:04:29 volprox kernel: mpls_gso: MPLS GSO support Sep 16 19:04:29 volprox kernel: IPI shorthand broadcast: enabled Sep 16 19:04:29 volprox kernel: sched_clock: Marking stable (341655110, 6315896)->(352111570, -4140564) Sep 16 19:04:29 volprox kernel: Loading compiled-in X.509 certificates Sep 16 19:04:29 volprox kernel: clk: Disabling unused clocks Sep 16 19:04:29 volprox kernel: PM: genpd: Disabling unused power domains Sep 16 19:04:29 volprox kernel: ata2: found unknown device (class 0) Sep 16 19:04:29 volprox kernel: ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Sep 16 19:04:29 volprox kernel: scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Sep 16 19:04:29 volprox kernel: usb 1-1: new full-speed USB device number 2 using uhci_hcd Sep 16 19:04:29 volprox kernel: usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 Sep 16 19:04:29 volprox kernel: usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 Sep 16 19:04:29 volprox kernel: usb 1-1: Product: QEMU USB Tablet Sep 16 19:04:29 volprox kernel: usb 1-1: Manufacturer: QEMU Sep 16 19:04:29 volprox kernel: usb 1-1: SerialNumber: 28754-0000:00:01.2-1 Sep 16 19:04:29 volprox kernel: Freeing initrd memory: 78084K Sep 16 19:04:29 volprox kernel: Freeing unused kernel image (initmem) memory: 3124K Sep 16 19:04:29 volprox kernel: Write protecting the kernel read-only data: 22528k Sep 16 19:04:29 volprox kernel: Freeing unused kernel image (rodata/data gap) memory: 788K Sep 16 19:04:29 volprox kernel: Run /init as init process Sep 16 19:04:29 volprox kernel: with arguments: Sep 16 19:04:29 volprox kernel: /init Sep 16 19:04:29 volprox kernel: splash Sep 16 19:04:29 volprox kernel: with environment: Sep 16 19:04:29 volprox kernel: HOME=/ Sep 16 19:04:29 volprox kernel: TERM=linux Sep 16 19:04:29 volprox kernel: BOOT_IMAGE=vmlinuz Sep 16 19:04:29 volprox kernel: bootdelay=5 Sep 16 19:04:29 volprox kernel: biosdevname=0 Sep 16 19:04:29 volprox kernel: imgpart=UUID=3ddf10b5-43a4-45f6-a8fa-fde595f0bef6 Sep 16 19:04:29 volprox kernel: bootpart=UUID=14E6-4F3A Sep 16 19:04:29 volprox kernel: datapart=UUID=33973cba-33c1-4101-a3cf-953d0681254b Sep 16 19:04:29 volprox kernel: hwdevice=x86 Sep 16 19:04:29 volprox kernel: uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg Sep 16 19:04:29 volprox kernel: imgfile=/volumio_current.sqsh Sep 16 19:04:29 volprox kernel: use_kmsg=no Sep 16 19:04:29 volprox kernel: e1000e: Intel(R) PRO/1000 Network Driver Sep 16 19:04:29 volprox kernel: e1000e: Copyright(c) 1999 - 2015 Intel Corporation. Sep 16 19:04:29 volprox kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 10 Sep 16 19:04:29 volprox kernel: e1000e 0000:00:12.0: Interrupt Throttling Rate (ints/sec) set to dynamic conservative mode Sep 16 19:04:29 volprox kernel: FDC 0 is a S82078B Sep 16 19:04:29 volprox kernel: ahci 0000:00:07.0: version 3.0 Sep 16 19:04:29 volprox kernel: ACPI: bus type drm_connector registered Sep 16 19:04:29 volprox kernel: input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 Sep 16 19:04:29 volprox kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Sep 16 19:04:29 volprox kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 Sep 16 19:04:29 volprox kernel: input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 Sep 16 19:04:29 volprox kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Sep 16 19:04:29 volprox kernel: ahci 0000:00:07.0: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Sep 16 19:04:29 volprox kernel: ahci 0000:00:07.0: 6/6 ports implemented (port mask 0x3f) Sep 16 19:04:29 volprox kernel: ahci 0000:00:07.0: flags: 64bit ncq only Sep 16 19:04:29 volprox kernel: usbcore: registered new interface driver usbhid Sep 16 19:04:29 volprox kernel: usbhid: USB HID core driver Sep 16 19:04:29 volprox kernel: bochs-drm 0000:00:02.0: vgaarb: deactivate vga console Sep 16 19:04:29 volprox kernel: Console: switching to colour dummy device 80x25 Sep 16 19:04:29 volprox kernel: scsi host2: ahci Sep 16 19:04:29 volprox kernel: [drm] Found bochs VGA, ID 0xb0c5. Sep 16 19:04:29 volprox kernel: [drm] Framebuffer size 16384 kB @ 0xfc000000, mmio @ 0xfeaa8000. Sep 16 19:04:29 volprox kernel: [drm] Found EDID data blob. Sep 16 19:04:29 volprox kernel: [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 Sep 16 19:04:29 volprox kernel: fbcon: bochs-drmdrmfb (fb0) is primary device Sep 16 19:04:29 volprox kernel: scsi host3: ahci Sep 16 19:04:29 volprox kernel: Console: switching to colour frame buffer device 160x50 Sep 16 19:04:29 volprox kernel: bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device Sep 16 19:04:29 volprox kernel: scsi host4: ahci Sep 16 19:04:29 volprox kernel: scsi host5: ahci Sep 16 19:04:29 volprox kernel: input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input5 Sep 16 19:04:29 volprox kernel: scsi host6: ahci Sep 16 19:04:29 volprox kernel: hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0 Sep 16 19:04:29 volprox kernel: scsi host7: ahci Sep 16 19:04:29 volprox kernel: ata3: SATA max UDMA/133 abar m4096@0xfeaaa000 port 0xfeaaa100 irq 27 lpm-pol 0 Sep 16 19:04:29 volprox kernel: ata4: SATA max UDMA/133 abar m4096@0xfeaaa000 port 0xfeaaa180 irq 27 lpm-pol 0 Sep 16 19:04:29 volprox kernel: ata5: SATA max UDMA/133 abar m4096@0xfeaaa000 port 0xfeaaa200 irq 27 lpm-pol 0 Sep 16 19:04:29 volprox kernel: ata6: SATA max UDMA/133 abar m4096@0xfeaaa000 port 0xfeaaa280 irq 27 lpm-pol 0 Sep 16 19:04:29 volprox kernel: ata7: SATA max UDMA/133 abar m4096@0xfeaaa000 port 0xfeaaa300 irq 27 lpm-pol 0 Sep 16 19:04:29 volprox kernel: ata8: SATA max UDMA/133 abar m4096@0xfeaaa000 port 0xfeaaa380 irq 27 lpm-pol 0 Sep 16 19:04:29 volprox kernel: sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Sep 16 19:04:29 volprox kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 16 19:04:29 volprox kernel: sr 1:0:0:0: Attached scsi CD-ROM sr0 Sep 16 19:04:29 volprox kernel: e1000e 0000:00:12.0 eth0: (PCI Express:2.5GT/s:Width x1) bc:24:11:d8:93:66 Sep 16 19:04:29 volprox kernel: e1000e 0000:00:12.0 eth0: Intel(R) PRO/1000 Network Connection Sep 16 19:04:29 volprox kernel: e1000e 0000:00:12.0 eth0: MAC: 3, PHY: 8, PBA No: 000000-000 Sep 16 19:04:29 volprox kernel: ata7: SATA link down (SStatus 0 SControl 300) Sep 16 19:04:29 volprox kernel: ata4: SATA link down (SStatus 0 SControl 300) Sep 16 19:04:29 volprox kernel: ata8: SATA link down (SStatus 0 SControl 300) Sep 16 19:04:29 volprox kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 16 19:04:29 volprox kernel: ata5: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 16 19:04:29 volprox kernel: ata6: SATA link down (SStatus 0 SControl 300) Sep 16 19:04:29 volprox kernel: ata3.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100 Sep 16 19:04:29 volprox kernel: ata3.00: 12525568 sectors, multi 16: LBA48 NCQ (depth 32) Sep 16 19:04:29 volprox kernel: ata3.00: applying bridge limits Sep 16 19:04:29 volprox kernel: ata5.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100 Sep 16 19:04:29 volprox kernel: ata5.00: 23011328 sectors, multi 16: LBA48 NCQ (depth 32) Sep 16 19:04:29 volprox kernel: ata5.00: applying bridge limits Sep 16 19:04:29 volprox kernel: ata3.00: configured for UDMA/100 Sep 16 19:04:29 volprox kernel: ata5.00: configured for UDMA/100 Sep 16 19:04:29 volprox kernel: scsi 2:0:0:0: Direct-Access ATA QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 Sep 16 19:04:29 volprox kernel: scsi 4:0:0:0: Direct-Access ATA QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 Sep 16 19:04:29 volprox kernel: sd 2:0:0:0: [sda] 12525568 512-byte logical blocks: (6.41 GB/5.97 GiB) Sep 16 19:04:29 volprox kernel: sd 2:0:0:0: [sda] Write Protect is off Sep 16 19:04:29 volprox kernel: sd 2:0:0:0: [sda] Mode Sense: 00 3a 00 00 Sep 16 19:04:29 volprox kernel: sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Sep 16 19:04:29 volprox kernel: sd 2:0:0:0: [sda] Preferred minimum I/O size 512 bytes Sep 16 19:04:29 volprox kernel: sd 4:0:0:0: [sdb] 23011328 512-byte logical blocks: (11.8 GB/11.0 GiB) Sep 16 19:04:29 volprox kernel: sd 4:0:0:0: [sdb] Write Protect is off Sep 16 19:04:29 volprox kernel: sd 4:0:0:0: [sdb] Mode Sense: 00 3a 00 00 Sep 16 19:04:29 volprox kernel: sd 4:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Sep 16 19:04:29 volprox kernel: sd 4:0:0:0: [sdb] Preferred minimum I/O size 512 bytes Sep 16 19:04:29 volprox kernel: sdb: sdb1 sdb2 sdb3 Sep 16 19:04:29 volprox kernel: sd 4:0:0:0: [sdb] Attached SCSI disk Sep 16 19:04:29 volprox kernel: sda: sda1 sda2 sda3 Sep 16 19:04:29 volprox kernel: sd 2:0:0:0: [sda] Attached SCSI disk Sep 16 19:04:29 volprox kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 16 19:04:29 volprox kernel: sdhci: Secure Digital Host Controller Interface driver Sep 16 19:04:29 volprox kernel: sdhci: Copyright(c) Pierre Ossman Sep 16 19:04:29 volprox kernel: fuse: init (API version 7.41) Sep 16 19:04:29 volprox kernel: usbcore: registered new interface driver uas Sep 16 19:04:29 volprox kernel: i915.modeset=1 is deprecated. Please remove it and the 'nomodeset' kernel parameter instead. Sep 16 19:04:29 volprox kernel: [drm] radeon kernel modesetting enabled. Sep 16 19:04:29 volprox kernel: random: crng init done Sep 16 19:04:29 volprox kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Sep 16 19:04:29 volprox kernel: EXT4-fs (sda2): recovery complete Sep 16 19:04:29 volprox kernel: EXT4-fs (sda2): mounted filesystem 3ddf10b5-43a4-45f6-a8fa-fde595f0bef6 r/w with ordered data mode. Quota mode: none. Sep 16 19:04:29 volprox kernel: loop: module loaded Sep 16 19:04:29 volprox kernel: block device autoloading is deprecated and will be removed. Sep 16 19:04:29 volprox kernel: loop0: detected capacity change from 0 to 2322184 Sep 16 19:04:29 volprox kernel: EXT4-fs (sda3): recovery complete Sep 16 19:04:29 volprox kernel: EXT4-fs (sda3): mounted filesystem 33973cba-33c1-4101-a3cf-953d0681254b r/w with ordered data mode. Quota mode: none. Sep 16 19:04:29 volprox systemd[1]: Inserted module 'autofs4' Sep 16 19:04:29 volprox systemd[1]: systemd 252.36-1~deb12u1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Sep 16 19:04:29 volprox systemd[1]: Detected virtualization kvm. Sep 16 19:04:29 volprox systemd[1]: Detected architecture x86-64. Sep 16 19:04:29 volprox systemd[1]: Hostname set to . Sep 16 19:04:29 volprox systemd[1]: Queued start job for default target graphical.target. Sep 16 19:04:29 volprox systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 16 19:04:29 volprox systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 16 19:04:29 volprox systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 16 19:04:29 volprox systemd[1]: Created slice user.slice - User and Session Slice. Sep 16 19:04:29 volprox systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 16 19:04:29 volprox systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 16 19:04:29 volprox systemd[1]: Expecting device dev-disk-by\x2duuid-14E6\x2d4F3A.device - /dev/disk/by-uuid/14E6-4F3A... Sep 16 19:04:29 volprox systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 16 19:04:29 volprox systemd[1]: Reached target slices.target - Slice Units. Sep 16 19:04:29 volprox systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 16 19:04:29 volprox systemd[1]: Listening on rpcbind.socket - RPCbind Server Activation Socket. Sep 16 19:04:29 volprox systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket. Sep 16 19:04:29 volprox systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. Sep 16 19:04:29 volprox systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 16 19:04:29 volprox systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 16 19:04:29 volprox systemd[1]: Listening on systemd-journald.socket - Journal Socket. Sep 16 19:04:29 volprox systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 16 19:04:29 volprox systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 16 19:04:29 volprox systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 16 19:04:29 volprox systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 16 19:04:29 volprox systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 16 19:04:29 volprox systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 16 19:04:29 volprox systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Sep 16 19:04:29 volprox systemd[1]: Started dynamicswap.service - dynamicswap service. Sep 16 19:04:29 volprox systemd[1]: Reached target swap.target - Swaps. Sep 16 19:04:29 volprox systemd[1]: Starting fake-hwclock.service - Restore / save the current clock... Sep 16 19:04:29 volprox systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 16 19:04:29 volprox systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 16 19:04:29 volprox systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 16 19:04:29 volprox systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 16 19:04:29 volprox systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 16 19:04:29 volprox systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 16 19:04:29 volprox systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 16 19:04:29 volprox systemd[1]: Starting systemd-journald.service - Journal Service... Sep 16 19:04:29 volprox systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 16 19:04:29 volprox systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 16 19:04:29 volprox systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 16 19:04:29 volprox systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 16 19:04:29 volprox systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 16 19:04:29 volprox systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 16 19:04:29 volprox systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 16 19:04:29 volprox systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 16 19:04:29 volprox systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 16 19:04:29 volprox systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 16 19:04:29 volprox systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 16 19:04:29 volprox systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 16 19:04:29 volprox systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 16 19:04:29 volprox systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 16 19:04:29 volprox systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 16 19:04:29 volprox systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 16 19:04:29 volprox systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 16 19:04:29 volprox systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 16 19:04:29 volprox systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 16 19:04:29 volprox systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 16 19:04:29 volprox systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 16 19:04:29 volprox systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 16 19:04:29 volprox systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 16 19:04:29 volprox systemd[1]: Finished fake-hwclock.service - Restore / save the current clock. Sep 16 19:04:29 volprox systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 16 19:04:29 volprox systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 16 19:04:29 volprox systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 16 19:04:29 volprox systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Sep 16 19:04:29 volprox systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 16 19:04:29 volprox systemd[1]: Starting systemd-random-seed.service - Load/Save Random Seed... Sep 16 19:04:29 volprox systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 16 19:04:29 volprox systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 16 19:04:29 volprox systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 16 19:04:29 volprox systemd[1]: Finished systemd-random-seed.service - Load/Save Random Seed. Sep 16 19:04:29 volprox systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Sep 16 19:04:29 volprox systemd[1]: dynamicswap.service: Deactivated successfully. Sep 16 19:04:29 volprox systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 16 19:04:29 volprox systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 16 19:04:29 volprox systemd-journald[505]: Journal started Sep 16 19:04:29 volprox systemd-journald[505]: Runtime Journal (/run/log/journal/224f84478981b180c46d984d68846101) is 3.7M, max 30.0M, 26.2M free. Sep 16 19:04:29 volprox fake-hwclock[496]: Current system time: 2025-09-16 10:04:29 Sep 16 19:04:29 volprox fake-hwclock[496]: fake-hwclock saved clock information is in the past: 2025-09-16 09:53:35 Sep 16 19:04:29 volprox fake-hwclock[496]: To set system time to this saved clock anyway, use "force" Sep 16 19:04:29 volprox systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 16 19:04:29 volprox systemd[1]: Started systemd-journald.service - Journal Service. Sep 16 19:04:29 volprox systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 16 19:04:29 volprox systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 16 19:04:29 volprox systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Sep 16 19:04:29 volprox systemd[1]: Mounting tmp.mount - /tmp... Sep 16 19:04:29 volprox systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Sep 16 19:04:29 volprox systemd[1]: Mounting var-log.mount - /var/log... Sep 16 19:04:29 volprox systemd[1]: Mounting var-spool-cups.mount - /var/spool/cups... Sep 16 19:04:29 volprox systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 16 19:04:29 volprox systemd[1]: Mounted tmp.mount - /tmp. Sep 16 19:04:29 volprox systemd[1]: Mounted var-log.mount - /var/log. Sep 16 19:04:29 volprox systemd[1]: Mounted var-spool-cups.mount - /var/spool/cups. Sep 16 19:04:29 volprox systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 16 19:04:29 volprox systemd-journald[505]: Runtime Journal (/run/log/journal/224f84478981b180c46d984d68846101) is 3.7M, max 30.0M, 26.2M free. Sep 16 19:04:29 volprox systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 16 19:04:29 volprox systemd-journald[505]: Received client request to flush runtime journal. Sep 16 19:04:29 volprox systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 16 19:04:29 volprox systemd[1]: Starting ifupdown-pre.service - Helper to synchronize boot up for ifupdown... Sep 16 19:04:29 volprox systemd[1]: Finished ifupdown-pre.service - Helper to synchronize boot up for ifupdown. Sep 16 19:04:30 volprox systemd-udevd[532]: Using default interface naming scheme 'v252'. Sep 16 19:04:30 volprox systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 16 19:04:30 volprox systemd[1]: Starting plymouth-start.service - Show Plymouth Boot Screen... Sep 16 19:04:30 volprox (udev-worker)[543]: Network interface NamePolicy= disabled on kernel command line. Sep 16 19:04:30 volprox systemd[1]: Started plymouth-start.service - Show Plymouth Boot Screen. Sep 16 19:04:30 volprox systemd[1]: systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch was skipped because of an unmet condition check (ConditionPathExists=!/run/plymouth/pid). Sep 16 19:04:30 volprox systemd[1]: Started systemd-ask-password-plymouth.path - Forward Password Requests to Plymouth Directory Watch. Sep 16 19:04:30 volprox systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 16 19:04:30 volprox kernel: sr 1:0:0:0: Attached scsi generic sg0 type 5 Sep 16 19:04:30 volprox kernel: sd 2:0:0:0: Attached scsi generic sg1 type 0 Sep 16 19:04:30 volprox kernel: sd 4:0:0:0: Attached scsi generic sg2 type 0 Sep 16 19:04:30 volprox systemd[1]: Expecting device sys-subsystem-net-devices-eth0.device - /sys/subsystem/net/devices/eth0... Sep 16 19:04:30 volprox systemd[1]: Found device sys-subsystem-net-devices-eth0.device - 82574L Gigabit Network Connection. Sep 16 19:04:30 volprox systemd[1]: Found device dev-disk-by\x2duuid-14E6\x2d4F3A.device - QEMU_HARDDISK boot. Sep 16 19:04:30 volprox systemd[1]: Starting systemd-fsck@dev-disk-by\x2duuid-14E6\x2d4F3A.service - File System Check on /dev/disk/by-uuid/14E6-4F3A... Sep 16 19:04:30 volprox systemd[1]: Started systemd-fsckd.service - File System Check Daemon to report status. Sep 16 19:04:30 volprox systemd-fsck[584]: fsck.fat 4.2 (2021-01-31) Sep 16 19:04:30 volprox systemd-fsck[584]: /dev/sda1: 20 files, 22600/93500 clusters Sep 16 19:04:30 volprox systemd[1]: Finished systemd-fsck@dev-disk-by\x2duuid-14E6\x2d4F3A.service - File System Check on /dev/disk/by-uuid/14E6-4F3A. Sep 16 19:04:30 volprox kernel: cryptd: max_cpu_qlen set to 1000 Sep 16 19:04:30 volprox systemd[1]: Listening on systemd-rfkill.socket - Load/Save RF Kill Switch Status /dev/rfkill Watch. Sep 16 19:04:30 volprox kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Sep 16 19:04:30 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC887-VD: line_outs=1 (0x14/0x0/0x0/0x0/0x0) type:line Sep 16 19:04:30 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Sep 16 19:04:30 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: hp_outs=1 (0x1b/0x0/0x0/0x0/0x0) Sep 16 19:04:30 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0 Sep 16 19:04:30 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: dig-out=0x11/0x0 Sep 16 19:04:30 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: inputs: Sep 16 19:04:30 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: Rear Mic=0x18 Sep 16 19:04:30 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: Front Mic=0x19 Sep 16 19:04:30 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: Line=0x1a Sep 16 19:04:30 volprox kernel: snd_hda_codec_hdmi hdaudioC0D2: No i915 binding for Intel HDMI/DP codec Sep 16 19:04:30 volprox kernel: hdaudio hdaudioC0D2: Unable to configure, disabling Sep 16 19:04:30 volprox kernel: input: HDA Intel PCH Rear Mic as /devices/pci0000:00/0000:00:11.0/sound/card0/input6 Sep 16 19:04:30 volprox kernel: input: HDA Intel PCH Front Mic as /devices/pci0000:00/0000:00:11.0/sound/card0/input7 Sep 16 19:04:30 volprox kernel: input: HDA Intel PCH Line as /devices/pci0000:00/0000:00:11.0/sound/card0/input8 Sep 16 19:04:30 volprox kernel: input: HDA Intel PCH Line Out as /devices/pci0000:00/0000:00:11.0/sound/card0/input9 Sep 16 19:04:30 volprox kernel: input: HDA Intel PCH Front Headphone as /devices/pci0000:00/0000:00:11.0/sound/card0/input10 Sep 16 19:04:30 volprox systemd[1]: systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch was skipped because of an unmet condition check (ConditionPathExists=!/run/plymouth/pid). Sep 16 19:04:30 volprox systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 16 19:04:30 volprox systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 16 19:04:30 volprox systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 16 19:04:30 volprox systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Sep 16 19:04:30 volprox systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Sep 16 19:04:30 volprox systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 16 19:04:30 volprox systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 16 19:04:30 volprox systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 16 19:04:30 volprox systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 16 19:04:30 volprox systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 16 19:04:30 volprox systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 16 19:04:30 volprox systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 16 19:04:30 volprox systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 16 19:04:30 volprox systemd[1]: Mounting boot.mount - /boot... Sep 16 19:04:30 volprox systemd[1]: Mounting var-spool-cups-tmp.mount - /var/spool/cups/tmp... Sep 16 19:04:30 volprox kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Sep 16 19:04:30 volprox systemd[1]: Mounted boot.mount - /boot. Sep 16 19:04:30 volprox systemd[1]: Mounted var-spool-cups-tmp.mount - /var/spool/cups/tmp. Sep 16 19:04:30 volprox systemd[1]: Reached target local-fs.target - Local File Systems. Sep 16 19:04:30 volprox systemd[1]: Started ifup@eth0.service - ifup for eth0. Sep 16 19:04:30 volprox systemd[1]: Starting networking.service - Raise network interfaces... Sep 16 19:04:30 volprox systemd[1]: Starting plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data... Sep 16 19:04:30 volprox systemd[1]: Starting systemd-binfmt.service - Set Up Additional Binary Formats... Sep 16 19:04:30 volprox systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Sep 16 19:04:30 volprox systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 16 19:04:30 volprox systemd[1]: Received SIGRTMIN+20 from PID 359 (plymouthd). Sep 16 19:04:30 volprox systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 659 (systemd-binfmt) Sep 16 19:04:30 volprox systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Sep 16 19:04:30 volprox systemd[1]: Finished plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data. Sep 16 19:04:30 volprox systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Sep 16 19:04:30 volprox systemd[1]: Finished systemd-binfmt.service - Set Up Additional Binary Formats. Sep 16 19:04:30 volprox systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 16 19:04:30 volprox systemd[1]: Mounting run-rpc_pipefs.mount - RPC Pipe File System... Sep 16 19:04:30 volprox systemd[1]: Started haveged.service - Entropy Daemon based on the HAVEGE algorithm. Sep 16 19:04:30 volprox systemd[1]: Starting rpcbind.service - RPC bind portmap service... Sep 16 19:04:30 volprox kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Sep 16 19:04:30 volprox systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 16 19:04:30 volprox kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Sep 16 19:04:30 volprox kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Sep 16 19:04:30 volprox sh[670]: command failed: No such device (-19) Sep 16 19:04:30 volprox systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 16 19:04:30 volprox systemd[1]: Reached target sysinit.target - System Initialization. Sep 16 19:04:30 volprox ifup[669]: command failed: No such device (-19) Sep 16 19:04:30 volprox haveged[678]: haveged: command socket is listening at fd 3 Sep 16 19:04:30 volprox systemd[1]: Started acpid.path - ACPI Events Check. Sep 16 19:04:30 volprox systemd[1]: Started apt-daily.timer - Daily apt download activities. Sep 16 19:04:30 volprox systemd[1]: Started apt-daily-upgrade.timer - Daily apt upgrade and clean activities. Sep 16 19:04:30 volprox systemd[1]: Started dpkg-db-backup.timer - Daily dpkg database backup timer. Sep 16 19:04:30 volprox systemd[1]: Started e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems. Sep 16 19:04:30 volprox systemd[1]: Started fstrim.timer - Discard unused blocks once a week. Sep 16 19:04:30 volprox systemd[1]: Started man-db.timer - Daily man-db regeneration. Sep 16 19:04:30 volprox systemd[1]: Started ntpsec-rotate-stats.timer - Rotate ntpd stats daily. Sep 16 19:04:30 volprox systemd[1]: Started setdatetime-helper.timer - Volumio Time Sync Watchdog Timer. Sep 16 19:04:30 volprox systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 16 19:04:30 volprox systemd[1]: Reached target paths.target - Path Units. Sep 16 19:04:30 volprox systemd[1]: Reached target timers.target - Timer Units. Sep 16 19:04:31 volprox systemd[1]: Listening on acpid.socket - ACPID Listen Socket. Sep 16 19:04:31 volprox systemd[1]: Listening on avahi-daemon.socket - Avahi mDNS/DNS-SD Stack Activation Socket. Sep 16 19:04:31 volprox systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 16 19:04:31 volprox systemd[1]: Reached target sockets.target - Socket Units. Sep 16 19:04:31 volprox systemd[1]: systemd-pcrphase-sysinit.service - TPM2 PCR Barrier (Initialization) was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Sep 16 19:04:31 volprox systemd[1]: Reached target basic.target - Basic System. Sep 16 19:04:31 volprox kernel: RPC: Registered named UNIX socket transport module. Sep 16 19:04:31 volprox kernel: RPC: Registered udp transport module. Sep 16 19:04:31 volprox kernel: RPC: Registered tcp transport module. Sep 16 19:04:31 volprox kernel: RPC: Registered tcp-with-tls transport module. Sep 16 19:04:31 volprox kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Sep 16 19:04:31 volprox systemd[1]: Started acpid.service - ACPI event daemon. Sep 16 19:04:31 volprox systemd[1]: alsa-state.service - Manage Sound Card State (restore and store) was skipped because of an unmet condition check (ConditionPathExists=/etc/alsa/state-daemon.conf). Sep 16 19:04:31 volprox systemd[1]: Starting alsa-restore.service - Save/Restore Sound Card State... Sep 16 19:04:31 volprox systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Sep 16 19:04:31 volprox systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 16 19:04:31 volprox sh[706]: dhcpcd-9.4.1 starting Sep 16 19:04:31 volprox dhcpcd[706]: dhcpcd-9.4.1 starting Sep 16 19:04:31 volprox systemd[1]: Starting e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots... Sep 16 19:04:31 volprox sh[706]: DUID 00:04:43:5c:66:39:d9:0b:46:78:8d:da:27:66:66:31:a1:b5 Sep 16 19:04:31 volprox dhcpcd[725]: DUID 00:04:43:5c:66:39:d9:0b:46:78:8d:da:27:66:66:31:a1:b5 Sep 16 19:04:31 volprox systemd[1]: getty-static.service - getty on tty2-tty6 if dbus and logind are not available was skipped because of an unmet condition check (ConditionPathExists=!/usr/bin/dbus-daemon). Sep 16 19:04:31 volprox systemd[1]: headless_wireless.service - Copy user wpa_supplicant.conf was skipped because of an unmet condition check (ConditionPathExists=/boot/wpa_supplicant.conf). Sep 16 19:04:31 volprox systemd[1]: Started iptables.service - Volumio Iptables Module. Sep 16 19:04:31 volprox ifup[716]: command failed: No such device (-19) Sep 16 19:04:31 volprox systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Sep 16 19:04:31 volprox systemd[1]: Starting systemd-logind.service - User Login Management... Sep 16 19:04:31 volprox systemd[1]: Starting triggerhappy.service - triggerhappy global hotkey daemon... Sep 16 19:04:31 volprox mpd_monitor.sh[730]: MPD Monitor Service: Starting MPD Monitor Service Sep 16 19:04:31 volprox systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Sep 16 19:04:31 volprox systemd[1]: Started volumio-remote-updater.service - Volumio Remote OTA Updater. Sep 16 19:04:31 volprox systemd[1]: Starting volumio_rfkill_unblock.service - Manage nl80211 modules blocking state... Sep 16 19:04:31 volprox systemd[1]: volumiossh.service - Volumio SSH enabler was skipped because of an unmet condition check (ConditionPathExistsGlob=/boot/ssh{,.txt}). Sep 16 19:04:31 volprox systemd[1]: Starting wireless.service - Wireless Services... Sep 16 19:04:31 volprox systemd[1]: Mounted run-rpc_pipefs.mount - RPC Pipe File System. Sep 16 19:04:31 volprox systemd[1]: Reached target rpc_pipefs.target. Sep 16 19:04:31 volprox systemd[1]: rpc-gssd.service - RPC security service for NFS client and server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Sep 16 19:04:31 volprox systemd[1]: Reached target nfs-client.target - NFS client services. Sep 16 19:04:31 volprox systemd[1]: Started rpcbind.service - RPC bind portmap service. Sep 16 19:04:31 volprox systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 16 19:04:31 volprox systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 16 19:04:31 volprox systemd[1]: Reached target rpcbind.target - RPC Port Mapper. Sep 16 19:04:31 volprox systemd[1]: Starting loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling... Sep 16 19:04:31 volprox systemd[1]: systemd-pcrphase.service - TPM2 PCR Barrier (User) was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Sep 16 19:04:31 volprox kernel: 8021q: 802.1Q VLAN Support v1.8 Sep 16 19:04:31 volprox systemd[1]: Finished alsa-restore.service - Save/Restore Sound Card State. Sep 16 19:04:31 volprox systemd[1]: Reached target sound.target - Sound Card. Sep 16 19:04:31 volprox volumio_rfkill_unblock.sh[740]: Volumio WiFi Soft Blocked check script Sep 16 19:04:31 volprox volumio_rfkill_unblock.sh[740]: Check if rfkill is available Sep 16 19:04:31 volprox systemd[1]: e2scrub_reap.service: Deactivated successfully. Sep 16 19:04:31 volprox systemd[1]: Finished e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots. Sep 16 19:04:31 volprox volumio_rfkill_unblock.sh[740]: Check if rfkill listed devices are already unblocked Sep 16 19:04:31 volprox systemd[1]: Started triggerhappy.service - triggerhappy global hotkey daemon. Sep 16 19:04:31 volprox avahi-daemon[719]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Sep 16 19:04:31 volprox avahi-daemon[719]: Successfully dropped root privileges. Sep 16 19:04:31 volprox avahi-daemon[719]: avahi-daemon 0.8 starting up. Sep 16 19:04:31 volprox systemd[1]: Starting th-udev-rebind.service - Late rebind of input devices to triggerhappy... Sep 16 19:04:31 volprox volumio_rfkill_unblock.sh[740]: Wi-Fi is already unblocked. Sep 16 19:04:31 volprox systemd[1]: Finished volumio_rfkill_unblock.service - Manage nl80211 modules blocking state. Sep 16 19:04:31 volprox systemd[1]: Starting dhcpcd.service - DHCP Client Daemon on all interfaces... Sep 16 19:04:31 volprox acpid[696]: starting up with netlink and the input layer Sep 16 19:04:31 volprox mpd_monitor.sh[743]: MPD error: Connection refused Sep 16 19:04:31 volprox mpd_monitor.sh[730]: MPD Monitor Service: MPD Appears to be inactive, restarting Sep 16 19:04:31 volprox systemd-logind[735]: New seat seat0. Sep 16 19:04:31 volprox th-udev-rebind.sh[755]: Rebinding /dev/input/event0 to thd using --add... Sep 16 19:04:31 volprox haveged[678]: haveged: ver: 1.9.14; arch: x86; vend: GenuineIntel; build: (gcc 12.2.0 ITV); collect: 128K Sep 16 19:04:31 volprox haveged[678]: haveged: cpu: (L4 VC); data: 32K (L2 L4 V); inst: 32K (L2 L4 V); idx: 24/40; sz: 32010/53875 Sep 16 19:04:31 volprox haveged[678]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.9969 Sep 16 19:04:31 volprox haveged[678]: haveged: fills: 0, generated: 0 Sep 16 19:04:31 volprox systemd-logind[735]: Watching system buttons on /dev/input/event0 (Power Button) Sep 16 19:04:31 volprox systemd-logind[735]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Sep 16 19:04:31 volprox mpd_monitor.sh[760]: mpd: no process found Sep 16 19:04:31 volprox acpid[696]: 3 rules loaded Sep 16 19:04:31 volprox acpid[696]: waiting for events: event logging is off Sep 16 19:04:31 volprox th-udev-rebind.sh[755]: Rebinding /dev/input/event1 to thd using --add... Sep 16 19:04:31 volprox dhcpcd[757]: dhcpcd-9.4.1 starting Sep 16 19:04:31 volprox th-udev-rebind.sh[755]: Rebinding /dev/input/event2 to thd using --add... Sep 16 19:04:31 volprox th-udev-rebind.sh[755]: Rebinding /dev/input/event3 to thd using --add... Sep 16 19:04:31 volprox th-udev-rebind.sh[755]: Rebinding /dev/input/event4 to thd using --add... Sep 16 19:04:31 volprox th-udev-rebind.sh[755]: Rebinding /dev/input/event5 to thd using --add... Sep 16 19:04:31 volprox th-udev-rebind.sh[755]: Rebinding /dev/input/event6 to thd using --add... Sep 16 19:04:31 volprox th-udev-rebind.sh[755]: Rebinding /dev/input/event7 to thd using --add... Sep 16 19:04:31 volprox th-udev-rebind.sh[755]: Rebinding /dev/input/event8 to thd using --add... Sep 16 19:04:31 volprox th-udev-rebind.sh[755]: Rebinding /dev/input/event9 to thd using --add... Sep 16 19:04:31 volprox dhcpcd[772]: dev: loaded udev Sep 16 19:04:31 volprox dhcpcd[772]: DUID 00:04:43:5c:66:39:d9:0b:46:78:8d:da:27:66:66:31:a1:b5 Sep 16 19:04:31 volprox systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 19:04:31 volprox systemd[1]: th-udev-rebind.service: Deactivated successfully. Sep 16 19:04:31 volprox systemd[1]: Finished th-udev-rebind.service - Late rebind of input devices to triggerhappy. Sep 16 19:04:31 volprox systemd[1]: Started dhcpcd.service - DHCP Client Daemon on all interfaces. Sep 16 19:04:31 volprox systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 16 19:04:31 volprox avahi-daemon[719]: Successfully called chroot(). Sep 16 19:04:31 volprox avahi-daemon[719]: Successfully dropped remaining capabilities. Sep 16 19:04:31 volprox dbus-daemon[720]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 16 19:04:31 volprox avahi-daemon[719]: Loading service file /services/volumio.service. Sep 16 19:04:31 volprox loadcpufreq[746]: Loading cpufreq kernel modules...failed. Sep 16 19:04:31 volprox systemd[1]: Starting wpa_supplicant.service - WPA supplicant... Sep 16 19:04:31 volprox systemd[1]: Started loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling. Sep 16 19:04:31 volprox systemd[1]: Started systemd-logind.service - User Login Management. Sep 16 19:04:31 volprox systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Sep 16 19:04:31 volprox systemd[1]: Starting cpufrequtils.service - LSB: set CPUFreq kernel parameters... Sep 16 19:04:31 volprox systemd[1]: Finished networking.service - Raise network interfaces. Sep 16 19:04:31 volprox kernel: 8021q: adding VLAN 0 to HW filter on device eth0 Sep 16 19:04:31 volprox avahi-daemon[719]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Sep 16 19:04:31 volprox avahi-daemon[719]: New relevant interface lo.IPv4 for mDNS. Sep 16 19:04:31 volprox avahi-daemon[719]: Network interface enumeration completed. Sep 16 19:04:31 volprox avahi-daemon[719]: Registering new address record for 127.0.0.1 on lo.IPv4. Sep 16 19:04:31 volprox dhcpcd[772]: eth0: waiting for carrier Sep 16 19:04:31 volprox sh[706]: eth0: waiting for carrier Sep 16 19:04:31 volprox dhcpcd[725]: eth0: waiting for carrier Sep 16 19:04:31 volprox systemd[1]: iptables.service: Deactivated successfully. Sep 16 19:04:31 volprox cpufrequtils[872]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Sep 16 19:04:31 volprox systemd[1]: Started cpufrequtils.service - LSB: set CPUFreq kernel parameters. Sep 16 19:04:31 volprox volumio-remote-updater[739]: Volumio OTA Client: 1.7.0 Sep 16 19:04:31 volprox volumio-remote-updater[739]: Error: No active session Sep 16 19:04:31 volprox volumio-remote-updater[739]: [2025-09-16 19:04:31] [info] asio async_connect error: asio.system:111 (Connection refused) Sep 16 19:04:31 volprox volumio-remote-updater[739]: [2025-09-16 19:04:31] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Sep 16 19:04:31 volprox volumio-remote-updater[739]: [2025-09-16 19:04:31] [error] handle_connect error: Connection refused Sep 16 19:04:31 volprox wpa_supplicant[861]: Successfully initialized wpa_supplicant Sep 16 19:04:31 volprox systemd[1]: Started wpa_supplicant.service - WPA supplicant. Sep 16 19:04:31 volprox systemd[1]: Reached target network.target - Network. Sep 16 19:04:31 volprox systemd[1]: Reached target network-online.target - Network is Online. Sep 16 19:04:31 volprox systemd[1]: Starting ifplugd.service - LSB: Brings up/down network automatically... Sep 16 19:04:31 volprox systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 19:04:31 volprox systemd[1]: Starting nmbd.service - Samba NMB Daemon... Sep 16 19:04:31 volprox systemd[1]: Starting ntpsec.service - Network Time Service... Sep 16 19:04:31 volprox systemd[1]: Starting rc-local.service - /etc/rc.local Compatibility... Sep 16 19:04:31 volprox upmpdcli[738]: Could not open config: /tmp/upmpdcli.conf Sep 16 19:04:31 volprox systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart... Sep 16 19:04:31 volprox systemd[1]: Starting samba-ad-dc.service - Samba AD Daemon... Sep 16 19:04:31 volprox sm-notify[890]: Version 2.6.2 starting Sep 16 19:04:31 volprox systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Sep 16 19:04:31 volprox systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 19:04:31 volprox dbus-daemon[720]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.4' (uid=0 pid=900 comm="timedatectl show --property=NTPSynchronized --valu") Sep 16 19:04:31 volprox systemd[1]: Starting ssh.service - OpenBSD Secure Shell server... Sep 16 19:04:31 volprox systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 16 19:04:31 volprox systemd[1]: Started volumio-ipchange.service - Volumio IP Change Monitor. Sep 16 19:04:31 volprox systemd[1]: Starting welcome.service - Show a welcome message on console... Sep 16 19:04:31 volprox systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Sep 16 19:04:31 volprox systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Sep 16 19:04:31 volprox systemd[1]: Started rc-local.service - /etc/rc.local Compatibility. Sep 16 19:04:31 volprox systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart. Sep 16 19:04:31 volprox ntpd[898]: INIT: ntpd ntpsec-1.2.2: Starting Sep 16 19:04:31 volprox ntp-systemd-wrapper[898]: 2025-09-16T19:04:31 ntpd[898]: INIT: ntpd ntpsec-1.2.2: Starting Sep 16 19:04:31 volprox ntp-systemd-wrapper[898]: 2025-09-16T19:04:31 ntpd[898]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Sep 16 19:04:31 volprox ntpd[898]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Sep 16 19:04:31 volprox systemd[1]: Started ntpsec.service - Network Time Service. Sep 16 19:04:31 volprox systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 16 19:04:31 volprox systemd[1]: Starting plymouth-quit-wait.service - Hold until boot process finishes up... Sep 16 19:04:31 volprox systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... Sep 16 19:04:31 volprox systemd[1]: Starting systemd-timedated.service - Time & Date Service... Sep 16 19:04:31 volprox welcome[906]: Resolved ip:[0] Sep 16 19:04:31 volprox ntpd[910]: INIT: precision = 0.085 usec (-23) Sep 16 19:04:31 volprox systemd[1]: Received SIGRTMIN+21 from PID 359 (plymouthd). Sep 16 19:04:31 volprox ntpd[910]: INIT: successfully locked into RAM Sep 16 19:04:31 volprox ifplugd(eth0)[925]: ifplugd 0.28 initializing. Sep 16 19:04:31 volprox ifplugd(eth0)[925]: Using interface eth0/BC:24:11:D8:93:66 with driver (version: 6.12.35-volumio) Sep 16 19:04:31 volprox ifplugd(eth0)[925]: Using detection mode: SIOCETHTOOL Sep 16 19:04:31 volprox ifplugd(eth0)[925]: Initialization complete, link beat not detected. Sep 16 19:04:31 volprox systemd[1]: Received SIGRTMIN+21 from PID 359 (plymouthd). Sep 16 19:04:31 volprox ntpd[910]: CONFIG: readconfig: parsing file: /etc/ntpsec/ntp.conf Sep 16 19:04:31 volprox ntpd[910]: CONFIG: restrict nopeer ignored Sep 16 19:04:31 volprox systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. Sep 16 19:04:31 volprox systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. Sep 16 19:04:31 volprox systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 16 19:04:31 volprox systemd[1]: Reached target getty.target - Login Prompts. Sep 16 19:04:31 volprox ntpd[910]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Sep 16 19:04:31 volprox ntpd[910]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2025-12-28T00:00Z last=2017-01-01T00:00Z ofs=37 Sep 16 19:04:31 volprox ntpd[910]: INIT: Using SO_TIMESTAMPNS(ns) Sep 16 19:04:31 volprox ntpd[910]: IO: Listen and drop on 0 v6wildcard [::]:123 Sep 16 19:04:31 volprox ntpd[910]: IO: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 16 19:04:31 volprox ntpd[910]: IO: Listen normally on 2 lo 127.0.0.1:123 Sep 16 19:04:31 volprox ntpd[910]: IO: Listening on routing socket on fd #19 for interface updates Sep 16 19:04:31 volprox sshd[929]: Server listening on 0.0.0.0 port 22. Sep 16 19:04:31 volprox systemd[1]: Started ssh.service - OpenBSD Secure Shell server. Sep 16 19:04:31 volprox sshd[929]: Server listening on :: port 22. Sep 16 19:04:31 volprox ntpd[910]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes Sep 16 19:04:31 volprox ntpd[910]: INIT: Built with OpenSSL 3.0.9 30 May 2023, 30000090 Sep 16 19:04:31 volprox ntpd[910]: INIT: Running with OpenSSL 3.0.16 11 Feb 2025, 30000100 Sep 16 19:04:31 volprox ntpd[910]: NTSc: Using system default root certificates. Sep 16 19:04:31 volprox dbus-daemon[720]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 16 19:04:31 volprox systemd[1]: Started systemd-timedated.service - Time & Date Service. Sep 16 19:04:31 volprox bash[899]: Time is already synchronized. Sep 16 19:04:31 volprox systemd[1]: setdatetime-helper.service: Deactivated successfully. Sep 16 19:04:31 volprox systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Sep 16 19:04:31 volprox systemd[1]: Finished welcome.service - Show a welcome message on console. Sep 16 19:04:31 volprox ifplugd[884]: Network Interface Plugging Daemon...start eth0...done. Sep 16 19:04:31 volprox systemd[1]: Started ifplugd.service - LSB: Brings up/down network automatically. Sep 16 19:04:31 volprox ntpd[910]: statistics directory /var/log/ntpsec/ does not exist or is unwriteable, error No such file or directory Sep 16 19:04:31 volprox sudo[886]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 19:04:31 volprox sudo[886]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 19:04:31 volprox sudo[941]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Sep 16 19:04:31 volprox sudo[886]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:31 volprox kernel: e1000e 0000:00:12.0 eth0: NIC Link is Up 1000 Mbps Full Duplex, Flow Control: Rx/Tx Sep 16 19:04:31 volprox dhcpcd[725]: eth0: carrier acquired Sep 16 19:04:31 volprox dhcpcd[772]: eth0: carrier acquired Sep 16 19:04:31 volprox sh[706]: eth0: carrier acquired Sep 16 19:04:31 volprox dhcpcd[772]: eth0: IAID 11:d8:93:66 Sep 16 19:04:31 volprox dhcpcd[725]: eth0: IAID 11:d8:93:66 Sep 16 19:04:31 volprox sh[706]: eth0: IAID 11:d8:93:66 Sep 16 19:04:31 volprox dhcpcd[772]: eth0: adding address fe80::ecb:d821:8315:c322 Sep 16 19:04:31 volprox sh[706]: eth0: adding address fe80::ecb:d821:8315:c322 Sep 16 19:04:31 volprox dhcpcd[725]: eth0: adding address fe80::ecb:d821:8315:c322 Sep 16 19:04:31 volprox dhcpcd[725]: ipv6_addaddr1: Permission denied Sep 16 19:04:31 volprox sh[706]: ipv6_addaddr1: Permission denied Sep 16 19:04:31 volprox dhcpcd[772]: ipv6_addaddr1: Permission denied Sep 16 19:04:31 volprox dhcpcd[725]: eth0: soliciting an IPv6 router Sep 16 19:04:31 volprox sh[706]: eth0: soliciting an IPv6 router Sep 16 19:04:32 volprox systemd[1]: samba-ad-dc.service: Skipped due to 'exec-condition'. Sep 16 19:04:32 volprox systemd[1]: Condition check resulted in samba-ad-dc.service - Samba AD Daemon being skipped. Sep 16 19:04:32 volprox iw[971]: command failed: No such device (-19) Sep 16 19:04:32 volprox avahi-daemon[719]: Server startup complete. Host name is volprox.local. Local service cookie is 3309591972. Sep 16 19:04:32 volprox iwconfig[976]: Error for wireless request "Set Power Management" (8B2C) : Sep 16 19:04:32 volprox iwconfig[976]: SET failed on device wlan0 ; No such device. Sep 16 19:04:32 volprox systemd[1]: wireless.service: Deactivated successfully. Sep 16 19:04:32 volprox systemd[1]: Started wireless.service - Wireless Services. Sep 16 19:04:32 volprox systemd[1]: Started volumio.service - Volumio Backend Module. Sep 16 19:04:32 volprox systemd[1]: Started screenshot.service - Process screenshots triggered by PrtSc-button. Sep 16 19:04:32 volprox systemd[1]: Started soundcard-init.service - Intel SST and HDA soundcard init service. Sep 16 19:04:32 volprox systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. Sep 16 19:04:32 volprox nmbd[963]: [2025/09/16 19:04:32.201049, 0] ../../source3/nmbd/nmbd.c:901(main) Sep 16 19:04:32 volprox nmbd[963]: nmbd version 4.17.12-Debian started. Sep 16 19:04:32 volprox nmbd[963]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Sep 16 19:04:32 volprox nmbd[963]: [2025/09/16 19:04:32.204467, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) Sep 16 19:04:32 volprox nmbd[963]: started asyncdns process 1001 Sep 16 19:04:32 volprox nmbd[963]: [2025/09/16 19:04:32.205125, 0] ../../lib/util/become_daemon.c:150(daemon_status) Sep 16 19:04:32 volprox nmbd[963]: daemon_status: daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Sep 16 19:04:32 volprox nmbd[963]: [2025/09/16 19:04:32.205173, 0] ../../source3/nmbd/nmbd_subnetdb.c:252(create_subnets) Sep 16 19:04:32 volprox nmbd[963]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Sep 16 19:04:32 volprox volumio-cpu-tweak[982]: Setting RT Priority for mpd Sep 16 19:04:32 volprox volumio-cpu-tweak[982]: Setting MPD Affinity Sep 16 19:04:32 volprox volumio-cpu-tweak[1006]: pid 942's current affinity mask: f Sep 16 19:04:32 volprox volumio-cpu-tweak[1006]: pid 942's new affinity mask: 3 Sep 16 19:04:32 volprox volumio-cpu-tweak[982]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Sep 16 19:04:32 volprox volumio-cpu-tweak[1007]: Error setting new values. Common errors: Sep 16 19:04:32 volprox volumio-cpu-tweak[1007]: - Do you have proper administration rights? (super-user?) Sep 16 19:04:32 volprox volumio-cpu-tweak[1007]: - Is the governor you requested available and modprobed? Sep 16 19:04:32 volprox volumio-cpu-tweak[1007]: - Trying to set an invalid policy? Sep 16 19:04:32 volprox volumio-cpu-tweak[1007]: - Trying to set a specific frequency, but userspace governor is not available, Sep 16 19:04:32 volprox volumio-cpu-tweak[1007]: for example because of hardware which cannot be set to a specific frequency Sep 16 19:04:32 volprox volumio-cpu-tweak[1007]: or because the userspace governor isn't loaded? Sep 16 19:04:32 volprox systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. Sep 16 19:04:32 volprox soundcard-init.sh[1035]: Card 0 Chip Realtek ALC887-VD Name HDA Intel PCH Sep 16 19:04:32 volprox soundcard-init.sh[1047]: Simple mixer control 'IEC958',0 Sep 16 19:04:32 volprox soundcard-init.sh[1047]: Capabilities: pswitch pswitch-joined Sep 16 19:04:32 volprox soundcard-init.sh[1047]: Playback channels: Mono Sep 16 19:04:32 volprox soundcard-init.sh[1047]: Mono: Playback [on] Sep 16 19:04:32 volprox systemd[1]: soundcard-init.service: Deactivated successfully. Sep 16 19:04:32 volprox dhcpcd[725]: eth0: soliciting a DHCP lease Sep 16 19:04:32 volprox sh[706]: eth0: soliciting a DHCP lease Sep 16 19:04:32 volprox dhcpcd[725]: eth0: offered 172.30.1.70 from 172.30.1.254 Sep 16 19:04:32 volprox sh[706]: eth0: offered 172.30.1.70 from 172.30.1.254 Sep 16 19:04:32 volprox dhcpcd[725]: eth0: probing address 172.30.1.70/24 Sep 16 19:04:32 volprox sh[706]: eth0: probing address 172.30.1.70/24 Sep 16 19:04:32 volprox ntpd[910]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 16 19:04:32 volprox ifplugd(eth0)[925]: Link beat detected. Sep 16 19:04:32 volprox ntpd[910]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Sep 16 19:04:32 volprox ntpd[910]: DNS: dns_check: DNS error: -11, System error Sep 16 19:04:32 volprox ntpd[910]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 Sep 16 19:04:32 volprox ifplugd(eth0)[925]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Sep 16 19:04:32 volprox ifplugd(eth0)[925]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Sep 16 19:04:32 volprox dhcpcd[772]: eth0: soliciting an IPv6 router Sep 16 19:04:32 volprox avahi-daemon[719]: Service "VolProx" (/services/volumio.service) successfully established. Sep 16 19:04:33 volprox mpd[942]: 2025-09-16T19:04:33 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 19:04:33 volprox volumio[979]: info: ------------------------------------------- Sep 16 19:04:33 volprox volumio[979]: info: ----- Volumio3 ---- Sep 16 19:04:33 volprox volumio[979]: info: ------------------------------------------- Sep 16 19:04:33 volprox volumio[979]: info: ----- System startup ---- Sep 16 19:04:33 volprox volumio[979]: info: ------------------------------------------- Sep 16 19:04:33 volprox systemd[1]: Started mpd.service - Music Player Daemon. Sep 16 19:04:33 volprox mpd_monitor.sh[730]: MPD Monitor Service: MPD restarted due to no mpc output. Sep 16 19:04:33 volprox volumio[979]: info: MYVOLUMIO Environment detected Sep 16 19:04:33 volprox volumio[979]: info: Plugin folders cleanup Sep 16 19:04:33 volprox volumio[979]: info: Scanning into folder /volumio/app/plugins/ Sep 16 19:04:33 volprox volumio[979]: info: Scanning category audio_interface Sep 16 19:04:33 volprox volumio[979]: info: Scanning category miscellanea Sep 16 19:04:33 volprox volumio[979]: info: Scanning category music_service Sep 16 19:04:33 volprox volumio[979]: info: Scanning category plugins.json Sep 16 19:04:33 volprox volumio[979]: info: Scanning category system_controller Sep 16 19:04:33 volprox volumio[979]: info: Scanning category user_interface Sep 16 19:04:33 volprox volumio[979]: info: Scanning into folder /data/plugins/ Sep 16 19:04:33 volprox volumio[979]: info: Scanning category music_service Sep 16 19:04:33 volprox volumio[979]: info: Scanning category system_controller Sep 16 19:04:33 volprox volumio[979]: info: Scanning category system_hardware Sep 16 19:04:33 volprox volumio[979]: info: Scanning category user_interface Sep 16 19:04:33 volprox volumio[979]: info: Plugin folders cleanup completed Sep 16 19:04:33 volprox volumio[979]: info: ------------------------------------------- Sep 16 19:04:33 volprox volumio[979]: info: ----- Core plugins startup ---- Sep 16 19:04:33 volprox volumio[979]: info: ------------------------------------------- Sep 16 19:04:33 volprox volumio[979]: info: Loading plugins from folder /volumio/app/plugins/ Sep 16 19:04:33 volprox volumio[979]: info: Adding plugin upnp to MyMusic Plugins Sep 16 19:04:33 volprox volumio[979]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 16 19:04:33 volprox volumio[979]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 16 19:04:33 volprox volumio[979]: info: Loading plugins from folder /data/plugins/ Sep 16 19:04:33 volprox volumio[979]: info: Loading plugin "system"... Sep 16 19:04:33 volprox volumio[979]: info: Loading plugin "appearance"... Sep 16 19:04:33 volprox dhcpcd[772]: eth0: soliciting a DHCP lease Sep 16 19:04:33 volprox dhcpcd[772]: eth0: offered 172.30.1.70 from 172.30.1.254 Sep 16 19:04:33 volprox ntpd[910]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 16 19:04:33 volprox ntpd[910]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Sep 16 19:04:33 volprox ntpd[910]: DNS: dns_check: DNS error: -11, System error Sep 16 19:04:33 volprox ntpd[910]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12 Sep 16 19:04:33 volprox dhcpcd[772]: eth0: probing address 172.30.1.70/24 Sep 16 19:04:33 volprox volumio[979]: info: Loading plugin "network"... Sep 16 19:04:33 volprox volumio[979]: info: Refreshing Cached IP Addresses Sep 16 19:04:33 volprox sudo[1078]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 19:04:33 volprox sudo[1078]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:33 volprox sudo[1076]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 19:04:33 volprox sudo[1076]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:33 volprox volumio[979]: info: Loading plugin "services"... Sep 16 19:04:33 volprox volumio[979]: info: Loading plugin "alsa_controller"... Sep 16 19:04:33 volprox sudo[1076]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:33 volprox sudo[1085]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 16 19:04:33 volprox sudo[1085]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:33 volprox sudo[1078]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:33 volprox sudo[1085]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:33 volprox volumio[979]: warn: Unable to locate the audio output device USB HIFI Audio. Please configure a valid output device. Sep 16 19:04:33 volprox volumio[979]: Invalid card number '5'. Sep 16 19:04:33 volprox volumio[979]: info: Hardware Mixer selected but no Hardware mixer available, detecting default mixer Sep 16 19:04:33 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 16 19:04:33 volprox volumio[979]: Invalid card number '5'. Sep 16 19:04:33 volprox volumio[979]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 16 19:04:33 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 19:04:33 volprox volumio[979]: info: Loading plugin "wizard"... Sep 16 19:04:33 volprox volumio[979]: info: Loading plugin "networkfs"... Sep 16 19:04:33 volprox volumio[979]: info: Starting Udev Watcher for removable devices Sep 16 19:04:33 volprox sudo[1123]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=kasiri33,password=Tw22tyim!!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //172.30.1.60/music /mnt/NAS/Nas Sep 16 19:04:33 volprox sudo[1123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:33 volprox volumio[979]: info: Ignoring mount for partition: boot Sep 16 19:04:33 volprox volumio[979]: info: Ignoring mount for partition: volumio Sep 16 19:04:33 volprox volumio[979]: info: Ignoring mount for partition: volumio_data Sep 16 19:04:33 volprox volumio[979]: info: Ignoring mount for partition: boot Sep 16 19:04:33 volprox volumio[979]: info: Ignoring mount for partition: volumio Sep 16 19:04:33 volprox volumio[979]: info: Ignoring mount for partition: volumio_data Sep 16 19:04:33 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 19:04:33 volprox volumio[979]: info: Loading plugin "volumio_command_line_client"... Sep 16 19:04:33 volprox volumio[979]: info: Loading plugin "upnp"... Sep 16 19:04:33 volprox volumio[979]: info: [1758017073967] Starting Upmpd Daemon Sep 16 19:04:33 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 19:04:33 volprox volumio[979]: info: Loading plugin "my_music"... Sep 16 19:04:33 volprox volumio[979]: info: Loading plugin "mpd"... Sep 16 19:04:33 volprox kernel: netfs: FS-Cache loaded Sep 16 19:04:33 volprox kernel: Key type dns_resolver registered Sep 16 19:04:34 volprox sudo[1123]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:34 volprox kernel: Key type cifs.spnego registered Sep 16 19:04:34 volprox kernel: Key type cifs.idmap registered Sep 16 19:04:34 volprox 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. Sep 16 19:04:34 volprox kernel: CIFS: Attempting to mount //172.30.1.60/music Sep 16 19:04:34 volprox kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Sep 16 19:04:34 volprox kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Sep 16 19:04:34 volprox volumio[979]: info: Loading plugin "upnp_browser"... Sep 16 19:04:34 volprox volumio[979]: info: Loading plugin "alarm-clock"... Sep 16 19:04:34 volprox volumio[979]: info: Loading plugin "airplay_emulation"... Sep 16 19:04:34 volprox volumio[979]: info: Starting Shairport Sync Sep 16 19:04:34 volprox volumio[979]: info: Loading plugin "last_100"... Sep 16 19:04:34 volprox volumio[979]: info: Loading plugin "webradio"... Sep 16 19:04:34 volprox volumio[979]: info: Loading plugin "i2s_dacs"... Sep 16 19:04:34 volprox volumio[979]: info: I2S DAC not set, start Auto-detection Sep 16 19:04:34 volprox volumio[979]: info: Loading plugin "volumiodiscovery"... Sep 16 19:04:34 volprox volumio[979]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 16 19:04:34 volprox volumio[979]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 19:04:34 volprox volumio[979]: *** WARNING *** For more information see Sep 16 19:04:34 volprox volumio[979]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 16 19:04:34 volprox volumio[979]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 19:04:34 volprox volumio[979]: *** WARNING *** For more information see Sep 16 19:04:34 volprox node[979]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 16 19:04:34 volprox node[979]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 19:04:34 volprox node[979]: *** WARNING *** For more information see Sep 16 19:04:34 volprox node[979]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 16 19:04:34 volprox node[979]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 19:04:34 volprox node[979]: *** WARNING *** For more information see Sep 16 19:04:34 volprox volumio[979]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 16 19:04:34 volprox volumio[979]: info: Discovery: Started advertising with name: VolProx Sep 16 19:04:34 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 19:04:34 volprox volumio[979]: info: Plugin ytcr is not enabled Sep 16 19:04:34 volprox volumio[979]: info: Loading plugin "ytmusic"... Sep 16 19:04:34 volprox ntpd[910]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 16 19:04:34 volprox ntpd[910]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Sep 16 19:04:34 volprox ntpd[910]: DNS: dns_check: DNS error: -11, System error Sep 16 19:04:34 volprox ntpd[910]: DNS: dns_take_status: 2.debian.pool.ntp.org=>error, 12 Sep 16 19:04:35 volprox volumio[979]: info: Plugin autostart is not enabled Sep 16 19:04:35 volprox volumio[979]: info: Loading plugin "outputs"... Sep 16 19:04:35 volprox volumio[979]: info: Loading plugin "albumart"... Sep 16 19:04:35 volprox volumio[979]: info: Plugin example_plugin is not enabled Sep 16 19:04:35 volprox volumio[979]: info: Loading plugin "inputs"... Sep 16 19:04:35 volprox volumio[979]: info: Loading plugin "updater_comm"... Sep 16 19:04:35 volprox volumio[1148]: Forking 3 albumart workers Sep 16 19:04:35 volprox volumio[979]: info: Plugin mpdemulation is not enabled Sep 16 19:04:35 volprox volumio[979]: info: Loading plugin "rest_api"... Sep 16 19:04:35 volprox volumio[979]: info: Loading plugin "websocket"... Sep 16 19:04:35 volprox volumio[979]: info: Starting Socket.io Server version 1.7.4 Sep 16 19:04:35 volprox volumio[979]: info: Loading plugin "Bluetoothremote"... Sep 16 19:04:35 volprox volumio[1158]: Starting albumart workers Sep 16 19:04:35 volprox volumio[1160]: Starting albumart workers Sep 16 19:04:35 volprox volumio[1159]: Starting albumart workers Sep 16 19:04:35 volprox ntpd[910]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 16 19:04:35 volprox ntpd[910]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Sep 16 19:04:35 volprox ntpd[910]: DNS: dns_check: DNS error: -11, System error Sep 16 19:04:35 volprox ntpd[910]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12 Sep 16 19:04:35 volprox volumio[979]: info: Applying required configuration parameters for plugin Bluetoothremote Sep 16 19:04:35 volprox volumio[979]: info: Loading plugin "Systeminfo"... Sep 16 19:04:35 volprox volumio[979]: info: Loading plugin "randomizer"... Sep 16 19:04:36 volprox volumio[979]: info: Applying required configuration parameters for plugin randomizer Sep 16 19:04:36 volprox volumio[979]: info: Loading i18n strings for locale ko Sep 16 19:04:36 volprox volumio[979]: Updating browse sources language Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::initPlayerControls Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:04:36 volprox volumio[979]: Express server listening on port 3000 Sep 16 19:04:36 volprox volumio[979]: [Metrics] WebUI: 3s 171.18ms Sep 16 19:04:36 volprox volumio[979]: info: Setting Device type: x86 Sep 16 19:04:36 volprox volumio[979]: info: CoreStateMachine::resetVolumioState Sep 16 19:04:36 volprox volumio[979]: info: CoreStateMachine::getcurrentVolume Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:04:36 volprox volumio[979]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Sep 16 19:04:36 volprox volumio[979]: info: Completed loading Core Plugins Sep 16 19:04:36 volprox volumio[979]: info: Preparing to generate the ALSA configuration file Sep 16 19:04:36 volprox volumio[979]: info: Volumio Network Manager: Network status updated: 0 Sep 16 19:04:36 volprox volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. Sep 16 19:04:36 volprox volumio[979]: info: Cannot mount NAS Nas at system boot, trial number 1 ,retrying in 5 seconds Sep 16 19:04:36 volprox volumio[979]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 16 19:04:36 volprox volumio[979]: wlan0 Interface doesn't support scanning. Sep 16 19:04:36 volprox volumio[979]: info: Cannot use regular scanning, forcing with ap-force Sep 16 19:04:36 volprox sudo[1211]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 16 19:04:36 volprox sudo[1211]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:36 volprox sudo[1211]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:36 volprox volumio[979]: command failed: No such device (-19) Sep 16 19:04:36 volprox volumio[979]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 16 19:04:36 volprox volumio[979]: command failed: No such device (-19) Sep 16 19:04:36 volprox volumio[979]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Sep 16 19:04:36 volprox volumio[979]: info: VolumeController:: Volume=undefined Mute =false Sep 16 19:04:36 volprox volumio[979]: info: CoreStateMachine::pushState Sep 16 19:04:36 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioPushState Sep 16 19:04:36 volprox volumio[979]: info: CoreStateMachine::updateTrackBlock Sep 16 19:04:36 volprox volumio[979]: info: CorePlayQueue::getTrackBlock Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 19:04:36 volprox volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. Sep 16 19:04:36 volprox volumio[979]: info: Reloading queue from file Sep 16 19:04:36 volprox volumio[979]: info: Asound.conf file unchanged, so no further update is needed Sep 16 19:04:36 volprox volumio[979]: info: Output device has changed, restarting MPD Sep 16 19:04:36 volprox volumio[979]: info: Output device has changed, restarting Shairport Sync Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:04:36 volprox sudo[1226]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 19:04:36 volprox sudo[1226]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:36 volprox sudo[1226]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:36 volprox sudo[1228]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 19:04:36 volprox sudo[1228]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:36 volprox volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 19:04:36 volprox volumio[979]: info: ___________ START PLUGINS ___________ Sep 16 19:04:36 volprox volumio[979]: info: ControllerMpd::onStart: Initializing MPD Sep 16 19:04:36 volprox volumio[979]: info: Creating MPD Configuration file Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 19:04:36 volprox volumio[979]: info: [1758017076258] CoreMusicLibrary::Adding element 미디어 서버 Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:04:36 volprox systemd[1]: Stopping mpd.service - Music Player Daemon... Sep 16 19:04:36 volprox sudo[1238]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 19:04:36 volprox sudo[1238]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:36 volprox volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 19:04:36 volprox sudo[1237]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox sudo[1237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:04:36 volprox sudo[1237]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:36 volprox volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 19:04:36 volprox volumio[979]: info: [1758017076281] CoreMusicLibrary::Adding element Last_100 Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 19:04:36 volprox volumio[979]: info: [1758017076283] CoreMusicLibrary::Adding element Webradio Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 19:04:36 volprox volumio[979]: info: Initializing BBC Radios Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 19:04:36 volprox volumio[979]: info: [1758017076307] CoreMusicLibrary::Adding element YouTube Music Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:04:36 volprox volumio[979]: Cannot find translation for source YouTube Music Sep 16 19:04:36 volprox volumio[979]: info: Loading i18n strings for locale ko Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 19:04:36 volprox volumio[979]: info: [1758017076323] CoreMusicLibrary::Adding element Randomizer Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:04:36 volprox volumio[979]: Cannot find translation for source YouTube Music Sep 16 19:04:36 volprox volumio[979]: Cannot find translation for source Randomizer Sep 16 19:04:36 volprox volumio[979]: info: Volumio Calling Home Sep 16 19:04:36 volprox systemd[1]: mpd.service: Deactivated successfully. Sep 16 19:04:36 volprox systemd[1]: Stopped mpd.service - Music Player Daemon. Sep 16 19:04:36 volprox systemd[1]: mpd.service: Consumed 1.168s CPU time. Sep 16 19:04:36 volprox systemd[1]: mpd.socket: Deactivated successfully. Sep 16 19:04:36 volprox systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Sep 16 19:04:36 volprox systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Sep 16 19:04:36 volprox (sd-listen[1265]: mpd.socket: Failed to create listening socket ([::]:6600): Address already in use Sep 16 19:04:36 volprox systemd[1]: mpd.socket: Failed to receive listening socket ([::]:6600): Input/output error Sep 16 19:04:36 volprox volumio[979]: info: CoreStateMachine::setRepeat null single undefined Sep 16 19:04:36 volprox volumio[979]: info: CoreStateMachine::pushState Sep 16 19:04:36 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 19:04:36 volprox systemd[1]: mpd.socket: Failed to listen on sockets: Input/output error Sep 16 19:04:36 volprox systemd[1]: mpd.socket: Failed with result 'resources'. Sep 16 19:04:36 volprox systemd[1]: Failed to listen on mpd.socket - Music Player Daemon Socket. Sep 16 19:04:36 volprox systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioPushState Sep 16 19:04:36 volprox volumio[979]: info: CoreStateMachine::setRandom true Sep 16 19:04:36 volprox volumio[979]: info: CoreStateMachine::pushState Sep 16 19:04:36 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioPushState Sep 16 19:04:36 volprox volumio[979]: info: VolumeController:: Volume=undefined Mute =false Sep 16 19:04:36 volprox volumio[979]: info: CoreStateMachine::pushState Sep 16 19:04:36 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioPushState Sep 16 19:04:36 volprox volumio[979]: Unhandled rejection Error: No sockets available, cannot start. Sep 16 19:04:36 volprox volumio[979]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Sep 16 19:04:36 volprox volumio[979]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Sep 16 19:04:36 volprox volumio[979]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Sep 16 19:04:36 volprox volumio[979]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Sep 16 19:04:36 volprox volumio[979]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Sep 16 19:04:36 volprox volumio[979]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Sep 16 19:04:36 volprox volumio[979]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Sep 16 19:04:36 volprox volumio[979]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Sep 16 19:04:36 volprox volumio[979]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Sep 16 19:04:36 volprox volumio[979]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Sep 16 19:04:36 volprox volumio[979]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Sep 16 19:04:36 volprox volumio[979]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Sep 16 19:04:36 volprox volumio[979]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Sep 16 19:04:36 volprox volumio[979]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Sep 16 19:04:36 volprox volumio[979]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Sep 16 19:04:36 volprox volumio[979]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Sep 16 19:04:36 volprox volumio[979]: info: MPD Permissions set Sep 16 19:04:36 volprox volumio[979]: info: MPD Permissions set Sep 16 19:04:36 volprox volumio[979]: info: Discovery: adding dc6d063d-cf6c-4d35-a730-1a2904c4aa87 Sep 16 19:04:36 volprox volumio[979]: info: Discovery: Found device VolProx Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioGetState Sep 16 19:04:36 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:36 volprox volumio[979]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Sep 16 19:04:36 volprox volumio[979]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox sudo[1266]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 19:04:36 volprox sudo[1266]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 19:04:36 volprox sudo[1266]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:04:36 volprox volumio-remote-updater[739]: [2025-09-16 19:04:36] [connect] Successful connection Sep 16 19:04:36 volprox volumio-remote-updater[739]: [2025-09-16 19:04:36] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1758017076 101 Sep 16 19:04:36 volprox volumio[979]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 3 Sep 16 19:04:36 volprox volumio[979]: info: Starting Shairport Sync Sep 16 19:04:36 volprox volumio[979]: info: Starting Shairport Sync Sep 16 19:04:36 volprox volumio[979]: info: Starting Shairport Sync Sep 16 19:04:36 volprox sudo[1288]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 19:04:36 volprox sudo[1288]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:36 volprox sudo[1290]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 19:04:36 volprox sudo[1290]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:36 volprox sudo[1292]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 19:04:36 volprox sudo[1292]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:36 volprox systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 19:04:36 volprox systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 19:04:36 volprox systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 19:04:36 volprox systemd[1]: shairport-sync.service: Consumed 1.626s CPU time. Sep 16 19:04:36 volprox volumio[979]: info: CoreCommandRouter::volumioGetState Sep 16 19:04:36 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:36 volprox systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 19:04:36 volprox sudo[1292]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:36 volprox volumio[979]: info: Shairport-Sync Started Sep 16 19:04:36 volprox sudo[1290]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:36 volprox volumio[979]: Error adding Membership: Error: addMembership EINVAL Sep 16 19:04:36 volprox volumio[979]: info: Shairport-Sync Started Sep 16 19:04:36 volprox systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 19:04:36 volprox systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 19:04:36 volprox systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 19:04:36 volprox systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 19:04:36 volprox sudo[1288]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:36 volprox volumio[979]: info: Shairport-Sync Started Sep 16 19:04:36 volprox mpd[1274]: 2025-09-16T19:04:36 server_socket: bind to '0.0.0.0:6600' failed (continuing anyway, because binding to '[::]:6600' succeeded): Failed to bind socket: Address already in use Sep 16 19:04:36 volprox mpd[1274]: 2025-09-16T19:04:36 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 19:04:36 volprox systemd[1]: Started mpd.service - Music Player Daemon. Sep 16 19:04:36 volprox sudo[1238]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:36 volprox sudo[1228]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:36 volprox volumio[979]: info: Completed starting Core Plugins Sep 16 19:04:36 volprox volumio[979]: info: ------------------------------------------- Sep 16 19:04:36 volprox volumio[979]: info: ----- MyVolumio plugins startup ---- Sep 16 19:04:36 volprox volumio[979]: info: ------------------------------------------- Sep 16 19:04:36 volprox volumio[979]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 16 19:04:36 volprox volumio[979]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Sep 16 19:04:36 volprox volumio[979]: error: connect ECONNREFUSED /run/mpd/socket {"address":"/run/mpd/socket","code":"ECONNREFUSED","errno":-111,"syscall":"connect"} Sep 16 19:04:37 volprox volumio[979]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Sep 16 19:04:37 volprox volumio[979]: error: connect ECONNREFUSED /run/mpd/socket {"address":"/run/mpd/socket","code":"ECONNREFUSED","errno":-111,"syscall":"connect"} Sep 16 19:04:37 volprox volumio[979]: info: MPD running with PID1274 Sep 16 19:04:37 volprox volumio[979]: ,establishing connection Sep 16 19:04:37 volprox volumio[979]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Sep 16 19:04:37 volprox volumio[979]: error: connect ECONNREFUSED /run/mpd/socket {"address":"/run/mpd/socket","code":"ECONNREFUSED","errno":-111,"syscall":"connect"} Sep 16 19:04:37 volprox dhcpcd[725]: eth0: leased 172.30.1.70 for 3600 seconds Sep 16 19:04:37 volprox sh[706]: eth0: leased 172.30.1.70 for 3600 seconds Sep 16 19:04:37 volprox avahi-daemon[719]: Joining mDNS multicast group on interface eth0.IPv4 with address 172.30.1.70. Sep 16 19:04:37 volprox avahi-daemon[719]: New relevant interface eth0.IPv4 for mDNS. Sep 16 19:04:37 volprox avahi-daemon[719]: Registering new address record for 172.30.1.70 on eth0.IPv4. Sep 16 19:04:37 volprox dhcpcd[725]: eth0: adding route to 172.30.1.0/24 Sep 16 19:04:37 volprox sh[706]: eth0: adding route to 172.30.1.0/24 Sep 16 19:04:37 volprox dhcpcd[725]: eth0: adding default route via 172.30.1.254 Sep 16 19:04:37 volprox sh[706]: eth0: adding default route via 172.30.1.254 Sep 16 19:04:37 volprox volumio[979]: verbose: New Socket.io Connection to 172.30.1.70 from 172.30.1.10 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Sep 16 19:04:37 volprox systemd[1]: welcome.service: Deactivated successfully. Sep 16 19:04:37 volprox systemd[1]: Stopped welcome.service - Show a welcome message on console. Sep 16 19:04:37 volprox systemd[1]: Stopping welcome.service - Show a welcome message on console... Sep 16 19:04:37 volprox volumio[979]: verbose: New Socket.io Connection to 172.30.1.70 from 172.30.1.10 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Sep 16 19:04:37 volprox sh[706]: forked to background, child pid 724 Sep 16 19:04:37 volprox systemd[1]: Starting welcome.service - Show a welcome message on console... Sep 16 19:04:37 volprox welcome[1329]: Resolved ip:[1] 172.30.1.70 Sep 16 19:04:37 volprox systemd[1]: Finished welcome.service - Show a welcome message on console. Sep 16 19:04:37 volprox systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Sep 16 19:04:37 volprox ifplugd(eth0)[925]: client: ifup: interface eth0 already configured Sep 16 19:04:37 volprox sh[1369]: eth0=eth0 Sep 16 19:04:37 volprox ifplugd(eth0)[925]: Program executed successfully. Sep 16 19:04:37 volprox systemd[1]: Started nmbd.service - Samba NMB Daemon. Sep 16 19:04:37 volprox systemd[1]: Starting winbind.service - Samba Winbind Daemon... Sep 16 19:04:37 volprox winbindd[1373]: [2025/09/16 19:04:37.822480, 0] ../../source3/winbindd/winbindd.c:1440(main) Sep 16 19:04:37 volprox winbindd[1373]: winbindd version 4.17.12-Debian started. Sep 16 19:04:37 volprox winbindd[1373]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Sep 16 19:04:37 volprox winbindd[1373]: [2025/09/16 19:04:37.826939, 0] ../../source3/winbindd/winbindd_cache.c:3117(initialize_winbindd_cache) Sep 16 19:04:37 volprox winbindd[1373]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Sep 16 19:04:37 volprox systemd[1]: Started winbind.service - Samba Winbind Daemon. Sep 16 19:04:37 volprox systemd[1]: Starting smbd.service - Samba SMB Daemon... Sep 16 19:04:37 volprox volumio[979]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 16 19:04:37 volprox volumio[979]: info: CoreStateMachine::getcurrentVolume Sep 16 19:04:37 volprox volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 19:04:37 volprox volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. Sep 16 19:04:37 volprox volumio[979]: info: VolumeController:: Volume=undefined Mute =false Sep 16 19:04:37 volprox volumio[979]: info: CoreStateMachine::pushState Sep 16 19:04:37 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:37 volprox volumio[979]: info: CoreCommandRouter::volumioPushState Sep 16 19:04:37 volprox volumio[979]: info: CoreStateMachine::updateTrackBlock Sep 16 19:04:37 volprox volumio[979]: info: CorePlayQueue::getTrackBlock Sep 16 19:04:37 volprox volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 19:04:37 volprox volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. Sep 16 19:04:37 volprox smbd[1389]: [2025/09/16 19:04:37.991195, 0] ../../source3/smbd/server.c:1741(main) Sep 16 19:04:37 volprox smbd[1389]: smbd version 4.17.12-Debian started. Sep 16 19:04:37 volprox smbd[1389]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Sep 16 19:04:37 volprox volumio[979]: info: VolumeController:: Volume=undefined Mute =false Sep 16 19:04:37 volprox volumio[979]: info: CoreStateMachine::pushState Sep 16 19:04:38 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::volumioPushState Sep 16 19:04:38 volprox volumio[979]: verbose: New Socket.io Connection to 172.30.1.70 from 172.30.1.10 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::volumioGetVisibleSources Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::volumioGetState Sep 16 19:04:38 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 16 19:04:38 volprox volumio[979]: info: Received Get System Info Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 19:04:38 volprox volumio[979]: info: Discovery: Getting this device information Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::volumioGetState Sep 16 19:04:38 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::volumioGetState Sep 16 19:04:38 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:38 volprox volumio[979]: info: Listing playlists Sep 16 19:04:38 volprox systemd[1]: Started smbd.service - Samba SMB Daemon. Sep 16 19:04:38 volprox systemd[1]: Reached target multi-user.target - Multi-User System. Sep 16 19:04:38 volprox systemd[1]: Reached target graphical.target - Graphical Interface. Sep 16 19:04:38 volprox systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Sep 16 19:04:38 volprox systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Sep 16 19:04:38 volprox systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Sep 16 19:04:38 volprox systemd[1]: Startup finished in 11.385s (kernel) + 8.674s (userspace) = 20.060s. Sep 16 19:04:38 volprox volumio[979]: info: VolumeController::SetAlsaVolume0 Sep 16 19:04:38 volprox volumio[979]: info: CoreStateMachine::pushState Sep 16 19:04:38 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::volumioPushState Sep 16 19:04:38 volprox volumio[979]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. Sep 16 19:04:38 volprox volumio[979]: info: Discovery: this is already registered, dc6d063d-cf6c-4d35-a730-1a2904c4aa87 Sep 16 19:04:38 volprox volumio[979]: info: Discovery: Found device VolProx Sep 16 19:04:38 volprox volumio[979]: info: CoreCommandRouter::volumioGetState Sep 16 19:04:38 volprox volumio[979]: info: CorePlayQueue::getTrack 0 Sep 16 19:04:38 volprox dhcpcd[772]: eth0: leased 172.30.1.70 for 3600 seconds Sep 16 19:04:38 volprox dhcpcd[772]: eth0: adding route to 172.30.1.0/24 Sep 16 19:04:38 volprox dhcpcd[772]: eth0: adding default route via 172.30.1.254 Sep 16 19:04:38 volprox systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Sep 16 19:04:38 volprox systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Sep 16 19:04:38 volprox systemd[1]: welcome.service: Deactivated successfully. Sep 16 19:04:38 volprox systemd[1]: Stopped welcome.service - Show a welcome message on console. Sep 16 19:04:38 volprox systemd[1]: Stopping welcome.service - Show a welcome message on console... Sep 16 19:04:38 volprox systemd[1]: Starting welcome.service - Show a welcome message on console... Sep 16 19:04:38 volprox welcome[1416]: Resolved ip:[1] 172.30.1.70 Sep 16 19:04:38 volprox systemd[1]: Finished welcome.service - Show a welcome message on console. Sep 16 19:04:38 volprox systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Sep 16 19:04:39 volprox ntpd[910]: IO: Listen normally on 3 eth0 172.30.1.70:123 Sep 16 19:04:39 volprox ntpd[910]: IO: new interface(s) found: waking up resolver Sep 16 19:04:39 volprox ntpd[910]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 16 19:04:39 volprox ntpd[910]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Sep 16 19:04:39 volprox ntpd[910]: DNS: Pool taking: 221.151.118.78 Sep 16 19:04:39 volprox ntpd[910]: DNS: Pool taking: 193.123.243.2 Sep 16 19:04:39 volprox ntpd[910]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Sep 16 19:04:40 volprox ntpd[910]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 16 19:04:40 volprox ntpd[910]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Sep 16 19:04:40 volprox ntpd[910]: DNS: Pool taking: 175.195.167.194 Sep 16 19:04:40 volprox ntpd[910]: DNS: Pool taking: 175.210.18.47 Sep 16 19:04:40 volprox ntpd[910]: DNS: Pool taking: 240b:400d:3:3300:aeda:71da:9779:d4f1 Sep 16 19:04:40 volprox ntpd[910]: DNS: Pool taking: 2401:c080:1c00:24a1:5400:5ff:fe04:720 Sep 16 19:04:40 volprox ntpd[910]: DNS: Pool taking: 2001:678:8::123 Sep 16 19:04:40 volprox ntpd[910]: DNS: Pool taking: 240b:400d:3:3300:aeda:71da:9779:d8f1 Sep 16 19:04:40 volprox ntpd[910]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Sep 16 19:04:41 volprox sudo[1433]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=kasiri33,password=Tw22tyim!!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //172.30.1.60/music /mnt/NAS/Nas Sep 16 19:04:41 volprox sudo[1433]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:41 volprox kernel: CIFS: Attempting to mount //172.30.1.60/music Sep 16 19:04:41 volprox sudo[1433]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:41 volprox ntpd[910]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 16 19:04:41 volprox ntpd[910]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Sep 16 19:04:41 volprox ntpd[910]: DNS: Pool taking: 121.174.142.82 Sep 16 19:04:41 volprox ntpd[910]: DNS: Pool taking: 158.247.202.103 Sep 16 19:04:41 volprox ntpd[910]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Sep 16 19:04:42 volprox ntpd[910]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 16 19:04:42 volprox ntpd[910]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Sep 16 19:04:42 volprox ntpd[910]: DNS: Pool taking: 203.32.26.46 Sep 16 19:04:42 volprox ntpd[910]: DNS: Pool skipping: 175.195.167.194 Sep 16 19:04:42 volprox ntpd[910]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Sep 16 19:04:43 volprox volumio[979]: info: Volumio Network Manager: Network status updated: 1 Sep 16 19:04:43 volprox sudo[1478]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 19:04:43 volprox sudo[1478]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:43 volprox sudo[1480]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 19:04:43 volprox sudo[1478]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:43 volprox sudo[1480]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:43 volprox sudo[1480]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:43 volprox sudo[1485]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 16 19:04:43 volprox sudo[1485]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:44 volprox systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Sep 16 19:04:44 volprox sudo[1485]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:44 volprox volumio[979]: info: Upmpdcli Daemon Started Sep 16 19:04:44 volprox volumio[979]: warn: Bluetoothremote--- No Bluetooth device selected. Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 16 19:04:45 volprox volumio[979]: info: Adding plugin bluetooth to MyMusic Plugins Sep 16 19:04:45 volprox volumio[979]: info: Adding plugin multiroom to MyMusic Plugins Sep 16 19:04:45 volprox volumio[979]: info: Adding plugin metavolumio to MyMusic Plugins Sep 16 19:04:45 volprox volumio[979]: info: Adding plugin cd_controller to MyMusic Plugins Sep 16 19:04:45 volprox volumio[979]: info: Adding plugin qobuzconnect to MyMusic Plugins Sep 16 19:04:45 volprox volumio[979]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 16 19:04:45 volprox volumio[979]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 16 19:04:45 volprox volumio[979]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 16 19:04:45 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:04:45 volprox volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:04:45 volprox volumio[979]: info: Starting MyVolumio Remote Streaming Endpoints Sep 16 19:04:46 volprox volumio[979]: info: MyVolumio login type: Token Sep 16 19:04:46 volprox upmpdcli[1507]: writing RSA key Sep 16 19:04:46 volprox volumio[979]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 16 19:04:46 volprox volumio[979]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 16 19:04:46 volprox volumio[979]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 16 19:04:46 volprox volumio[979]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 16 19:04:46 volprox volumio[979]: info: Streaming services startup Sep 16 19:04:46 volprox volumio[979]: info: Starting Streaming Daemon Sep 16 19:04:46 volprox sudo[1523]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 16 19:04:46 volprox sudo[1523]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:46 volprox volumio[979]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 16 19:04:46 volprox sudo[1523]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:46 volprox volumio[979]: error: Cannot start Volumio Streaming Daemon Sep 16 19:04:46 volprox volumio[979]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 16 19:04:46 volprox volumio[979]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 16 19:04:46 volprox volumio[979]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=4.022&uuid=2e94cd07f2341d3ffdd343a36a3cfd46" http://updates.volumio.org/downloader-v1/track-device Sep 16 19:04:46 volprox volumio[979]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 16 19:04:46 volprox volumio[979]: Dload Upload Total Spent Left Speed Sep 16 19:04:46 volprox volumio[979]: [132B blob data] Sep 16 19:04:46 volprox volumio[979]: retrying in 5 seconds, trial 0 Sep 16 19:04:46 volprox volumio[979]: info: Volumio Calling Home Sep 16 19:04:47 volprox ntpd[910]: CLOCK: time stepped by 1.265265 Sep 16 19:04:47 volprox ntpd[910]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes Sep 16 19:04:48 volprox volumio[979]: error: MyVolumio Custom Token format not valid, refreshing it Sep 16 19:04:48 volprox volumio[979]: info: Volumio called home Sep 16 19:04:49 volprox volumio[979]: info: MyVolumio login type: Token Sep 16 19:04:49 volprox volumio[979]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Sep 16 19:04:50 volprox volumio[979]: info: MyVolumio token set successfully Sep 16 19:04:50 volprox volumio[979]: info: MYVOLUMIO: Adding device Sep 16 19:04:50 volprox volumio[979]: info: MYVOLUMIO: Evaluating Server Sep 16 19:04:50 volprox volumio[979]: info: MyVolumio status changed Sep 16 19:04:50 volprox volumio[979]: info: Streaming services startup Sep 16 19:04:50 volprox volumio[979]: info: Starting Streaming Daemon Sep 16 19:04:50 volprox volumio[979]: info: Removing browser output: myVolumio user plan is not superstar Sep 16 19:04:50 volprox volumio[979]: info: Removing audio output: Sep 16 19:04:50 volprox volumio[979]: info: Stoppping Tunnel 1 Sep 16 19:04:50 volprox sudo[1556]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 16 19:04:50 volprox sudo[1556]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:50 volprox sudo[1558]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Sep 16 19:04:50 volprox sudo[1558]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 19:04:50 volprox systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Sep 16 19:04:50 volprox systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 19:04:50 volprox systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 19:04:50 volprox sudo[1556]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:50 volprox volumio[979]: error: Cannot start Volumio Streaming Daemon Sep 16 19:04:50 volprox systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 19:04:50 volprox systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 19:04:50 volprox volumio[979]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 16 19:04:50 volprox volumio[979]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 16 19:04:50 volprox systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 19:04:50 volprox systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 19:04:50 volprox setdatetime-helper.sh[1561]: Time is not synchronized. Attempting to sync... Sep 16 19:04:50 volprox sudo[1558]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:50 volprox volumio[979]: info: Remote SSH Stopped Sep 16 19:04:50 volprox sudo[1570]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Tue, 16 Sep 2025 10:04:50 GMT#015' Sep 16 19:04:50 volprox sudo[1570]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 19:04:50 volprox setdatetime-helper.sh[1571]: Tue Sep 16 19:04:50 KST 2025 Sep 16 19:04:50 volprox setdatetime-helper.sh[1561]: Time synchronized successfully. Sep 16 19:04:50 volprox sudo[1570]: pam_unix(sudo:session): session closed for user root Sep 16 19:04:50 volprox systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Sep 16 19:04:50 volprox systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Sep 16 19:04:50 volprox systemd-journald[505]: Time jumped backwards, rotating. Sep 16 19:04:50 volprox volumio[979]: error: Failed to ping endpoint as1.myvolumio.org : unknown error Sep 16 19:04:50 volprox volumio[979]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 19:04:50 volprox volumio[979]: Error: Unable to resolve or reject the same promise twice Sep 16 19:04:50 volprox volumio[979]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Sep 16 19:04:50 volprox volumio[979]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32371) Sep 16 19:04:50 volprox volumio[979]: at Socket.emit (node:events:514:28) Sep 16 19:04:50 volprox volumio[979]: at addChunk (node:internal/streams/readable:343:12) Sep 16 19:04:50 volprox volumio[979]: at readableAddChunk (node:internal/streams/readable:316:9) Sep 16 19:04:50 volprox volumio[979]: at Readable.push (node:internal/streams/readable:253:10) Sep 16 19:04:50 volprox volumio[979]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Sep 16 19:04:50 volprox volumio[979]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 19:04:50 volprox sudo[1587]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-09-16 19:03' Sep 16 19:04:50 volprox sudo[1587]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dfc7bb04e09bf2260691765a2340814af1fa2971" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="30d63a8c53d2826bd7f262e22b4e4511a4cc9d01" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Aug 30 07:07:32 UTC 2025" VOLUMIO_VERSION="4.022" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9a5a1566f5c8d470330ec8a877815bcf"