Jul 05 11:31:28 volprox kernel: Linux version 6.12.30-volumio (andrew@rig) (gcc (Ubuntu 14.2.0-4ubuntu2~24.04) 14.2.0, GNU ld (GNU Binutils for Ubuntu) 2.42) #2 SMP PREEMPT_DYNAMIC Wed May 28 19:37:30 BST 2025 Jul 05 11:31:28 volprox kernel: Command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=f9122924-079c-42eb-9700-f39ff249b20f bootpart=UUID=9F79-DB23 datapart=UUID=235821d1-628a-4647-a5fe-6c10402b8c33 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 Jul 05 11:31:28 volprox kernel: KERNEL supported cpus: Jul 05 11:31:28 volprox kernel: Intel GenuineIntel Jul 05 11:31:28 volprox kernel: AMD AuthenticAMD Jul 05 11:31:28 volprox kernel: Hygon HygonGenuine Jul 05 11:31:28 volprox kernel: Centaur CentaurHauls Jul 05 11:31:28 volprox kernel: zhaoxin Shanghai Jul 05 11:31:28 volprox kernel: BIOS-provided physical RAM map: Jul 05 11:31:28 volprox kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Jul 05 11:31:28 volprox kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Jul 05 11:31:28 volprox kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Jul 05 11:31:28 volprox kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bffb9fff] usable Jul 05 11:31:28 volprox kernel: BIOS-e820: [mem 0x00000000bffba000-0x00000000bfffffff] reserved Jul 05 11:31:28 volprox kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jul 05 11:31:28 volprox kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Jul 05 11:31:28 volprox kernel: BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable Jul 05 11:31:28 volprox kernel: NX (Execute Disable) protection: active Jul 05 11:31:28 volprox kernel: APIC: Static calls initialized Jul 05 11:31:28 volprox kernel: SMBIOS 2.8 present. Jul 05 11:31:28 volprox kernel: DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 Jul 05 11:31:28 volprox kernel: DMI: Memory slots populated: 1/1 Jul 05 11:31:28 volprox kernel: Hypervisor detected: KVM Jul 05 11:31:28 volprox kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jul 05 11:31:28 volprox kernel: kvm-clock: using sched offset of 6003929659 cycles Jul 05 11:31:28 volprox kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jul 05 11:31:28 volprox kernel: tsc: Detected 3911.998 MHz processor Jul 05 11:31:28 volprox kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jul 05 11:31:28 volprox kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jul 05 11:31:28 volprox kernel: last_pfn = 0x140000 max_arch_pfn = 0x400000000 Jul 05 11:31:28 volprox kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Jul 05 11:31:28 volprox kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jul 05 11:31:28 volprox kernel: last_pfn = 0xbffba max_arch_pfn = 0x400000000 Jul 05 11:31:28 volprox kernel: found SMP MP-table at [mem 0x000f5440-0x000f544f] Jul 05 11:31:28 volprox kernel: RAMDISK: [mem 0x7b351000-0x7fffffff] Jul 05 11:31:28 volprox kernel: ACPI: Early table checksum verification disabled Jul 05 11:31:28 volprox kernel: ACPI: RSDP 0x00000000000F5240 000014 (v00 BOCHS ) Jul 05 11:31:28 volprox kernel: ACPI: RSDT 0x00000000BFFE3CAA 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 05 11:31:28 volprox kernel: ACPI: FACP 0x00000000BFFE3A7C 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 05 11:31:28 volprox kernel: ACPI: DSDT 0x00000000BFFDF040 004A3C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 05 11:31:28 volprox kernel: ACPI: FACS 0x00000000BFFDF000 000040 Jul 05 11:31:28 volprox kernel: ACPI: APIC 0x00000000BFFE3AF0 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 05 11:31:28 volprox kernel: ACPI: SSDT 0x00000000BFFE3B80 0000CA (v01 BOCHS VMGENID 00000001 BXPC 00000001) Jul 05 11:31:28 volprox kernel: ACPI: HPET 0x00000000BFFE3C4A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 05 11:31:28 volprox kernel: ACPI: WAET 0x00000000BFFE3C82 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 05 11:31:28 volprox kernel: ACPI: Reserving FACP table memory at [mem 0xbffe3a7c-0xbffe3aef] Jul 05 11:31:28 volprox kernel: ACPI: Reserving DSDT table memory at [mem 0xbffdf040-0xbffe3a7b] Jul 05 11:31:28 volprox kernel: ACPI: Reserving FACS table memory at [mem 0xbffdf000-0xbffdf03f] Jul 05 11:31:28 volprox kernel: ACPI: Reserving APIC table memory at [mem 0xbffe3af0-0xbffe3b7f] Jul 05 11:31:28 volprox kernel: ACPI: Reserving SSDT table memory at [mem 0xbffe3b80-0xbffe3c49] Jul 05 11:31:28 volprox kernel: ACPI: Reserving HPET table memory at [mem 0xbffe3c4a-0xbffe3c81] Jul 05 11:31:28 volprox kernel: ACPI: Reserving WAET table memory at [mem 0xbffe3c82-0xbffe3ca9] Jul 05 11:31:28 volprox kernel: Zone ranges: Jul 05 11:31:28 volprox kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jul 05 11:31:28 volprox kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Jul 05 11:31:28 volprox kernel: Normal [mem 0x0000000100000000-0x000000013fffffff] Jul 05 11:31:28 volprox kernel: Movable zone start for each node Jul 05 11:31:28 volprox kernel: Early memory node ranges Jul 05 11:31:28 volprox kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Jul 05 11:31:28 volprox kernel: node 0: [mem 0x0000000000100000-0x00000000bffb9fff] Jul 05 11:31:28 volprox kernel: node 0: [mem 0x0000000100000000-0x000000013fffffff] Jul 05 11:31:28 volprox kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] Jul 05 11:31:28 volprox kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jul 05 11:31:28 volprox kernel: On node 0, zone DMA: 97 pages in unavailable ranges Jul 05 11:31:28 volprox kernel: On node 0, zone Normal: 70 pages in unavailable ranges Jul 05 11:31:28 volprox kernel: ACPI: PM-Timer IO Port: 0x608 Jul 05 11:31:28 volprox kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jul 05 11:31:28 volprox kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jul 05 11:31:28 volprox kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jul 05 11:31:28 volprox kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jul 05 11:31:28 volprox kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jul 05 11:31:28 volprox kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jul 05 11:31:28 volprox kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jul 05 11:31:28 volprox kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jul 05 11:31:28 volprox kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jul 05 11:31:28 volprox kernel: CPU topo: Max. logical packages: 1 Jul 05 11:31:28 volprox kernel: CPU topo: Max. logical dies: 1 Jul 05 11:31:28 volprox kernel: CPU topo: Max. dies per package: 1 Jul 05 11:31:28 volprox kernel: CPU topo: Max. threads per core: 1 Jul 05 11:31:28 volprox kernel: CPU topo: Num. cores per package: 4 Jul 05 11:31:28 volprox kernel: CPU topo: Num. threads per package: 4 Jul 05 11:31:28 volprox kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Jul 05 11:31:28 volprox kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jul 05 11:31:28 volprox kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] Jul 05 11:31:28 volprox kernel: PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] Jul 05 11:31:28 volprox kernel: PM: hibernation: Registered nosave memory: [mem 0xbffba000-0xffffffff] Jul 05 11:31:28 volprox kernel: [mem 0xc0000000-0xfeffbfff] available for PCI devices Jul 05 11:31:28 volprox kernel: Booting paravirtualized kernel on KVM Jul 05 11:31:28 volprox kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Jul 05 11:31:28 volprox kernel: setup_percpu: NR_CPUS:64 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jul 05 11:31:28 volprox kernel: percpu: Embedded 59 pages/cpu s201432 r8192 d32040 u524288 Jul 05 11:31:28 volprox kernel: pcpu-alloc: s201432 r8192 d32040 u524288 alloc=1*2097152 Jul 05 11:31:28 volprox kernel: pcpu-alloc: [0] 0 1 2 3 Jul 05 11:31:28 volprox kernel: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=f9122924-079c-42eb-9700-f39ff249b20f bootpart=UUID=9F79-DB23 datapart=UUID=235821d1-628a-4647-a5fe-6c10402b8c33 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 Jul 05 11:31:28 volprox kernel: Unknown kernel command line parameters "splash BOOT_IMAGE=vmlinuz biosdevname=0 imgpart=UUID=f9122924-079c-42eb-9700-f39ff249b20f bootpart=UUID=9F79-DB23 datapart=UUID=235821d1-628a-4647-a5fe-6c10402b8c33 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh use_kmsg=no", will be passed to user space. Jul 05 11:31:28 volprox kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 05 11:31:28 volprox kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 05 11:31:28 volprox kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048408 Jul 05 11:31:28 volprox kernel: mem auto-init: stack:all(pattern), heap alloc:off, heap free:off Jul 05 11:31:28 volprox kernel: software IO TLB: area num 4. Jul 05 11:31:28 volprox kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 05 11:31:28 volprox kernel: Kernel/User page tables isolation: enabled Jul 05 11:31:28 volprox kernel: ftrace: allocating 43661 entries in 171 pages Jul 05 11:31:28 volprox kernel: ftrace: allocated 171 pages with 5 groups Jul 05 11:31:28 volprox kernel: Dynamic Preempt: voluntary Jul 05 11:31:28 volprox kernel: rcu: Preemptible hierarchical RCU implementation. Jul 05 11:31:28 volprox kernel: rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=4. Jul 05 11:31:28 volprox kernel: Trampoline variant of Tasks RCU enabled. Jul 05 11:31:28 volprox kernel: Rude variant of Tasks RCU enabled. Jul 05 11:31:28 volprox kernel: Tracing variant of Tasks RCU enabled. Jul 05 11:31:28 volprox kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Jul 05 11:31:28 volprox kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 05 11:31:28 volprox kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 05 11:31:28 volprox kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 05 11:31:28 volprox kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 05 11:31:28 volprox kernel: NR_IRQS: 4352, nr_irqs: 456, preallocated irqs: 16 Jul 05 11:31:28 volprox kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 05 11:31:28 volprox kernel: Console: colour VGA+ 80x25 Jul 05 11:31:28 volprox kernel: printk: legacy console [tty0] enabled Jul 05 11:31:28 volprox kernel: ACPI: Core revision 20240827 Jul 05 11:31:28 volprox kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Jul 05 11:31:28 volprox kernel: APIC: Switch to symmetric I/O mode setup Jul 05 11:31:28 volprox kernel: x2apic enabled Jul 05 11:31:28 volprox kernel: APIC: Switched APIC routing to: physical x2apic Jul 05 11:31:28 volprox kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jul 05 11:31:28 volprox kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x70c7414a6ec, max_idle_ns: 881590470838 ns Jul 05 11:31:28 volprox kernel: Calibrating delay loop (skipped) preset value.. 7823.99 BogoMIPS (lpj=15647992) Jul 05 11:31:28 volprox kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Jul 05 11:31:28 volprox kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Jul 05 11:31:28 volprox kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jul 05 11:31:28 volprox kernel: Spectre V2 : Mitigation: Retpolines Jul 05 11:31:28 volprox kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jul 05 11:31:28 volprox kernel: Speculative Store Bypass: Vulnerable Jul 05 11:31:28 volprox kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Jul 05 11:31:28 volprox kernel: MMIO Stale Data: Unknown: No mitigations Jul 05 11:31:28 volprox kernel: ITS: Mitigation: Aligned branch/return thunks Jul 05 11:31:28 volprox kernel: x86/fpu: x87 FPU will use FXSAVE Jul 05 11:31:28 volprox kernel: Freeing SMP alternatives memory: 36K Jul 05 11:31:28 volprox kernel: pid_max: default: 32768 minimum: 301 Jul 05 11:31:28 volprox kernel: LSM: initializing lsm=capability,yama Jul 05 11:31:28 volprox kernel: Yama: becoming mindful. Jul 05 11:31:28 volprox kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 05 11:31:28 volprox kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 05 11:31:28 volprox kernel: smpboot: CPU0: Intel QEMU Virtual CPU version 2.5+ (family: 0xf, model: 0x6b, stepping: 0x1) Jul 05 11:31:28 volprox kernel: Performance Events: unsupported Netburst CPU model 107 no PMU driver, software events only. Jul 05 11:31:28 volprox kernel: signal: max sigframe size: 1440 Jul 05 11:31:28 volprox kernel: rcu: Hierarchical SRCU implementation. Jul 05 11:31:28 volprox kernel: rcu: Max phase no-delay instances is 1000. Jul 05 11:31:28 volprox kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jul 05 11:31:28 volprox kernel: NMI watchdog: Perf NMI watchdog permanently disabled Jul 05 11:31:28 volprox kernel: smp: Bringing up secondary CPUs ... Jul 05 11:31:28 volprox kernel: smpboot: x86: Booting SMP configuration: Jul 05 11:31:28 volprox kernel: .... node #0, CPUs: #1 #2 #3 Jul 05 11:31:28 volprox kernel: smp: Brought up 1 node, 4 CPUs Jul 05 11:31:28 volprox kernel: smpboot: Total of 4 processors activated (31295.98 BogoMIPS) Jul 05 11:31:28 volprox kernel: Memory: 3941316K/4193632K available (16384K kernel code, 2020K rwdata, 5352K rodata, 3048K init, 928K bss, 246820K reserved, 0K cma-reserved) Jul 05 11:31:28 volprox kernel: devtmpfs: initialized Jul 05 11:31:28 volprox kernel: x86/mm: Memory block size: 128MB Jul 05 11:31:28 volprox kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Jul 05 11:31:28 volprox kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 05 11:31:28 volprox kernel: pinctrl core: initialized pinctrl subsystem Jul 05 11:31:28 volprox kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 05 11:31:28 volprox kernel: audit: initializing netlink subsys (disabled) Jul 05 11:31:28 volprox kernel: audit: type=2000 audit(1751682681.837:1): state=initialized audit_enabled=0 res=1 Jul 05 11:31:28 volprox kernel: thermal_sys: Registered thermal governor 'fair_share' Jul 05 11:31:28 volprox kernel: thermal_sys: Registered thermal governor 'bang_bang' Jul 05 11:31:28 volprox kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 05 11:31:28 volprox kernel: thermal_sys: Registered thermal governor 'user_space' Jul 05 11:31:28 volprox kernel: cpuidle: using governor ladder Jul 05 11:31:28 volprox kernel: cpuidle: using governor menu Jul 05 11:31:28 volprox kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 05 11:31:28 volprox kernel: PCI: Using configuration type 1 for base access Jul 05 11:31:28 volprox kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jul 05 11:31:28 volprox kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 05 11:31:28 volprox kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jul 05 11:31:28 volprox kernel: ACPI: Added _OSI(Module Device) Jul 05 11:31:28 volprox kernel: ACPI: Added _OSI(Processor Device) Jul 05 11:31:28 volprox kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jul 05 11:31:28 volprox kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 05 11:31:28 volprox kernel: ACPI: 2 ACPI AML tables successfully acquired and loaded Jul 05 11:31:28 volprox kernel: ACPI: Interpreter enabled Jul 05 11:31:28 volprox kernel: ACPI: PM: (supports S0 S5) Jul 05 11:31:28 volprox kernel: ACPI: Using IOAPIC for interrupt routing Jul 05 11:31:28 volprox kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jul 05 11:31:28 volprox kernel: PCI: Using E820 reservations for host bridge windows Jul 05 11:31:28 volprox kernel: ACPI: Enabled 3 GPEs in block 00 to 0F Jul 05 11:31:28 volprox kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 05 11:31:28 volprox kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Jul 05 11:31:28 volprox kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Jul 05 11:31:28 volprox kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Jul 05 11:31:28 volprox kernel: acpiphp: Slot [3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [7] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [16] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [17] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [18] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [6] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [8] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [9] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [10] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [11] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [12] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [13] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [14] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [15] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [19] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [20] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [21] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [22] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [23] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [24] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [25] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [26] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [27] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [28] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [29] registered Jul 05 11:31:28 volprox kernel: PCI host bridge to bus 0000:00 Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: root bus resource [mem 0x140000000-0x1bfffffff window] Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 05 11:31:28 volprox kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:00:01.1: BAR 4 [io 0xf180-0xf18f] Jul 05 11:31:28 volprox kernel: pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk Jul 05 11:31:28 volprox kernel: pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk Jul 05 11:31:28 volprox kernel: pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk Jul 05 11:31:28 volprox kernel: pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk Jul 05 11:31:28 volprox kernel: pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:00:01.2: BAR 4 [io 0xf140-0xf15f] Jul 05 11:31:28 volprox kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI Jul 05 11:31:28 volprox kernel: pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB Jul 05 11:31:28 volprox kernel: pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:00:02.0: BAR 0 [mem 0xfc000000-0xfcffffff pref] Jul 05 11:31:28 volprox kernel: pci 0000:00:02.0: BAR 2 [mem 0xfea74000-0xfea74fff] Jul 05 11:31:28 volprox kernel: pci 0000:00:02.0: ROM [mem 0xfea40000-0xfea4ffff pref] Jul 05 11:31:28 volprox kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jul 05 11:31:28 volprox kernel: pci 0000:00:03.0: [1af4:1002] type 00 class 0x00ff00 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:00:03.0: BAR 0 [io 0xf100-0xf13f] Jul 05 11:31:28 volprox kernel: pci 0000:00:03.0: BAR 4 [mem 0xfd600000-0xfd603fff 64bit pref] Jul 05 11:31:28 volprox kernel: pci 0000:00:05.0: [1b36:0001] type 01 class 0x060400 conventional PCI bridge Jul 05 11:31:28 volprox kernel: pci 0000:00:05.0: BAR 0 [mem 0xfea75000-0xfea750ff 64bit] Jul 05 11:31:28 volprox kernel: pci 0000:00:05.0: PCI bridge to [bus 01] Jul 05 11:31:28 volprox kernel: pci 0000:00:05.0: bridge window [io 0xe000-0xefff] Jul 05 11:31:28 volprox kernel: pci 0000:00:05.0: bridge window [mem 0xfe800000-0xfe9fffff] Jul 05 11:31:28 volprox kernel: pci 0000:00:05.0: bridge window [mem 0xfd400000-0xfd5fffff 64bit pref] Jul 05 11:31:28 volprox kernel: pci 0000:00:07.0: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:00:07.0: BAR 4 [io 0xf160-0xf17f] Jul 05 11:31:28 volprox kernel: pci 0000:00:07.0: BAR 5 [mem 0xfea76000-0xfea76fff] Jul 05 11:31:28 volprox kernel: pci 0000:00:10.0: [8086:a2af] type 00 class 0x0c0330 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:00:10.0: BAR 0 [mem 0xfea50000-0xfea5ffff 64bit] Jul 05 11:31:28 volprox kernel: pci 0000:00:11.0: [8086:a2f0] type 00 class 0x040300 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:00:11.0: BAR 0 [mem 0xfea70000-0xfea73fff 64bit] Jul 05 11:31:28 volprox kernel: pci 0000:00:11.0: BAR 4 [mem 0xfea60000-0xfea6ffff 64bit] Jul 05 11:31:28 volprox kernel: pci 0000:00:12.0: [10ec:8139] type 00 class 0x020000 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:00:12.0: BAR 0 [io 0xf000-0xf0ff] Jul 05 11:31:28 volprox kernel: pci 0000:00:12.0: BAR 1 [mem 0xfea77000-0xfea770ff] Jul 05 11:31:28 volprox kernel: pci 0000:00:12.0: ROM [mem 0xfea00000-0xfea3ffff pref] Jul 05 11:31:28 volprox kernel: pci 0000:00:1e.0: [1b36:0001] type 01 class 0x060400 conventional PCI bridge Jul 05 11:31:28 volprox kernel: pci 0000:00:1e.0: BAR 0 [mem 0xfea78000-0xfea780ff 64bit] Jul 05 11:31:28 volprox kernel: pci 0000:00:1e.0: PCI bridge to [bus 02] Jul 05 11:31:28 volprox kernel: pci 0000:00:1e.0: bridge window [io 0xd000-0xdfff] Jul 05 11:31:28 volprox kernel: pci 0000:00:1e.0: bridge window [mem 0xfe600000-0xfe7fffff] Jul 05 11:31:28 volprox kernel: pci 0000:00:1e.0: bridge window [mem 0xfd200000-0xfd3fffff 64bit pref] Jul 05 11:31:28 volprox kernel: pci 0000:00:1f.0: [1b36:0001] type 01 class 0x060400 conventional PCI bridge Jul 05 11:31:28 volprox kernel: pci 0000:00:1f.0: BAR 0 [mem 0xfea79000-0xfea790ff 64bit] Jul 05 11:31:28 volprox kernel: pci 0000:00:1f.0: PCI bridge to [bus 03] Jul 05 11:31:28 volprox kernel: pci 0000:00:1f.0: bridge window [io 0xc000-0xcfff] Jul 05 11:31:28 volprox kernel: pci 0000:00:1f.0: bridge window [mem 0xfe400000-0xfe5fffff] Jul 05 11:31:28 volprox kernel: pci 0000:00:1f.0: bridge window [mem 0xfd000000-0xfd1fffff 64bit pref] Jul 05 11:31:28 volprox kernel: pci_bus 0000:01: extended config space not accessible Jul 05 11:31:28 volprox kernel: acpiphp: Slot [0] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [1-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [3-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [4-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [5] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [6-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [7-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [8-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [9-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [10-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [11-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [12-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [13-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [14-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [15-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [16-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [17-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [18-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [19-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [20-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [21-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [22-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [23-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [24-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [25-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [26-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [27-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [28-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [29-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [30] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [31] registered Jul 05 11:31:28 volprox kernel: pci 0000:00:05.0: PCI bridge to [bus 01] Jul 05 11:31:28 volprox kernel: pci_bus 0000:02: extended config space not accessible Jul 05 11:31:28 volprox kernel: acpiphp: Slot [27-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [0-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [1-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [2-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [3-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [4-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [5-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [6-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [7-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [8-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [9-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [10-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [11-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [12-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [13-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [14-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [15-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [16-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [17-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [18-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [19-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [20-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [21-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [22-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [23-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [24-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [25-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [26-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [28-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [29-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [30-2] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [31-2] registered Jul 05 11:31:28 volprox kernel: pci 0000:02:1b.0: [1b36:000d] type 00 class 0x0c0330 conventional PCI endpoint Jul 05 11:31:28 volprox kernel: pci 0000:02:1b.0: BAR 0 [mem 0xfe600000-0xfe603fff 64bit] Jul 05 11:31:28 volprox kernel: pci 0000:00:1e.0: PCI bridge to [bus 02] Jul 05 11:31:28 volprox kernel: pci_bus 0000:03: extended config space not accessible Jul 05 11:31:28 volprox kernel: acpiphp: Slot [0-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [1-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [2-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [3-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [4-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [5-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [6-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [7-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [8-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [9-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [10-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [11-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [12-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [13-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [14-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [15-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [16-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [17-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [18-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [19-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [20-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [21-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [22-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [23-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [24-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [25-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [26-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [27-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [28-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [29-4] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [30-3] registered Jul 05 11:31:28 volprox kernel: acpiphp: Slot [31-3] registered Jul 05 11:31:28 volprox kernel: pci 0000:00:1f.0: PCI bridge to [bus 03] Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: on NUMA node 0 Jul 05 11:31:28 volprox kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jul 05 11:31:28 volprox kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jul 05 11:31:28 volprox kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jul 05 11:31:28 volprox kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jul 05 11:31:28 volprox kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Jul 05 11:31:28 volprox kernel: iommu: Default domain type: Translated Jul 05 11:31:28 volprox kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jul 05 11:31:28 volprox kernel: SCSI subsystem initialized Jul 05 11:31:28 volprox kernel: libata version 3.00 loaded. Jul 05 11:31:28 volprox kernel: ACPI: bus type USB registered Jul 05 11:31:28 volprox kernel: usbcore: registered new interface driver usbfs Jul 05 11:31:28 volprox kernel: usbcore: registered new interface driver hub Jul 05 11:31:28 volprox kernel: usbcore: registered new device driver usb Jul 05 11:31:28 volprox kernel: PCI: Using ACPI for IRQ routing Jul 05 11:31:28 volprox kernel: PCI: pci_cache_line_size set to 64 bytes Jul 05 11:31:28 volprox kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Jul 05 11:31:28 volprox kernel: e820: reserve RAM buffer [mem 0xbffba000-0xbfffffff] Jul 05 11:31:28 volprox kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Jul 05 11:31:28 volprox kernel: pci 0000:00:02.0: vgaarb: bridge control possible Jul 05 11:31:28 volprox kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jul 05 11:31:28 volprox kernel: vgaarb: loaded Jul 05 11:31:28 volprox kernel: hpet: 3 channels of 0 reserved for per-cpu timers Jul 05 11:31:28 volprox kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jul 05 11:31:28 volprox kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Jul 05 11:31:28 volprox kernel: clocksource: Switched to clocksource kvm-clock Jul 05 11:31:28 volprox kernel: VFS: Disk quotas dquot_6.6.0 Jul 05 11:31:28 volprox kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 05 11:31:28 volprox kernel: pnp: PnP ACPI init Jul 05 11:31:28 volprox kernel: pnp 00:02: [dma 2] Jul 05 11:31:28 volprox kernel: pnp: PnP ACPI: found 4 devices Jul 05 11:31:28 volprox kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jul 05 11:31:28 volprox kernel: NET: Registered PF_INET protocol family Jul 05 11:31:28 volprox kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 05 11:31:28 volprox kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 05 11:31:28 volprox kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 05 11:31:28 volprox kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 05 11:31:28 volprox kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 05 11:31:28 volprox kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 05 11:31:28 volprox kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 05 11:31:28 volprox kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 05 11:31:28 volprox kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 05 11:31:28 volprox kernel: pci 0000:00:05.0: PCI bridge to [bus 01] Jul 05 11:31:28 volprox kernel: pci 0000:00:05.0: bridge window [io 0xe000-0xefff] Jul 05 11:31:28 volprox kernel: pci 0000:00:05.0: bridge window [mem 0xfe800000-0xfe9fffff] Jul 05 11:31:28 volprox kernel: pci 0000:00:05.0: bridge window [mem 0xfd400000-0xfd5fffff 64bit pref] Jul 05 11:31:28 volprox kernel: pci 0000:00:1e.0: PCI bridge to [bus 02] Jul 05 11:31:28 volprox kernel: pci 0000:00:1e.0: bridge window [io 0xd000-0xdfff] Jul 05 11:31:28 volprox kernel: pci 0000:00:1e.0: bridge window [mem 0xfe600000-0xfe7fffff] Jul 05 11:31:28 volprox kernel: pci 0000:00:1e.0: bridge window [mem 0xfd200000-0xfd3fffff 64bit pref] Jul 05 11:31:28 volprox kernel: pci 0000:00:1f.0: PCI bridge to [bus 03] Jul 05 11:31:28 volprox kernel: pci 0000:00:1f.0: bridge window [io 0xc000-0xcfff] Jul 05 11:31:28 volprox kernel: pci 0000:00:1f.0: bridge window [mem 0xfe400000-0xfe5fffff] Jul 05 11:31:28 volprox kernel: pci 0000:00:1f.0: bridge window [mem 0xfd000000-0xfd1fffff 64bit pref] Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] Jul 05 11:31:28 volprox kernel: pci_bus 0000:00: resource 8 [mem 0x140000000-0x1bfffffff window] Jul 05 11:31:28 volprox kernel: pci_bus 0000:01: resource 0 [io 0xe000-0xefff] Jul 05 11:31:28 volprox kernel: pci_bus 0000:01: resource 1 [mem 0xfe800000-0xfe9fffff] Jul 05 11:31:28 volprox kernel: pci_bus 0000:01: resource 2 [mem 0xfd400000-0xfd5fffff 64bit pref] Jul 05 11:31:28 volprox kernel: pci_bus 0000:02: resource 0 [io 0xd000-0xdfff] Jul 05 11:31:28 volprox kernel: pci_bus 0000:02: resource 1 [mem 0xfe600000-0xfe7fffff] Jul 05 11:31:28 volprox kernel: pci_bus 0000:02: resource 2 [mem 0xfd200000-0xfd3fffff 64bit pref] Jul 05 11:31:28 volprox kernel: pci_bus 0000:03: resource 0 [io 0xc000-0xcfff] Jul 05 11:31:28 volprox kernel: pci_bus 0000:03: resource 1 [mem 0xfe400000-0xfe5fffff] Jul 05 11:31:28 volprox kernel: pci_bus 0000:03: resource 2 [mem 0xfd000000-0xfd1fffff 64bit pref] Jul 05 11:31:28 volprox kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Jul 05 11:31:28 volprox kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Jul 05 11:31:28 volprox kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11 Jul 05 11:31:28 volprox kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 10 Jul 05 11:31:28 volprox kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Jul 05 11:31:28 volprox kernel: PCI: CLS 64 bytes, default 64 Jul 05 11:31:28 volprox kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Jul 05 11:31:28 volprox kernel: software IO TLB: mapped [mem 0x00000000bbfba000-0x00000000bffba000] (64MB) Jul 05 11:31:28 volprox kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x70c7414a6ec, max_idle_ns: 881590470838 ns Jul 05 11:31:28 volprox kernel: Trying to unpack rootfs image as initramfs... Jul 05 11:31:28 volprox kernel: Initialise system trusted keyrings Jul 05 11:31:28 volprox kernel: workingset: timestamp_bits=46 max_order=20 bucket_order=0 Jul 05 11:31:28 volprox kernel: Key type asymmetric registered Jul 05 11:31:28 volprox kernel: Asymmetric key parser 'x509' registered Jul 05 11:31:28 volprox kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jul 05 11:31:28 volprox kernel: io scheduler mq-deadline registered Jul 05 11:31:28 volprox kernel: io scheduler kyber registered Jul 05 11:31:28 volprox kernel: ledtrig-cpu: registered to indicate activity on CPUs Jul 05 11:31:28 volprox kernel: shpchp 0000:00:05.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0.S28_) Jul 05 11:31:28 volprox kernel: shpchp 0000:00:05.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0) Jul 05 11:31:28 volprox kernel: shpchp 0000:00:05.0: Cannot get control of SHPC hotplug Jul 05 11:31:28 volprox kernel: shpchp 0000:00:1e.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0.SF0_) Jul 05 11:31:28 volprox kernel: shpchp 0000:00:1e.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0) Jul 05 11:31:28 volprox kernel: shpchp 0000:00:1e.0: Cannot get control of SHPC hotplug Jul 05 11:31:28 volprox kernel: shpchp 0000:00:1f.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0.SF8_) Jul 05 11:31:28 volprox kernel: shpchp 0000:00:1f.0: Requesting control of SHPC hotplug via OSHP (\_SB_.PCI0) Jul 05 11:31:28 volprox kernel: shpchp 0000:00:1f.0: Cannot get control of SHPC hotplug Jul 05 11:31:28 volprox kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Jul 05 11:31:28 volprox kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 Jul 05 11:31:28 volprox kernel: ACPI: button: Power Button [PWRF] Jul 05 11:31:28 volprox kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Jul 05 11:31:28 volprox kernel: Linux agpgart interface v0.103 Jul 05 11:31:28 volprox kernel: ata_piix 0000:00:01.1: version 2.13 Jul 05 11:31:28 volprox kernel: scsi host0: ata_piix Jul 05 11:31:28 volprox kernel: scsi host1: ata_piix Jul 05 11:31:28 volprox kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xf180 irq 14 lpm-pol 0 Jul 05 11:31:28 volprox kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xf188 irq 15 lpm-pol 0 Jul 05 11:31:28 volprox kernel: uhci_hcd 0000:00:01.2: UHCI Host Controller Jul 05 11:31:28 volprox kernel: uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 Jul 05 11:31:28 volprox kernel: uhci_hcd 0000:00:01.2: detected 2 ports Jul 05 11:31:28 volprox kernel: uhci_hcd 0000:00:01.2: irq 11, io port 0x0000f140 Jul 05 11:31:28 volprox kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.12 Jul 05 11:31:28 volprox kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jul 05 11:31:28 volprox kernel: usb usb1: Product: UHCI Host Controller Jul 05 11:31:28 volprox kernel: usb usb1: Manufacturer: Linux 6.12.30-volumio uhci_hcd Jul 05 11:31:28 volprox kernel: usb usb1: SerialNumber: 0000:00:01.2 Jul 05 11:31:28 volprox kernel: hub 1-0:1.0: USB hub found Jul 05 11:31:28 volprox kernel: hub 1-0:1.0: 2 ports detected Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:00:10.0: xHCI Host Controller Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:00:10.0: new USB bus registered, assigned bus number 2 Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:00:10.0: hcc params 0x200077c1 hci version 0x100 quirks 0x0000000000009810 Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:00:10.0: xHCI Host Controller Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:00:10.0: new USB bus registered, assigned bus number 3 Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:00:10.0: Host supports USB 3.0 SuperSpeed Jul 05 11:31:28 volprox kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12 Jul 05 11:31:28 volprox kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jul 05 11:31:28 volprox kernel: usb usb2: Product: xHCI Host Controller Jul 05 11:31:28 volprox kernel: usb usb2: Manufacturer: Linux 6.12.30-volumio xhci-hcd Jul 05 11:31:28 volprox kernel: usb usb2: SerialNumber: 0000:00:10.0 Jul 05 11:31:28 volprox kernel: hub 2-0:1.0: USB hub found Jul 05 11:31:28 volprox kernel: hub 2-0:1.0: 12 ports detected Jul 05 11:31:28 volprox kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.12 Jul 05 11:31:28 volprox kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jul 05 11:31:28 volprox kernel: usb usb3: Product: xHCI Host Controller Jul 05 11:31:28 volprox kernel: usb usb3: Manufacturer: Linux 6.12.30-volumio xhci-hcd Jul 05 11:31:28 volprox kernel: usb usb3: SerialNumber: 0000:00:10.0 Jul 05 11:31:28 volprox kernel: hub 3-0:1.0: USB hub found Jul 05 11:31:28 volprox kernel: hub 3-0:1.0: 6 ports detected Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:02:1b.0: xHCI Host Controller Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:02:1b.0: new USB bus registered, assigned bus number 4 Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:02:1b.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010 Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:02:1b.0: xHCI Host Controller Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:02:1b.0: new USB bus registered, assigned bus number 5 Jul 05 11:31:28 volprox kernel: xhci_hcd 0000:02:1b.0: Host supports USB 3.0 SuperSpeed Jul 05 11:31:28 volprox kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12 Jul 05 11:31:28 volprox kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jul 05 11:31:28 volprox kernel: usb usb4: Product: xHCI Host Controller Jul 05 11:31:28 volprox kernel: usb usb4: Manufacturer: Linux 6.12.30-volumio xhci-hcd Jul 05 11:31:28 volprox kernel: usb usb4: SerialNumber: 0000:02:1b.0 Jul 05 11:31:28 volprox kernel: hub 4-0:1.0: USB hub found Jul 05 11:31:28 volprox kernel: hub 4-0:1.0: 15 ports detected Jul 05 11:31:28 volprox kernel: usb usb5: We don't know the algorithms for LPM for this host, disabling LPM. Jul 05 11:31:28 volprox kernel: usb usb5: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.12 Jul 05 11:31:28 volprox kernel: usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jul 05 11:31:28 volprox kernel: usb usb5: Product: xHCI Host Controller Jul 05 11:31:28 volprox kernel: usb usb5: Manufacturer: Linux 6.12.30-volumio xhci-hcd Jul 05 11:31:28 volprox kernel: usb usb5: SerialNumber: 0000:02:1b.0 Jul 05 11:31:28 volprox kernel: hub 5-0:1.0: USB hub found Jul 05 11:31:28 volprox kernel: hub 5-0:1.0: 15 ports detected Jul 05 11:31:28 volprox kernel: usbcore: registered new interface driver usb-storage Jul 05 11:31:28 volprox kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jul 05 11:31:28 volprox kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jul 05 11:31:28 volprox kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jul 05 11:31:28 volprox kernel: mousedev: PS/2 mouse device common for all mice Jul 05 11:31:28 volprox kernel: rtc_cmos 00:03: RTC can wake from S4 Jul 05 11:31:28 volprox kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 Jul 05 11:31:28 volprox kernel: rtc_cmos 00:03: registered as rtc0 Jul 05 11:31:28 volprox kernel: rtc_cmos 00:03: setting system clock to 2025-07-05T02:31:21 UTC (1751682681) Jul 05 11:31:28 volprox kernel: rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Jul 05 11:31:28 volprox kernel: i2c_dev: i2c /dev entries driver Jul 05 11:31:28 volprox kernel: intel_pstate: CPU model not supported Jul 05 11:31:28 volprox kernel: hid: raw HID events driver (C) Jiri Kosina Jul 05 11:31:28 volprox kernel: NET: Registered PF_INET6 protocol family Jul 05 11:31:28 volprox kernel: Segment Routing with IPv6 Jul 05 11:31:28 volprox kernel: In-situ OAM (IOAM) with IPv6 Jul 05 11:31:28 volprox kernel: mip6: Mobile IPv6 Jul 05 11:31:28 volprox kernel: NET: Registered PF_PACKET protocol family Jul 05 11:31:28 volprox kernel: mpls_gso: MPLS GSO support Jul 05 11:31:28 volprox kernel: IPI shorthand broadcast: enabled Jul 05 11:31:28 volprox kernel: sched_clock: Marking stable (405706320, 7253198)->(414915325, -1955807) Jul 05 11:31:28 volprox kernel: Loading compiled-in X.509 certificates Jul 05 11:31:28 volprox kernel: clk: Disabling unused clocks Jul 05 11:31:28 volprox kernel: PM: genpd: Disabling unused power domains Jul 05 11:31:28 volprox kernel: ata2: found unknown device (class 0) Jul 05 11:31:28 volprox kernel: ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Jul 05 11:31:28 volprox kernel: scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Jul 05 11:31:28 volprox kernel: usb 1-1: new full-speed USB device number 2 using uhci_hcd Jul 05 11:31:28 volprox kernel: usb 2-8: new high-speed USB device number 2 using xhci_hcd Jul 05 11:31:28 volprox kernel: usb 1-1: not running at top speed; connect to a high speed hub Jul 05 11:31:28 volprox kernel: usb 2-8: New USB device found, idVendor=262a, idProduct=0001, bcdDevice= 0.02 Jul 05 11:31:28 volprox kernel: usb 2-8: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jul 05 11:31:28 volprox kernel: usb 2-8: Product: USB HIFI Audio Jul 05 11:31:28 volprox kernel: usb 2-8: Manufacturer: Pawpaw Jul 05 11:31:28 volprox kernel: usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 Jul 05 11:31:28 volprox kernel: usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 Jul 05 11:31:28 volprox kernel: usb 1-1: Product: QEMU USB Tablet Jul 05 11:31:28 volprox kernel: usb 1-1: Manufacturer: QEMU Jul 05 11:31:28 volprox kernel: usb 1-1: SerialNumber: 28754-0000:00:01.2-1 Jul 05 11:31:28 volprox kernel: Freeing initrd memory: 78524K Jul 05 11:31:28 volprox kernel: Freeing unused kernel image (initmem) memory: 3048K Jul 05 11:31:28 volprox kernel: Write protecting the kernel read-only data: 22528k Jul 05 11:31:28 volprox kernel: Freeing unused kernel image (rodata/data gap) memory: 792K Jul 05 11:31:28 volprox kernel: Run /init as init process Jul 05 11:31:28 volprox kernel: with arguments: Jul 05 11:31:28 volprox kernel: /init Jul 05 11:31:28 volprox kernel: splash Jul 05 11:31:28 volprox kernel: with environment: Jul 05 11:31:28 volprox kernel: HOME=/ Jul 05 11:31:28 volprox kernel: TERM=linux Jul 05 11:31:28 volprox kernel: BOOT_IMAGE=vmlinuz Jul 05 11:31:28 volprox kernel: biosdevname=0 Jul 05 11:31:28 volprox kernel: imgpart=UUID=f9122924-079c-42eb-9700-f39ff249b20f Jul 05 11:31:28 volprox kernel: bootpart=UUID=9F79-DB23 Jul 05 11:31:28 volprox kernel: datapart=UUID=235821d1-628a-4647-a5fe-6c10402b8c33 Jul 05 11:31:28 volprox kernel: hwdevice=x86 Jul 05 11:31:28 volprox kernel: uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg Jul 05 11:31:28 volprox kernel: imgfile=/volumio_current.sqsh Jul 05 11:31:28 volprox kernel: use_kmsg=no Jul 05 11:31:28 volprox kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 Jul 05 11:31:28 volprox kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Jul 05 11:31:28 volprox kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jul 05 11:31:28 volprox kernel: ACPI: bus type drm_connector registered Jul 05 11:31:28 volprox kernel: ahci 0000:00:07.0: version 3.0 Jul 05 11:31:28 volprox kernel: 8139cp: 8139cp: 10/100 PCI Ethernet driver v1.3 (Mar 22, 2004) Jul 05 11:31:28 volprox kernel: ahci 0000:00:07.0: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Jul 05 11:31:28 volprox kernel: ahci 0000:00:07.0: 6/6 ports implemented (port mask 0x3f) Jul 05 11:31:28 volprox kernel: ahci 0000:00:07.0: flags: 64bit ncq only Jul 05 11:31:28 volprox kernel: FDC 0 is a S82078B Jul 05 11:31:28 volprox kernel: bochs-drm 0000:00:02.0: vgaarb: deactivate vga console Jul 05 11:31:28 volprox kernel: usbcore: registered new interface driver usbhid Jul 05 11:31:28 volprox kernel: usbhid: USB HID core driver Jul 05 11:31:28 volprox kernel: 8139cp 0000:00:12.0 eth0: RTL-8139C+ at 0x(____ptrval____), bc:24:11:d8:93:66, IRQ 10 Jul 05 11:31:28 volprox kernel: 8139too: 8139too Fast Ethernet driver 0.9.28 Jul 05 11:31:28 volprox kernel: Console: switching to colour dummy device 80x25 Jul 05 11:31:28 volprox kernel: [drm] Found bochs VGA, ID 0xb0c5. Jul 05 11:31:28 volprox kernel: [drm] Framebuffer size 16384 kB @ 0xfc000000, mmio @ 0xfea74000. Jul 05 11:31:28 volprox kernel: scsi host2: ahci Jul 05 11:31:28 volprox kernel: [drm] Found EDID data blob. Jul 05 11:31:28 volprox kernel: input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 Jul 05 11:31:28 volprox kernel: input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 Jul 05 11:31:28 volprox kernel: scsi host3: ahci Jul 05 11:31:28 volprox kernel: [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 Jul 05 11:31:28 volprox kernel: scsi host4: ahci Jul 05 11:31:28 volprox kernel: sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Jul 05 11:31:28 volprox kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jul 05 11:31:28 volprox kernel: fbcon: bochs-drmdrmfb (fb0) is primary device Jul 05 11:31:28 volprox kernel: Console: switching to colour frame buffer device 160x50 Jul 05 11:31:28 volprox kernel: bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device Jul 05 11:31:28 volprox kernel: scsi host5: ahci Jul 05 11:31:28 volprox kernel: scsi host6: ahci Jul 05 11:31:28 volprox kernel: scsi host7: ahci Jul 05 11:31:28 volprox kernel: hid-generic 0003:262A:0001.0001: No inputs registered, leaving Jul 05 11:31:28 volprox kernel: hid-generic 0003:262A:0001.0001: hidraw0: USB HID v1.00 Device [Pawpaw USB HIFI Audio] on usb-0000:00:10.0-8/input0 Jul 05 11:31:28 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.0002/input/input6 Jul 05 11:31:28 volprox kernel: ata3: SATA max UDMA/133 abar m4096@0xfea76000 port 0xfea76100 irq 30 lpm-pol 0 Jul 05 11:31:28 volprox kernel: ata4: SATA max UDMA/133 abar m4096@0xfea76000 port 0xfea76180 irq 30 lpm-pol 0 Jul 05 11:31:28 volprox kernel: ata5: SATA max UDMA/133 abar m4096@0xfea76000 port 0xfea76200 irq 30 lpm-pol 0 Jul 05 11:31:28 volprox kernel: ata6: SATA max UDMA/133 abar m4096@0xfea76000 port 0xfea76280 irq 30 lpm-pol 0 Jul 05 11:31:28 volprox kernel: ata7: SATA max UDMA/133 abar m4096@0xfea76000 port 0xfea76300 irq 30 lpm-pol 0 Jul 05 11:31:28 volprox kernel: ata8: SATA max UDMA/133 abar m4096@0xfea76000 port 0xfea76380 irq 30 lpm-pol 0 Jul 05 11:31:28 volprox kernel: hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0 Jul 05 11:31:28 volprox kernel: sr 1:0:0:0: Attached scsi CD-ROM sr0 Jul 05 11:31:28 volprox kernel: ata7: SATA link down (SStatus 0 SControl 300) Jul 05 11:31:28 volprox kernel: ata5: SATA link down (SStatus 0 SControl 300) Jul 05 11:31:28 volprox kernel: ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jul 05 11:31:28 volprox kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jul 05 11:31:28 volprox kernel: ata8: SATA link down (SStatus 0 SControl 300) Jul 05 11:31:28 volprox kernel: ata4.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100 Jul 05 11:31:28 volprox kernel: ata4.00: 23011328 sectors, multi 16: LBA48 NCQ (depth 32) Jul 05 11:31:28 volprox kernel: ata4.00: applying bridge limits Jul 05 11:31:28 volprox kernel: ata6: SATA link down (SStatus 0 SControl 300) Jul 05 11:31:28 volprox kernel: ata3.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100 Jul 05 11:31:28 volprox kernel: ata3.00: 28778496 sectors, multi 16: LBA48 NCQ (depth 32) Jul 05 11:31:28 volprox kernel: ata3.00: applying bridge limits Jul 05 11:31:28 volprox kernel: ata3.00: configured for UDMA/100 Jul 05 11:31:28 volprox kernel: ata4.00: configured for UDMA/100 Jul 05 11:31:28 volprox kernel: scsi 2:0:0:0: Direct-Access ATA QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 Jul 05 11:31:28 volprox kernel: sd 2:0:0:0: [sda] 28778496 512-byte logical blocks: (14.7 GB/13.7 GiB) Jul 05 11:31:28 volprox kernel: scsi 3:0:0:0: Direct-Access ATA QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 Jul 05 11:31:28 volprox kernel: sd 2:0:0:0: [sda] Write Protect is off Jul 05 11:31:28 volprox kernel: sd 2:0:0:0: [sda] Mode Sense: 00 3a 00 00 Jul 05 11:31:28 volprox kernel: sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jul 05 11:31:28 volprox kernel: sd 2:0:0:0: [sda] Preferred minimum I/O size 512 bytes Jul 05 11:31:28 volprox kernel: sd 3:0:0:0: [sdb] 23011328 512-byte logical blocks: (11.8 GB/11.0 GiB) Jul 05 11:31:28 volprox kernel: sd 3:0:0:0: [sdb] Write Protect is off Jul 05 11:31:28 volprox kernel: sd 3:0:0:0: [sdb] Mode Sense: 00 3a 00 00 Jul 05 11:31:28 volprox kernel: sd 3:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jul 05 11:31:28 volprox kernel: sd 3:0:0:0: [sdb] Preferred minimum I/O size 512 bytes Jul 05 11:31:28 volprox kernel: sdb: sdb1 sdb2 sdb3 Jul 05 11:31:28 volprox kernel: sda: sda1 sda2 sda3 Jul 05 11:31:28 volprox kernel: sd 3:0:0:0: [sdb] Attached SCSI disk Jul 05 11:31:28 volprox kernel: sd 2:0:0:0: [sda] Attached SCSI disk Jul 05 11:31:28 volprox kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 05 11:31:28 volprox kernel: sdhci: Secure Digital Host Controller Interface driver Jul 05 11:31:28 volprox kernel: sdhci: Copyright(c) Pierre Ossman Jul 05 11:31:28 volprox kernel: fuse: init (API version 7.41) Jul 05 11:31:28 volprox kernel: usbcore: registered new interface driver uas Jul 05 11:31:28 volprox kernel: i915.modeset=1 is deprecated. Please remove it and the 'nomodeset' kernel parameter instead. Jul 05 11:31:28 volprox kernel: [drm] radeon kernel modesetting enabled. Jul 05 11:31:28 volprox kernel: random: crng init done Jul 05 11:31:28 volprox kernel: FAT-fs (sdb1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jul 05 11:31:28 volprox kernel: EXT4-fs (sdb2): recovery complete Jul 05 11:31:28 volprox kernel: EXT4-fs (sdb2): mounted filesystem f9122924-079c-42eb-9700-f39ff249b20f r/w with ordered data mode. Quota mode: none. Jul 05 11:31:28 volprox kernel: loop: module loaded Jul 05 11:31:28 volprox kernel: block device autoloading is deprecated and will be removed. Jul 05 11:31:28 volprox kernel: loop0: detected capacity change from 0 to 2317560 Jul 05 11:31:28 volprox kernel: EXT4-fs (sdb3): recovery complete Jul 05 11:31:28 volprox kernel: EXT4-fs (sdb3): mounted filesystem 235821d1-628a-4647-a5fe-6c10402b8c33 r/w with ordered data mode. Quota mode: none. Jul 05 11:31:28 volprox systemd[1]: Inserted module 'autofs4' Jul 05 11:31:28 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) Jul 05 11:31:28 volprox systemd[1]: Detected virtualization kvm. Jul 05 11:31:28 volprox systemd[1]: Detected architecture x86-64. Jul 05 11:31:28 volprox systemd[1]: Hostname set to . Jul 05 11:31:28 volprox systemd[1]: Queued start job for default target graphical.target. Jul 05 11:31:28 volprox systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 05 11:31:28 volprox systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 05 11:31:28 volprox systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 05 11:31:28 volprox systemd[1]: Created slice user.slice - User and Session Slice. Jul 05 11:31:28 volprox systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 05 11:31:28 volprox systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 05 11:31:28 volprox systemd[1]: Expecting device dev-disk-by\x2duuid-9F79\x2dDB23.device - /dev/disk/by-uuid/9F79-DB23... Jul 05 11:31:28 volprox systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 05 11:31:28 volprox systemd[1]: Reached target slices.target - Slice Units. Jul 05 11:31:28 volprox systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 05 11:31:28 volprox systemd[1]: Listening on rpcbind.socket - RPCbind Server Activation Socket. Jul 05 11:31:28 volprox systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket. Jul 05 11:31:28 volprox systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. Jul 05 11:31:28 volprox systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Jul 05 11:31:28 volprox systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 05 11:31:28 volprox systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jul 05 11:31:28 volprox systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 05 11:31:28 volprox systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 05 11:31:28 volprox systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 05 11:31:28 volprox systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 05 11:31:28 volprox systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 05 11:31:28 volprox systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 05 11:31:28 volprox systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Jul 05 11:31:28 volprox systemd[1]: Started dynamicswap.service - dynamicswap service. Jul 05 11:31:28 volprox systemd[1]: Reached target swap.target - Swaps. Jul 05 11:31:28 volprox systemd[1]: Starting fake-hwclock.service - Restore / save the current clock... Jul 05 11:31:28 volprox systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 05 11:31:28 volprox systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 05 11:31:28 volprox systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 05 11:31:28 volprox systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 05 11:31:28 volprox systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 05 11:31:28 volprox systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 05 11:31:28 volprox systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 05 11:31:28 volprox systemd[1]: Starting systemd-journald.service - Journal Service... Jul 05 11:31:28 volprox systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 05 11:31:28 volprox systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 05 11:31:28 volprox systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 05 11:31:28 volprox systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 05 11:31:28 volprox systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 05 11:31:28 volprox systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 05 11:31:28 volprox systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 05 11:31:28 volprox systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 05 11:31:28 volprox systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 05 11:31:28 volprox systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 05 11:31:28 volprox systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 05 11:31:28 volprox systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 05 11:31:28 volprox systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 05 11:31:28 volprox systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 05 11:31:28 volprox systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 05 11:31:28 volprox systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 05 11:31:28 volprox systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 05 11:31:28 volprox systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 05 11:31:28 volprox systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 05 11:31:28 volprox systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 05 11:31:28 volprox systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 05 11:31:28 volprox systemd-journald[504]: Journal started Jul 05 11:31:28 volprox systemd-journald[504]: Runtime Journal (/run/log/journal/532ebd11fccb7018a1d61544683a89a5) is 3.7M, max 30.0M, 26.2M free. Jul 05 11:31:28 volprox systemd[1]: Started systemd-journald.service - Journal Service. Jul 05 11:31:28 volprox systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 05 11:31:28 volprox systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 05 11:31:28 volprox systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 05 11:31:28 volprox systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 05 11:31:28 volprox systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 05 11:31:28 volprox systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 05 11:31:28 volprox systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 05 11:31:28 volprox systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Jul 05 11:31:28 volprox systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 05 11:31:28 volprox systemd[1]: Starting systemd-random-seed.service - Load/Save Random Seed... Jul 05 11:31:28 volprox systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 05 11:31:28 volprox fake-hwclock[496]: Current system time: 2025-07-05 02:31:28 Jul 05 11:31:28 volprox fake-hwclock[496]: fake-hwclock saved clock information is in the past: 2025-07-05 02:30:06 Jul 05 11:31:28 volprox fake-hwclock[496]: To set system time to this saved clock anyway, use "force" Jul 05 11:31:28 volprox systemd[1]: Finished fake-hwclock.service - Restore / save the current clock. Jul 05 11:31:28 volprox systemd[1]: Finished systemd-random-seed.service - Load/Save Random Seed. Jul 05 11:31:28 volprox systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Jul 05 11:31:28 volprox systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 05 11:31:28 volprox systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 05 11:31:28 volprox systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 05 11:31:28 volprox systemd[1]: dynamicswap.service: Deactivated successfully. Jul 05 11:31:28 volprox systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 05 11:31:28 volprox systemd[1]: Starting ifupdown-pre.service - Helper to synchronize boot up for ifupdown... Jul 05 11:31:28 volprox systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 05 11:31:28 volprox systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 05 11:31:28 volprox systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jul 05 11:31:28 volprox systemd[1]: Mounting tmp.mount - /tmp... Jul 05 11:31:28 volprox systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jul 05 11:31:28 volprox systemd[1]: Mounting var-log.mount - /var/log... Jul 05 11:31:28 volprox systemd[1]: Mounting var-spool-cups.mount - /var/spool/cups... Jul 05 11:31:28 volprox systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 05 11:31:28 volprox systemd[1]: Finished ifupdown-pre.service - Helper to synchronize boot up for ifupdown. Jul 05 11:31:28 volprox systemd[1]: Mounted tmp.mount - /tmp. Jul 05 11:31:28 volprox systemd[1]: Mounted var-log.mount - /var/log. Jul 05 11:31:28 volprox systemd[1]: Mounted var-spool-cups.mount - /var/spool/cups. Jul 05 11:31:28 volprox systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 05 11:31:28 volprox systemd-journald[504]: Runtime Journal (/run/log/journal/532ebd11fccb7018a1d61544683a89a5) is 3.7M, max 30.0M, 26.2M free. Jul 05 11:31:28 volprox systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 05 11:31:28 volprox systemd-journald[504]: Received client request to flush runtime journal. Jul 05 11:31:28 volprox systemd-udevd[534]: Using default interface naming scheme 'v252'. Jul 05 11:31:28 volprox systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 05 11:31:28 volprox systemd[1]: Starting plymouth-start.service - Show Plymouth Boot Screen... Jul 05 11:31:28 volprox systemd[1]: Started plymouth-start.service - Show Plymouth Boot Screen. Jul 05 11:31:28 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). Jul 05 11:31:28 volprox systemd[1]: Started systemd-ask-password-plymouth.path - Forward Password Requests to Plymouth Directory Watch. Jul 05 11:31:28 volprox systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 05 11:31:28 volprox kernel: sr 1:0:0:0: Attached scsi generic sg0 type 5 Jul 05 11:31:28 volprox kernel: sd 2:0:0:0: Attached scsi generic sg1 type 0 Jul 05 11:31:28 volprox kernel: sd 3:0:0:0: Attached scsi generic sg2 type 0 Jul 05 11:31:28 volprox (udev-worker)[549]: Network interface NamePolicy= disabled on kernel command line. Jul 05 11:31:28 volprox systemd[1]: Found device dev-disk-by\x2duuid-9F79\x2dDB23.device - QEMU_HARDDISK boot. Jul 05 11:31:28 volprox systemd[1]: Starting systemd-fsck@dev-disk-by\x2duuid-9F79\x2dDB23.service - File System Check on /dev/disk/by-uuid/9F79-DB23... Jul 05 11:31:28 volprox systemd[1]: Started systemd-fsckd.service - File System Check Daemon to report status. Jul 05 11:31:28 volprox (udev-worker)[554]: mouse1: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox systemd[1]: Expecting device sys-subsystem-net-devices-eth0.device - /sys/subsystem/net/devices/eth0... Jul 05 11:31:29 volprox systemd-fsck[592]: fsck.fat 4.2 (2021-01-31) Jul 05 11:31:29 volprox systemd-fsck[592]: /dev/sdb1: 18 files, 22738/93500 clusters Jul 05 11:31:29 volprox systemd[1]: Finished systemd-fsck@dev-disk-by\x2duuid-9F79\x2dDB23.service - File System Check on /dev/disk/by-uuid/9F79-DB23. Jul 05 11:31:29 volprox systemd[1]: Found device sys-subsystem-net-devices-eth0.device - RTL-8100/8101L/8139 PCI Fast Ethernet Adapter (QEMU Virtual Machine). Jul 05 11:31:29 volprox kernel: cryptd: max_cpu_qlen set to 1000 Jul 05 11:31:29 volprox (udev-worker)[545]: event0: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox (udev-worker)[544]: event2: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox (udev-worker)[553]: event3: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox systemd[1]: Listening on systemd-rfkill.socket - Load/Save RF Kill Switch Status /dev/rfkill Watch. Jul 05 11:31:29 volprox (udev-worker)[546]: mouse0: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox (udev-worker)[550]: event1: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox kernel: usbcore: registered new interface driver snd-usb-audio Jul 05 11:31:29 volprox (udev-worker)[541]: mouse2: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC887-VD: line_outs=1 (0x14/0x0/0x0/0x0/0x0) type:line Jul 05 11:31:29 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Jul 05 11:31:29 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: hp_outs=1 (0x1b/0x0/0x0/0x0/0x0) Jul 05 11:31:29 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0 Jul 05 11:31:29 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: dig-out=0x11/0x0 Jul 05 11:31:29 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: inputs: Jul 05 11:31:29 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: Rear Mic=0x18 Jul 05 11:31:29 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: Front Mic=0x19 Jul 05 11:31:29 volprox kernel: snd_hda_codec_realtek hdaudioC0D0: Line=0x1a Jul 05 11:31:29 volprox kernel: snd_hda_codec_hdmi hdaudioC0D2: No i915 binding for Intel HDMI/DP codec Jul 05 11:31:29 volprox kernel: hdaudio hdaudioC0D2: Unable to configure, disabling Jul 05 11:31:29 volprox kernel: input: HDA Intel PCH Rear Mic as /devices/pci0000:00/0000:00:11.0/sound/card0/input7 Jul 05 11:31:29 volprox kernel: input: HDA Intel PCH Front Mic as /devices/pci0000:00/0000:00:11.0/sound/card0/input8 Jul 05 11:31:29 volprox kernel: input: HDA Intel PCH Line as /devices/pci0000:00/0000:00:11.0/sound/card0/input9 Jul 05 11:31:29 volprox kernel: input: HDA Intel PCH Line Out as /devices/pci0000:00/0000:00:11.0/sound/card0/input10 Jul 05 11:31:29 volprox kernel: input: HDA Intel PCH Front Headphone as /devices/pci0000:00/0000:00:11.0/sound/card0/input11 Jul 05 11:31:29 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). Jul 05 11:31:29 volprox systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 05 11:31:29 volprox systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 05 11:31:29 volprox systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 05 11:31:29 volprox systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Jul 05 11:31:29 volprox systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Jul 05 11:31:29 volprox systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 05 11:31:29 volprox systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 05 11:31:29 volprox systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 05 11:31:29 volprox systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 05 11:31:29 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). Jul 05 11:31:29 volprox systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Jul 05 11:31:29 volprox systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Jul 05 11:31:29 volprox systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 05 11:31:29 volprox systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 05 11:31:29 volprox systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 05 11:31:29 volprox systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 05 11:31:29 volprox (udev-worker)[542]: event4: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox (udev-worker)[557]: event9: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox (udev-worker)[544]: event8: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox (udev-worker)[537]: event7: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox (udev-worker)[552]: event6: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox (udev-worker)[545]: event5: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 05 11:31:29 volprox (udev-worker)[540]: pcmC5D0p: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Jul 05 11:31:29 volprox systemd[1]: Mounting boot.mount - /boot... Jul 05 11:31:29 volprox systemd[1]: Mounting var-spool-cups-tmp.mount - /var/spool/cups/tmp... Jul 05 11:31:29 volprox kernel: FAT-fs (sdb1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jul 05 11:31:29 volprox systemd[1]: Mounted boot.mount - /boot. Jul 05 11:31:29 volprox systemd[1]: Mounted var-spool-cups-tmp.mount - /var/spool/cups/tmp. Jul 05 11:31:29 volprox systemd[1]: Reached target local-fs.target - Local File Systems. Jul 05 11:31:29 volprox systemd[1]: Started ifup@eth0.service - ifup for eth0. Jul 05 11:31:29 volprox systemd[1]: Starting networking.service - Raise network interfaces... Jul 05 11:31:29 volprox systemd[1]: Starting plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data... Jul 05 11:31:29 volprox systemd[1]: Starting systemd-binfmt.service - Set Up Additional Binary Formats... Jul 05 11:31:29 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). Jul 05 11:31:29 volprox systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 05 11:31:29 volprox systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 693 (systemd-binfmt) Jul 05 11:31:29 volprox systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Jul 05 11:31:29 volprox systemd[1]: Finished plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data. Jul 05 11:31:29 volprox systemd[1]: Received SIGRTMIN+20 from PID 363 (plymouthd). Jul 05 11:31:29 volprox systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Jul 05 11:31:29 volprox systemd[1]: Finished systemd-binfmt.service - Set Up Additional Binary Formats. Jul 05 11:31:29 volprox systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 05 11:31:29 volprox systemd[1]: Mounting run-rpc_pipefs.mount - RPC Pipe File System... Jul 05 11:31:29 volprox systemd[1]: Started haveged.service - Entropy Daemon based on the HAVEGE algorithm. Jul 05 11:31:29 volprox systemd[1]: Starting rpcbind.service - RPC bind portmap service... Jul 05 11:31:29 volprox systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 05 11:31:29 volprox kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Jul 05 11:31:29 volprox systemd[1]: Started rpcbind.service - RPC bind portmap service. Jul 05 11:31:29 volprox systemd[1]: Reached target rpcbind.target - RPC Port Mapper. Jul 05 11:31:29 volprox systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 05 11:31:29 volprox systemd[1]: Reached target sysinit.target - System Initialization. Jul 05 11:31:29 volprox systemd[1]: Started acpid.path - ACPI Events Check. Jul 05 11:31:29 volprox systemd[1]: Started apt-daily.timer - Daily apt download activities. Jul 05 11:31:29 volprox systemd[1]: Started apt-daily-upgrade.timer - Daily apt upgrade and clean activities. Jul 05 11:31:29 volprox systemd[1]: Started dpkg-db-backup.timer - Daily dpkg database backup timer. Jul 05 11:31:29 volprox systemd[1]: Started e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems. Jul 05 11:31:29 volprox systemd[1]: Started fstrim.timer - Discard unused blocks once a week. Jul 05 11:31:29 volprox systemd[1]: Started man-db.timer - Daily man-db regeneration. Jul 05 11:31:29 volprox systemd[1]: Started ntpsec-rotate-stats.timer - Rotate ntpd stats daily. Jul 05 11:31:29 volprox systemd[1]: Started setdatetime-helper.timer - Volumio Time Sync Watchdog Timer. Jul 05 11:31:29 volprox systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 05 11:31:29 volprox systemd[1]: Reached target paths.target - Path Units. Jul 05 11:31:29 volprox systemd[1]: Reached target timers.target - Timer Units. Jul 05 11:31:29 volprox systemd[1]: Listening on acpid.socket - ACPID Listen Socket. Jul 05 11:31:29 volprox systemd[1]: Listening on avahi-daemon.socket - Avahi mDNS/DNS-SD Stack Activation Socket. Jul 05 11:31:29 volprox systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 05 11:31:29 volprox systemd[1]: Listening on triggerhappy.socket. Jul 05 11:31:29 volprox systemd[1]: Reached target sockets.target - Socket Units. Jul 05 11:31:29 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). Jul 05 11:31:29 volprox systemd[1]: Reached target basic.target - Basic System. Jul 05 11:31:29 volprox systemd[1]: Started acpid.service - ACPI event daemon. Jul 05 11:31:29 volprox kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Jul 05 11:31:29 volprox kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Jul 05 11:31:29 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). Jul 05 11:31:29 volprox systemd[1]: Starting alsa-restore.service - Save/Restore Sound Card State... Jul 05 11:31:29 volprox systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Jul 05 11:31:29 volprox systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 05 11:31:29 volprox systemd[1]: Starting e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots... Jul 05 11:31:29 volprox kernel: RPC: Registered named UNIX socket transport module. Jul 05 11:31:29 volprox kernel: RPC: Registered udp transport module. Jul 05 11:31:29 volprox kernel: RPC: Registered tcp transport module. Jul 05 11:31:29 volprox kernel: RPC: Registered tcp-with-tls transport module. Jul 05 11:31:29 volprox kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jul 05 11:31:29 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). Jul 05 11:31:29 volprox systemd[1]: headless_wireless.service - Copy user wpa_supplicant.conf was skipped because of an unmet condition check (ConditionPathExists=/boot/wpa_supplicant.conf). Jul 05 11:31:29 volprox systemd[1]: Started iptables.service - Volumio Iptables Module. Jul 05 11:31:29 volprox ifup[704]: command failed: No such device (-19) Jul 05 11:31:29 volprox sh[705]: command failed: No such device (-19) Jul 05 11:31:29 volprox systemd[1]: Starting systemd-logind.service - User Login Management... Jul 05 11:31:29 volprox systemd[1]: Starting triggerhappy.service - triggerhappy global hotkey daemon... Jul 05 11:31:29 volprox systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jul 05 11:31:29 volprox systemd[1]: Started volumio-remote-updater.service - Volumio Remote OTA Updater. Jul 05 11:31:29 volprox systemd[1]: Starting volumio_rfkill_unblock.service - Manage nl80211 modules blocking state... Jul 05 11:31:29 volprox systemd[1]: volumiossh.service - Volumio SSH enabler was skipped because of an unmet condition check (ConditionPathExistsGlob=/boot/ssh{,.txt}). Jul 05 11:31:29 volprox systemd[1]: Starting wireless.service - Wireless Services... Jul 05 11:31:29 volprox systemd[1]: Mounted run-rpc_pipefs.mount - RPC Pipe File System. Jul 05 11:31:29 volprox systemd[1]: Finished alsa-restore.service - Save/Restore Sound Card State. Jul 05 11:31:29 volprox systemd[1]: Reached target rpc_pipefs.target. Jul 05 11:31:29 volprox systemd[1]: Reached target sound.target - Sound Card. Jul 05 11:31:29 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). Jul 05 11:31:29 volprox systemd[1]: Reached target nfs-client.target - NFS client services. Jul 05 11:31:29 volprox systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 05 11:31:29 volprox systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 05 11:31:29 volprox systemd[1]: Starting loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling... Jul 05 11:31:29 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). Jul 05 11:31:29 volprox haveged[710]: haveged: command socket is listening at fd 3 Jul 05 11:31:29 volprox volumio_rfkill_unblock.sh[737]: Volumio WiFi Soft Blocked check script Jul 05 11:31:29 volprox volumio_rfkill_unblock.sh[737]: Check if rfkill is available Jul 05 11:31:29 volprox volumio_rfkill_unblock.sh[737]: Check if rfkill listed devices are already unblocked Jul 05 11:31:29 volprox thd[732]: Unable to parse trigger line: Jul 05 11:31:29 volprox thd[732]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Jul 05 11:31:29 volprox thd[732]: Unable to parse trigger line: Jul 05 11:31:29 volprox thd[732]: Unable to parse trigger line: Jul 05 11:31:29 volprox thd[732]: Unable to parse trigger line: Jul 05 11:31:29 volprox thd[732]: Unable to parse trigger line: Jul 05 11:31:29 volprox thd[732]: Unable to parse trigger line: Jul 05 11:31:29 volprox thd[732]: Unable to parse trigger line: Jul 05 11:31:29 volprox thd[732]: Found socket passed from systemd Jul 05 11:31:29 volprox systemd[1]: e2scrub_reap.service: Deactivated successfully. Jul 05 11:31:29 volprox systemd[1]: Finished e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots. Jul 05 11:31:29 volprox avahi-daemon[720]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Jul 05 11:31:29 volprox avahi-daemon[720]: Successfully dropped root privileges. Jul 05 11:31:29 volprox avahi-daemon[720]: avahi-daemon 0.8 starting up. Jul 05 11:31:29 volprox volumio_rfkill_unblock.sh[737]: Wi-Fi is already unblocked. Jul 05 11:31:29 volprox systemd[1]: Finished volumio_rfkill_unblock.service - Manage nl80211 modules blocking state. Jul 05 11:31:29 volprox systemd-logind[731]: New seat seat0. Jul 05 11:31:29 volprox systemd[1]: Starting dhcpcd.service - DHCP Client Daemon on all interfaces... Jul 05 11:31:29 volprox systemd[1]: Started triggerhappy.service - triggerhappy global hotkey daemon. Jul 05 11:31:29 volprox systemd-logind[731]: Watching system buttons on /dev/input/event0 (Power Button) Jul 05 11:31:29 volprox systemd-logind[731]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Jul 05 11:31:29 volprox acpid[718]: starting up with netlink and the input layer Jul 05 11:31:29 volprox ifup[778]: command failed: No such device (-19) Jul 05 11:31:29 volprox sh[773]: dhcpcd-9.4.1 starting Jul 05 11:31:29 volprox dhcpcd[773]: dhcpcd-9.4.1 starting Jul 05 11:31:29 volprox sh[773]: DUID 00:04:43:5c:66:39:d9:0b:46:78:8d:da:27:66:66:31:a1:b5 Jul 05 11:31:29 volprox dhcpcd[787]: DUID 00:04:43:5c:66:39:d9:0b:46:78:8d:da:27:66:66:31:a1:b5 Jul 05 11:31:29 volprox volumio-remote-updater[736]: Volumio OTA Client: 1.7.0 Jul 05 11:31:29 volprox acpid[718]: 3 rules loaded Jul 05 11:31:29 volprox acpid[718]: waiting for events: event logging is off Jul 05 11:31:29 volprox dhcpcd[755]: dhcpcd-9.4.1 starting Jul 05 11:31:29 volprox volumio-remote-updater[736]: Error: No active session Jul 05 11:31:29 volprox systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 05 11:31:29 volprox volumio-remote-updater[736]: [2025-07-05 11:31:29] [info] asio async_connect error: asio.system:111 (Connection refused) Jul 05 11:31:29 volprox volumio-remote-updater[736]: [2025-07-05 11:31:29] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Jul 05 11:31:29 volprox volumio-remote-updater[736]: [2025-07-05 11:31:29] [error] handle_connect error: Connection refused Jul 05 11:31:29 volprox dbus-daemon[722]: [system] Successfully activated service 'org.freedesktop.systemd1' Jul 05 11:31:29 volprox avahi-daemon[720]: Successfully called chroot(). Jul 05 11:31:29 volprox avahi-daemon[720]: Successfully dropped remaining capabilities. Jul 05 11:31:29 volprox dhcpcd[795]: dev: loaded udev Jul 05 11:31:29 volprox dhcpcd[795]: DUID 00:04:43:5c:66:39:d9:0b:46:78:8d:da:27:66:66:31:a1:b5 Jul 05 11:31:29 volprox avahi-daemon[720]: Loading service file /services/volumio.service. Jul 05 11:31:29 volprox avahi-daemon[720]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Jul 05 11:31:29 volprox avahi-daemon[720]: New relevant interface lo.IPv4 for mDNS. Jul 05 11:31:29 volprox avahi-daemon[720]: Network interface enumeration completed. Jul 05 11:31:29 volprox avahi-daemon[720]: Registering new address record for 127.0.0.1 on lo.IPv4. Jul 05 11:31:29 volprox systemd[1]: Starting wpa_supplicant.service - WPA supplicant... Jul 05 11:31:29 volprox systemd[1]: Started systemd-logind.service - User Login Management. Jul 05 11:31:29 volprox systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Jul 05 11:31:29 volprox kernel: 8021q: 802.1Q VLAN Support v1.8 Jul 05 11:31:29 volprox systemd[1]: Started dhcpcd.service - DHCP Client Daemon on all interfaces. Jul 05 11:31:29 volprox haveged[710]: haveged: ver: 1.9.14; arch: x86; vend: GenuineIntel; build: (gcc 12.2.0 ITV); collect: 128K Jul 05 11:31:29 volprox haveged[710]: haveged: cpu: (L4 VC); data: 32K (L2 L4 V); inst: 32K (L2 L4 V); idx: 24/40; sz: 32010/53875 Jul 05 11:31:29 volprox haveged[710]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00069 Jul 05 11:31:29 volprox haveged[710]: haveged: fills: 0, generated: 0 Jul 05 11:31:29 volprox upmpdcli[733]: Could not open config: /tmp/upmpdcli.conf Jul 05 11:31:29 volprox systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jul 05 11:31:29 volprox systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jul 05 11:31:29 volprox loadcpufreq[741]: Loading cpufreq kernel modules...failed. Jul 05 11:31:29 volprox systemd[1]: Started loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling. Jul 05 11:31:29 volprox wpa_supplicant[801]: Successfully initialized wpa_supplicant Jul 05 11:31:29 volprox systemd[1]: Starting cpufrequtils.service - LSB: set CPUFreq kernel parameters... Jul 05 11:31:29 volprox systemd[1]: Started wpa_supplicant.service - WPA supplicant. Jul 05 11:31:29 volprox systemd[1]: iptables.service: Deactivated successfully. Jul 05 11:31:29 volprox dhcpcd[787]: eth0: waiting for carrier Jul 05 11:31:29 volprox sh[773]: eth0: waiting for carrier Jul 05 11:31:29 volprox sh[773]: eth0: carrier acquired Jul 05 11:31:29 volprox dhcpcd[787]: eth0: carrier acquired Jul 05 11:31:29 volprox kernel: 8139cp 0000:00:12.0 eth0: link up, 100Mbps, full-duplex, lpa 0x05E1 Jul 05 11:31:29 volprox dhcpcd[795]: eth0: waiting for carrier Jul 05 11:31:29 volprox dhcpcd[795]: eth0: carrier acquired Jul 05 11:31:29 volprox dhcpcd[795]: eth0: IAID 11:d8:93:66 Jul 05 11:31:29 volprox dhcpcd[787]: eth0: IAID 11:d8:93:66 Jul 05 11:31:29 volprox dhcpcd[787]: eth0: adding address fe80::4766:cf0c:75a1:cff4 Jul 05 11:31:29 volprox dhcpcd[787]: ipv6_addaddr1: Permission denied Jul 05 11:31:29 volprox dhcpcd[795]: eth0: adding address fe80::4766:cf0c:75a1:cff4 Jul 05 11:31:29 volprox sh[773]: eth0: IAID 11:d8:93:66 Jul 05 11:31:29 volprox sh[773]: eth0: adding address fe80::4766:cf0c:75a1:cff4 Jul 05 11:31:29 volprox sh[773]: ipv6_addaddr1: Permission denied Jul 05 11:31:29 volprox cpufrequtils[850]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Jul 05 11:31:29 volprox dhcpcd[795]: ipv6_addaddr1: Permission denied Jul 05 11:31:29 volprox systemd[1]: Started cpufrequtils.service - LSB: set CPUFreq kernel parameters. Jul 05 11:31:29 volprox systemd[1]: Finished networking.service - Raise network interfaces. Jul 05 11:31:29 volprox systemd[1]: Reached target network.target - Network. Jul 05 11:31:29 volprox systemd[1]: Reached target network-online.target - Network is Online. Jul 05 11:31:29 volprox systemd[1]: Starting ifplugd.service - LSB: Brings up/down network automatically... Jul 05 11:31:29 volprox systemd[1]: Starting nmbd.service - Samba NMB Daemon... Jul 05 11:31:29 volprox systemd[1]: Starting ntpsec.service - Network Time Service... Jul 05 11:31:29 volprox systemd[1]: Starting rc-local.service - /etc/rc.local Compatibility... Jul 05 11:31:29 volprox systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart... Jul 05 11:31:29 volprox systemd[1]: Starting samba-ad-dc.service - Samba AD Daemon... Jul 05 11:31:29 volprox systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Jul 05 11:31:29 volprox systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 05 11:31:29 volprox sm-notify[906]: Version 2.6.2 starting Jul 05 11:31:29 volprox systemd[1]: Starting ssh.service - OpenBSD Secure Shell server... Jul 05 11:31:29 volprox systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 05 11:31:29 volprox dbus-daemon[722]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.4' (uid=0 pid=913 comm="timedatectl show --property=NTPSynchronized --valu") Jul 05 11:31:29 volprox systemd[1]: Started volumio-ipchange.service - Volumio IP Change Monitor. Jul 05 11:31:29 volprox systemd[1]: Starting welcome.service - Show a welcome message on console... Jul 05 11:31:29 volprox systemd[1]: Started rc-local.service - /etc/rc.local Compatibility. Jul 05 11:31:29 volprox systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart. Jul 05 11:31:29 volprox systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 05 11:31:29 volprox ntpd[917]: INIT: ntpd ntpsec-1.2.2: Starting Jul 05 11:31:29 volprox ntpd[917]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Jul 05 11:31:29 volprox ntp-systemd-wrapper[917]: 2025-07-05T11:31:29 ntpd[917]: INIT: ntpd ntpsec-1.2.2: Starting Jul 05 11:31:29 volprox ntp-systemd-wrapper[917]: 2025-07-05T11:31:29 ntpd[917]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Jul 05 11:31:29 volprox ntpd[928]: INIT: precision = 0.058 usec (-24) Jul 05 11:31:29 volprox welcome[922]: Resolved ip:[0] Jul 05 11:31:29 volprox systemd[1]: Starting plymouth-quit-wait.service - Hold until boot process finishes up... Jul 05 11:31:29 volprox ntpd[928]: INIT: successfully locked into RAM Jul 05 11:31:29 volprox systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... Jul 05 11:31:30 volprox systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jul 05 11:31:30 volprox systemd[1]: Started ntpsec.service - Network Time Service. Jul 05 11:31:30 volprox ntpd[928]: CONFIG: readconfig: parsing file: /etc/ntpsec/ntp.conf Jul 05 11:31:30 volprox ntpd[928]: CONFIG: restrict nopeer ignored Jul 05 11:31:30 volprox ntpd[928]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jul 05 11:31:30 volprox ntpd[928]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2025-12-28T00:00Z last=2017-01-01T00:00Z ofs=37 Jul 05 11:31:30 volprox ntpd[928]: INIT: Using SO_TIMESTAMPNS(ns) Jul 05 11:31:30 volprox ntpd[928]: IO: Listen and drop on 0 v6wildcard [::]:123 Jul 05 11:31:30 volprox ntpd[928]: IO: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jul 05 11:31:30 volprox ntpd[928]: IO: Listen normally on 2 lo 127.0.0.1:123 Jul 05 11:31:30 volprox ntpd[928]: IO: Listening on routing socket on fd #19 for interface updates Jul 05 11:31:30 volprox systemd[1]: Received SIGRTMIN+21 from PID 363 (plymouthd). Jul 05 11:31:30 volprox systemd[1]: Received SIGRTMIN+21 from PID 363 (plymouthd). Jul 05 11:31:30 volprox systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. Jul 05 11:31:30 volprox systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. Jul 05 11:31:30 volprox systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 05 11:31:30 volprox systemd[1]: Reached target getty.target - Login Prompts. Jul 05 11:31:30 volprox ntpd[928]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes Jul 05 11:31:30 volprox ntpd[928]: INIT: Built with OpenSSL 3.0.9 30 May 2023, 30000090 Jul 05 11:31:30 volprox ntpd[928]: INIT: Running with OpenSSL 3.0.16 11 Feb 2025, 30000100 Jul 05 11:31:30 volprox sshd[933]: Server listening on 0.0.0.0 port 22. Jul 05 11:31:30 volprox sshd[933]: Server listening on :: port 22. Jul 05 11:31:30 volprox ntpd[928]: NTSc: Using system default root certificates. Jul 05 11:31:30 volprox systemd[1]: Started ssh.service - OpenBSD Secure Shell server. Jul 05 11:31:30 volprox ifplugd(eth0)[947]: ifplugd 0.28 initializing. Jul 05 11:31:30 volprox ifplugd(eth0)[947]: Using interface eth0/BC:24:11:D8:93:66 with driver <8139cp> (version: 1.3) Jul 05 11:31:30 volprox ifplugd(eth0)[947]: Using detection mode: SIOCETHTOOL Jul 05 11:31:30 volprox ifplugd(eth0)[947]: Initialization complete, link beat detected. Jul 05 11:31:30 volprox dhcpcd[795]: eth0: soliciting a DHCP lease Jul 05 11:31:30 volprox systemd[1]: Finished welcome.service - Show a welcome message on console. Jul 05 11:31:30 volprox dbus-daemon[722]: [system] Successfully activated service 'org.freedesktop.timedate1' Jul 05 11:31:30 volprox systemd[1]: Started systemd-timedated.service - Time & Date Service. Jul 05 11:31:30 volprox bash[912]: Time is already synchronized. Jul 05 11:31:30 volprox systemd[1]: setdatetime-helper.service: Deactivated successfully. Jul 05 11:31:30 volprox systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Jul 05 11:31:30 volprox dhcpcd[795]: eth0: offered 172.30.1.70 from 172.30.1.254 Jul 05 11:31:30 volprox ntpd[928]: statistics directory /var/log/ntpsec/ does not exist or is unwriteable, error No such file or directory Jul 05 11:31:30 volprox ifplugd(eth0)[947]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jul 05 11:31:30 volprox dhcpcd[795]: eth0: probing address 172.30.1.70/24 Jul 05 11:31:30 volprox dhcpcd[795]: eth0: soliciting an IPv6 router Jul 05 11:31:30 volprox ifplugd(eth0)[947]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Jul 05 11:31:30 volprox systemd[1]: samba-ad-dc.service: Skipped due to 'exec-condition'. Jul 05 11:31:30 volprox systemd[1]: Condition check resulted in samba-ad-dc.service - Samba AD Daemon being skipped. Jul 05 11:31:30 volprox iw[987]: command failed: No such device (-19) Jul 05 11:31:30 volprox iwconfig[994]: Error for wireless request "Set Power Management" (8B2C) : Jul 05 11:31:30 volprox iwconfig[994]: SET failed on device wlan0 ; No such device. Jul 05 11:31:30 volprox systemd[1]: wireless.service: Deactivated successfully. Jul 05 11:31:30 volprox systemd[1]: Started wireless.service - Wireless Services. Jul 05 11:31:30 volprox systemd[1]: Started volumio.service - Volumio Backend Module. Jul 05 11:31:30 volprox systemd[1]: Started screenshot.service - Process screenshots triggered by PrtSc-button. Jul 05 11:31:30 volprox systemd[1]: Started soundcard-init.service - Intel SST and HDA soundcard init service. Jul 05 11:31:30 volprox systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. Jul 05 11:31:30 volprox volumio-cpu-tweak[1002]: Setting RT Priority for mpd Jul 05 11:31:30 volprox volumio-cpu-tweak[1027]: pid 35's current scheduling policy: SCHED_OTHER Jul 05 11:31:30 volprox volumio-cpu-tweak[1027]: pid 35's current scheduling priority: 0 Jul 05 11:31:30 volprox volumio-cpu-tweak[1002]: Setting MPD Affinity Jul 05 11:31:30 volprox volumio-cpu-tweak[1031]: pid 3's current affinity mask: f Jul 05 11:31:30 volprox volumio-cpu-tweak[1002]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jul 05 11:31:30 volprox volumio-cpu-tweak[1037]: Error setting new values. Common errors: Jul 05 11:31:30 volprox volumio-cpu-tweak[1037]: - Do you have proper administration rights? (super-user?) Jul 05 11:31:30 volprox volumio-cpu-tweak[1037]: - Is the governor you requested available and modprobed? Jul 05 11:31:30 volprox volumio-cpu-tweak[1037]: - Trying to set an invalid policy? Jul 05 11:31:30 volprox volumio-cpu-tweak[1037]: - Trying to set a specific frequency, but userspace governor is not available, Jul 05 11:31:30 volprox volumio-cpu-tweak[1037]: for example because of hardware which cannot be set to a specific frequency Jul 05 11:31:30 volprox volumio-cpu-tweak[1037]: or because the userspace governor isn't loaded? Jul 05 11:31:30 volprox systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. Jul 05 11:31:30 volprox avahi-daemon[720]: Server startup complete. Host name is volprox.local. Local service cookie is 3897367730. Jul 05 11:31:30 volprox nmbd[988]: [2025/07/05 11:31:30.610290, 0] ../../source3/nmbd/nmbd.c:901(main) Jul 05 11:31:30 volprox nmbd[988]: nmbd version 4.17.12-Debian started. Jul 05 11:31:30 volprox nmbd[988]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Jul 05 11:31:30 volprox nmbd[988]: [2025/07/05 11:31:30.617463, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) Jul 05 11:31:30 volprox nmbd[988]: started asyncdns process 1058 Jul 05 11:31:30 volprox nmbd[988]: [2025/07/05 11:31:30.618168, 0] ../../lib/util/become_daemon.c:150(daemon_status) Jul 05 11:31:30 volprox nmbd[988]: daemon_status: daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jul 05 11:31:30 volprox nmbd[988]: [2025/07/05 11:31:30.618210, 0] ../../source3/nmbd/nmbd_subnetdb.c:252(create_subnets) Jul 05 11:31:30 volprox nmbd[988]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jul 05 11:31:30 volprox soundcard-init.sh[1065]: Simple mixer control 'IEC958',0 Jul 05 11:31:30 volprox soundcard-init.sh[1065]: Capabilities: pswitch pswitch-joined Jul 05 11:31:30 volprox soundcard-init.sh[1065]: Playback channels: Mono Jul 05 11:31:30 volprox soundcard-init.sh[1065]: Mono: Playback [on] Jul 05 11:31:30 volprox systemd[1]: soundcard-init.service: Deactivated successfully. Jul 05 11:31:30 volprox dhcpcd[787]: eth0: soliciting an IPv6 router Jul 05 11:31:30 volprox sh[773]: eth0: soliciting an IPv6 router Jul 05 11:31:31 volprox ntpd[928]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Jul 05 11:31:31 volprox ntpd[928]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Jul 05 11:31:31 volprox ntpd[928]: DNS: dns_check: DNS error: -11, System error Jul 05 11:31:31 volprox ntpd[928]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 Jul 05 11:31:31 volprox volumio[997]: info: ------------------------------------------- Jul 05 11:31:31 volprox volumio[997]: info: ----- Volumio3 ---- Jul 05 11:31:31 volprox volumio[997]: info: ------------------------------------------- Jul 05 11:31:31 volprox volumio[997]: info: ----- System startup ---- Jul 05 11:31:31 volprox volumio[997]: info: ------------------------------------------- Jul 05 11:31:31 volprox dhcpcd[787]: eth0: soliciting a DHCP lease Jul 05 11:31:31 volprox sh[773]: eth0: soliciting a DHCP lease Jul 05 11:31:31 volprox sh[773]: eth0: offered 172.30.1.70 from 172.30.1.254 Jul 05 11:31:31 volprox dhcpcd[787]: eth0: offered 172.30.1.70 from 172.30.1.254 Jul 05 11:31:31 volprox sh[773]: eth0: probing address 172.30.1.70/24 Jul 05 11:31:31 volprox dhcpcd[787]: eth0: probing address 172.30.1.70/24 Jul 05 11:31:31 volprox volumio[997]: info: MYVOLUMIO Environment detected Jul 05 11:31:31 volprox volumio[997]: info: Plugin folders cleanup Jul 05 11:31:31 volprox volumio[997]: info: Scanning into folder /volumio/app/plugins/ Jul 05 11:31:31 volprox volumio[997]: info: Scanning category audio_interface Jul 05 11:31:31 volprox volumio[997]: info: Scanning category miscellanea Jul 05 11:31:31 volprox volumio[997]: info: Scanning category music_service Jul 05 11:31:31 volprox volumio[997]: info: Scanning category plugins.json Jul 05 11:31:31 volprox volumio[997]: info: Scanning category system_controller Jul 05 11:31:31 volprox volumio[997]: info: Scanning category user_interface Jul 05 11:31:31 volprox volumio[997]: info: Scanning into folder /data/plugins/ Jul 05 11:31:31 volprox volumio[997]: info: Scanning category music_service Jul 05 11:31:31 volprox volumio[997]: info: Scanning category system_controller Jul 05 11:31:31 volprox volumio[997]: info: Scanning category user_interface Jul 05 11:31:31 volprox volumio[997]: info: Plugin folders cleanup completed Jul 05 11:31:31 volprox volumio[997]: info: ------------------------------------------- Jul 05 11:31:31 volprox volumio[997]: info: ----- Core plugins startup ---- Jul 05 11:31:31 volprox volumio[997]: info: ------------------------------------------- Jul 05 11:31:31 volprox volumio[997]: info: Loading plugins from folder /volumio/app/plugins/ Jul 05 11:31:31 volprox volumio[997]: info: Adding plugin upnp to MyMusic Plugins Jul 05 11:31:31 volprox volumio[997]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 05 11:31:31 volprox volumio[997]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 05 11:31:31 volprox volumio[997]: info: Loading plugins from folder /data/plugins/ Jul 05 11:31:31 volprox volumio[997]: info: Loading plugin "system"... Jul 05 11:31:31 volprox volumio[997]: info: Loading plugin "appearance"... Jul 05 11:31:31 volprox avahi-daemon[720]: Service "VolProx" (/services/volumio.service) successfully established. Jul 05 11:31:31 volprox volumio[997]: info: Loading plugin "network"... Jul 05 11:31:31 volprox volumio[997]: info: Refreshing Cached IP Addresses Jul 05 11:31:31 volprox volumio[997]: info: Loading plugin "services"... Jul 05 11:31:31 volprox volumio[997]: info: Loading plugin "alsa_controller"... Jul 05 11:31:31 volprox sudo[1107]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 05 11:31:31 volprox sudo[1096]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 05 11:31:31 volprox sudo[1094]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 05 11:31:31 volprox sudo[1094]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:31 volprox sudo[1096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:31 volprox sudo[1107]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:31 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 05 11:31:31 volprox sudo[1094]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:31 volprox volumio[997]: info: Loading plugin "wizard"... Jul 05 11:31:31 volprox volumio[997]: info: Loading plugin "networkfs"... Jul 05 11:31:31 volprox sudo[1096]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:31 volprox sudo[1107]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:31 volprox volumio[997]: info: Starting Udev Watcher for removable devices Jul 05 11:31:31 volprox sudo[1132]: 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/VolProx Jul 05 11:31:31 volprox sudo[1132]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:31 volprox volumio[997]: info: Ignoring mount for partition: boot Jul 05 11:31:31 volprox volumio[997]: info: Ignoring mount for partition: volumio Jul 05 11:31:31 volprox volumio[997]: info: Ignoring mount for partition: volumio_data Jul 05 11:31:31 volprox volumio[997]: info: Ignoring mount for partition: boot Jul 05 11:31:31 volprox volumio[997]: info: Ignoring mount for partition: volumio Jul 05 11:31:31 volprox volumio[997]: info: Ignoring mount for partition: volumio_data Jul 05 11:31:31 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 05 11:31:31 volprox volumio[997]: info: Loading plugin "volumio_command_line_client"... Jul 05 11:31:31 volprox volumio[997]: info: Loading plugin "upnp"... Jul 05 11:31:31 volprox volumio[997]: info: [1751682691964] Starting Upmpd Daemon Jul 05 11:31:31 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 05 11:31:31 volprox volumio[997]: info: Loading plugin "my_music"... Jul 05 11:31:31 volprox volumio[997]: info: Loading plugin "mpd"... Jul 05 11:31:31 volprox kernel: netfs: FS-Cache loaded Jul 05 11:31:31 volprox kernel: Key type dns_resolver registered Jul 05 11:31:32 volprox sudo[1132]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:32 volprox kernel: Key type cifs.spnego registered Jul 05 11:31:32 volprox kernel: Key type cifs.idmap registered Jul 05 11:31:32 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. Jul 05 11:31:32 volprox kernel: CIFS: Attempting to mount //172.30.1.60/music Jul 05 11:31:32 volprox kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jul 05 11:31:32 volprox kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jul 05 11:31:32 volprox ntpd[928]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Jul 05 11:31:32 volprox ntpd[928]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Jul 05 11:31:32 volprox ntpd[928]: DNS: dns_check: DNS error: -11, System error Jul 05 11:31:32 volprox ntpd[928]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12 Jul 05 11:31:32 volprox volumio[997]: info: Loading plugin "upnp_browser"... Jul 05 11:31:32 volprox volumio[997]: info: Loading plugin "alarm-clock"... Jul 05 11:31:32 volprox volumio[997]: info: Loading plugin "airplay_emulation"... Jul 05 11:31:32 volprox volumio[997]: info: Starting Shairport Sync Jul 05 11:31:32 volprox volumio[997]: info: Loading plugin "last_100"... Jul 05 11:31:32 volprox volumio[997]: info: Loading plugin "webradio"... Jul 05 11:31:32 volprox volumio[997]: info: Loading plugin "i2s_dacs"... Jul 05 11:31:32 volprox volumio[997]: info: I2S DAC not set, start Auto-detection Jul 05 11:31:32 volprox volumio[997]: info: Loading plugin "volumiodiscovery"... Jul 05 11:31:32 volprox volumio[997]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 05 11:31:32 volprox volumio[997]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 05 11:31:32 volprox volumio[997]: *** WARNING *** For more information see Jul 05 11:31:32 volprox volumio[997]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 05 11:31:32 volprox node[997]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 05 11:31:32 volprox volumio[997]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 05 11:31:32 volprox volumio[997]: *** WARNING *** For more information see Jul 05 11:31:32 volprox node[997]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 05 11:31:32 volprox node[997]: *** WARNING *** For more information see Jul 05 11:31:32 volprox node[997]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 05 11:31:32 volprox node[997]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 05 11:31:32 volprox node[997]: *** WARNING *** For more information see Jul 05 11:31:32 volprox volumio[997]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 05 11:31:32 volprox volumio[997]: info: Discovery: Started advertising with name: VolProx Jul 05 11:31:32 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 05 11:31:32 volprox volumio[997]: info: Loading plugin "youtube2"... Jul 05 11:31:33 volprox ntpd[928]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Jul 05 11:31:33 volprox ntpd[928]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Jul 05 11:31:33 volprox ntpd[928]: DNS: dns_check: DNS error: -11, System error Jul 05 11:31:33 volprox ntpd[928]: DNS: dns_take_status: 2.debian.pool.ntp.org=>error, 12 Jul 05 11:31:33 volprox volumio[997]: info: Loading plugin "ytcr"... Jul 05 11:31:34 volprox ntpd[928]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Jul 05 11:31:34 volprox ntpd[928]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Jul 05 11:31:34 volprox ntpd[928]: DNS: dns_check: DNS error: -11, System error Jul 05 11:31:34 volprox ntpd[928]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12 Jul 05 11:31:34 volprox volumio[997]: info: Loading plugin "ytmusic"... Jul 05 11:31:34 volprox volumio-remote-updater[736]: [2025-07-05 11:31:34] [connect] Successful connection Jul 05 11:31:34 volprox dhcpcd[795]: eth0: leased 172.30.1.70 for 3600 seconds Jul 05 11:31:34 volprox avahi-daemon[720]: Joining mDNS multicast group on interface eth0.IPv4 with address 172.30.1.70. Jul 05 11:31:34 volprox dhcpcd[795]: eth0: adding route to 172.30.1.0/24 Jul 05 11:31:34 volprox avahi-daemon[720]: New relevant interface eth0.IPv4 for mDNS. Jul 05 11:31:34 volprox avahi-daemon[720]: Registering new address record for 172.30.1.70 on eth0.IPv4. Jul 05 11:31:34 volprox dhcpcd[795]: eth0: adding default route via 172.30.1.254 Jul 05 11:31:35 volprox systemd[1]: welcome.service: Deactivated successfully. Jul 05 11:31:35 volprox systemd[1]: Stopped welcome.service - Show a welcome message on console. Jul 05 11:31:35 volprox systemd[1]: Stopping welcome.service - Show a welcome message on console... Jul 05 11:31:35 volprox systemd[1]: Starting welcome.service - Show a welcome message on console... Jul 05 11:31:35 volprox welcome[1169]: Resolved ip:[1] 172.30.1.70 Jul 05 11:31:35 volprox systemd[1]: Finished welcome.service - Show a welcome message on console. Jul 05 11:31:35 volprox systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Jul 05 11:31:35 volprox systemd[1]: Started nmbd.service - Samba NMB Daemon. Jul 05 11:31:35 volprox systemd[1]: Starting winbind.service - Samba Winbind Daemon... Jul 05 11:31:35 volprox winbindd[1186]: [2025/07/05 11:31:35.282306, 0] ../../source3/winbindd/winbindd.c:1440(main) Jul 05 11:31:35 volprox winbindd[1186]: winbindd version 4.17.12-Debian started. Jul 05 11:31:35 volprox winbindd[1186]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Jul 05 11:31:35 volprox winbindd[1186]: [2025/07/05 11:31:35.287874, 0] ../../source3/winbindd/winbindd_cache.c:3117(initialize_winbindd_cache) Jul 05 11:31:35 volprox winbindd[1186]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jul 05 11:31:35 volprox systemd[1]: Started winbind.service - Samba Winbind Daemon. Jul 05 11:31:35 volprox systemd[1]: Starting smbd.service - Samba SMB Daemon... Jul 05 11:31:35 volprox smbd[1200]: [2025/07/05 11:31:35.475682, 0] ../../source3/smbd/server.c:1741(main) Jul 05 11:31:35 volprox smbd[1200]: smbd version 4.17.12-Debian started. Jul 05 11:31:35 volprox smbd[1200]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Jul 05 11:31:35 volprox dhcpcd[787]: eth0: leased 172.30.1.70 for 3600 seconds Jul 05 11:31:35 volprox sh[773]: eth0: leased 172.30.1.70 for 3600 seconds Jul 05 11:31:35 volprox dhcpcd[787]: eth0: adding route to 172.30.1.0/24 Jul 05 11:31:35 volprox sh[773]: eth0: adding route to 172.30.1.0/24 Jul 05 11:31:35 volprox dhcpcd[787]: eth0: adding default route via 172.30.1.254 Jul 05 11:31:35 volprox sh[773]: eth0: adding default route via 172.30.1.254 Jul 05 11:31:35 volprox systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Jul 05 11:31:35 volprox systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Jul 05 11:31:35 volprox systemd[1]: welcome.service: Deactivated successfully. Jul 05 11:31:35 volprox systemd[1]: Stopped welcome.service - Show a welcome message on console. Jul 05 11:31:35 volprox systemd[1]: Stopping welcome.service - Show a welcome message on console... Jul 05 11:31:35 volprox sh[773]: forked to background, child pid 786 Jul 05 11:31:35 volprox systemd[1]: Starting welcome.service - Show a welcome message on console... Jul 05 11:31:35 volprox welcome[1221]: Resolved ip:[1] 172.30.1.70 Jul 05 11:31:35 volprox systemd[1]: Finished welcome.service - Show a welcome message on console. Jul 05 11:31:35 volprox systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Jul 05 11:31:35 volprox volumio[997]: info: Loading plugin "SleepWakePlugin"... Jul 05 11:31:35 volprox ifplugd(eth0)[947]: client: ifup: interface eth0 already configured Jul 05 11:31:35 volprox sh[1258]: eth0=eth0 Jul 05 11:31:35 volprox systemd[1]: Started smbd.service - Samba SMB Daemon. Jul 05 11:31:35 volprox ifplugd(eth0)[947]: Program executed successfully. Jul 05 11:31:35 volprox ifplugd[901]: Network Interface Plugging Daemon...start eth0...done. Jul 05 11:31:35 volprox systemd[1]: Started ifplugd.service - LSB: Brings up/down network automatically. Jul 05 11:31:35 volprox systemd[1]: Reached target multi-user.target - Multi-User System. Jul 05 11:31:35 volprox systemd[1]: Reached target graphical.target - Graphical Interface. Jul 05 11:31:35 volprox volumio[997]: info: Applying required configuration parameters for plugin SleepWakePlugin Jul 05 11:31:35 volprox volumio[997]: info: SleepWakePlugin - onVolumioStart Jul 05 11:31:35 volprox volumio[997]: info: Loading plugin "autostart"... Jul 05 11:31:35 volprox systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Jul 05 11:31:35 volprox systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Jul 05 11:31:35 volprox systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Jul 05 11:31:35 volprox systemd[1]: Startup finished in 6.832s (kernel) + 7.881s (userspace) = 14.714s. Jul 05 11:31:35 volprox volumio[997]: info: Applying required configuration parameters for plugin autostart Jul 05 11:31:35 volprox volumio[997]: info: AutoStart - onVolumioStart - read config.json Jul 05 11:31:35 volprox volumio[997]: info: Loading plugin "now_playing"... Jul 05 11:31:36 volprox volumio[997]: info: Loading plugin "outputs"... Jul 05 11:31:36 volprox volumio[997]: info: Loading plugin "albumart"... Jul 05 11:31:36 volprox volumio[997]: info: Plugin example_plugin is not enabled Jul 05 11:31:36 volprox volumio[997]: info: Loading plugin "inputs"... Jul 05 11:31:36 volprox volumio[997]: info: Loading plugin "updater_comm"... Jul 05 11:31:36 volprox volumio[1265]: Forking 3 albumart workers Jul 05 11:31:36 volprox volumio[997]: info: Plugin mpdemulation is not enabled Jul 05 11:31:36 volprox volumio[997]: info: Loading plugin "rest_api"... Jul 05 11:31:36 volprox volumio[997]: info: Loading plugin "websocket"... Jul 05 11:31:36 volprox volumio[1277]: Starting albumart workers Jul 05 11:31:36 volprox volumio[1276]: Starting albumart workers Jul 05 11:31:36 volprox volumio[997]: info: Starting Socket.io Server version 1.7.4 Jul 05 11:31:36 volprox volumio[997]: info: Loading plugin "backup_restore"... Jul 05 11:31:36 volprox volumio[1275]: Starting albumart workers Jul 05 11:31:37 volprox volumio[997]: info: Applying required configuration parameters for plugin backup_restore Jul 05 11:31:37 volprox volumio[997]: info: Loading plugin "scheduledrestart"... Jul 05 11:31:37 volprox ntpd[928]: IO: Listen normally on 3 eth0 172.30.1.70:123 Jul 05 11:31:37 volprox ntpd[928]: IO: new interface(s) found: waking up resolver Jul 05 11:31:37 volprox ntpd[928]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Jul 05 11:31:37 volprox volumio[997]: info: Applying required configuration parameters for plugin scheduledrestart Jul 05 11:31:37 volprox volumio[997]: info: Loading plugin "Systeminfo"... Jul 05 11:31:37 volprox ntpd[928]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Jul 05 11:31:37 volprox ntpd[928]: DNS: Pool taking: 158.247.202.103 Jul 05 11:31:37 volprox ntpd[928]: DNS: Pool taking: 106.247.248.106 Jul 05 11:31:37 volprox ntpd[928]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Jul 05 11:31:37 volprox volumio[997]: info: Loading plugin "randomizer"... Jul 05 11:31:37 volprox volumio[997]: info: Applying required configuration parameters for plugin randomizer Jul 05 11:31:37 volprox volumio[997]: info: Loading i18n strings for locale ko Jul 05 11:31:37 volprox volumio[997]: Updating browse sources language Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::initPlayerControls Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 05 11:31:37 volprox volumio[997]: Express server listening on port 3000 Jul 05 11:31:37 volprox volumio[997]: [Metrics] WebUI: 6s 865.94ms Jul 05 11:31:37 volprox volumio[997]: info: Setting Device type: x86 Jul 05 11:31:37 volprox volumio[997]: info: CoreStateMachine::resetVolumioState Jul 05 11:31:37 volprox volumio[997]: info: CoreStateMachine::getcurrentVolume Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::volumioRetrievevolume Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 11:31:37 volprox volumio[997]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jul 05 11:31:37 volprox volumio[997]: info: Completed loading Core Plugins Jul 05 11:31:37 volprox volumio[997]: info: Preparing to generate the ALSA configuration file Jul 05 11:31:37 volprox volumio[997]: info: Volumio Network Manager: Network status updated: 0 Jul 05 11:31:37 volprox volumio[997]: info: Cannot mount NAS VolProx at system boot, trial number 1 ,retrying in 5 seconds Jul 05 11:31:37 volprox volumio[997]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jul 05 11:31:37 volprox volumio[997]: wlan0 Interface doesn't support scanning. Jul 05 11:31:37 volprox volumio[997]: info: Cannot use regular scanning, forcing with ap-force Jul 05 11:31:37 volprox sudo[1329]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jul 05 11:31:37 volprox sudo[1329]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:37 volprox sudo[1329]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:37 volprox volumio[997]: command failed: No such device (-19) Jul 05 11:31:37 volprox volumio[997]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jul 05 11:31:37 volprox volumio[997]: command failed: No such device (-19) Jul 05 11:31:37 volprox volumio[997]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jul 05 11:31:37 volprox volumio-remote-updater[736]: [2025-07-05 11:31:37] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1751682694 101 Jul 05 11:31:37 volprox volumio[997]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 1 Jul 05 11:31:37 volprox volumio[997]: 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/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jul 05 11:31:37 volprox volumio[997]: info: Reloading queue from file Jul 05 11:31:37 volprox volumio[997]: info: VolumeController:: Volume=100 Mute =false Jul 05 11:31:37 volprox volumio[997]: info: CoreStateMachine::pushState Jul 05 11:31:37 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::volumioPushState Jul 05 11:31:37 volprox volumio[997]: info: CoreStateMachine::updateTrackBlock Jul 05 11:31:37 volprox volumio[997]: info: CorePlayQueue::getTrackBlock Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::volumioRetrievevolume Jul 05 11:31:37 volprox volumio[997]: info: Asound.conf file unchanged, so no further update is needed Jul 05 11:31:37 volprox volumio[997]: info: Output device has changed, restarting MPD Jul 05 11:31:37 volprox volumio[997]: info: Output device has changed, restarting Shairport Sync Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 11:31:37 volprox sudo[1342]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 05 11:31:37 volprox sudo[1342]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:37 volprox sudo[1342]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:37 volprox sudo[1344]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 05 11:31:37 volprox sudo[1344]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:37 volprox volumio[997]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 05 11:31:37 volprox volumio[997]: info: ___________ START PLUGINS ___________ Jul 05 11:31:37 volprox volumio[997]: info: ControllerMpd::onStart: Initializing MPD Jul 05 11:31:37 volprox volumio[997]: info: Creating MPD Configuration file Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 05 11:31:37 volprox volumio[997]: info: [1751682697929] CoreMusicLibrary::Adding element 미디어 서버 Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 11:31:37 volprox sudo[1352]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 05 11:31:37 volprox sudo[1352]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:37 volprox sudo[1354]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 05 11:31:37 volprox sudo[1354]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:37 volprox sudo[1352]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:37 volprox volumio[997]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 05 11:31:37 volprox volumio[997]: info: [1751682697951] CoreMusicLibrary::Adding element Last_100 Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 05 11:31:37 volprox volumio[997]: info: [1751682697952] CoreMusicLibrary::Adding element Webradio Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 05 11:31:37 volprox volumio[997]: info: Initializing BBC Radios Jul 05 11:31:37 volprox systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 05 11:31:37 volprox systemd[1]: Starting mpd.service - Music Player Daemon... Jul 05 11:31:37 volprox systemd[1]: mpd.service: Deactivated successfully. Jul 05 11:31:37 volprox systemd[1]: Stopped mpd.service - Music Player Daemon. Jul 05 11:31:37 volprox systemd[1]: mpd.socket: Deactivated successfully. Jul 05 11:31:37 volprox systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jul 05 11:31:37 volprox systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jul 05 11:31:37 volprox systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 05 11:31:37 volprox systemd[1]: Starting mpd.service - Music Player Daemon... Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 05 11:31:37 volprox volumio[997]: info: [1751682697987] CoreMusicLibrary::Adding element YouTube2 Jul 05 11:31:37 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 11:31:37 volprox volumio[997]: Cannot find translation for source YouTube2 Jul 05 11:31:37 volprox volumio[997]: info: [ytcr] Data store TTL expired - clearing it... Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 05 11:31:38 volprox volumio[997]: info: [1751682698001] CoreMusicLibrary::Adding element YouTube Music Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 11:31:38 volprox volumio[997]: Cannot find translation for source YouTube2 Jul 05 11:31:38 volprox volumio[997]: Cannot find translation for source YouTube Music Jul 05 11:31:38 volprox volumio[997]: info: SleepWakePlugin - onStart Jul 05 11:31:38 volprox volumio[997]: info: SleepWakePlugin - Sleep scheduled in 48501997 milliseconds Jul 05 11:31:38 volprox volumio[997]: info: SleepWakePlugin - Wake scheduled in 70101996 milliseconds Jul 05 11:31:38 volprox volumio[997]: info: AutoStart - onStart Jul 05 11:31:38 volprox sudo[1376]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 05 11:31:38 volprox sudo[1376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 05 11:31:38 volprox volumio[997]: info: [now-playing] ConfigUpdater: config is up to date. Jul 05 11:31:38 volprox sudo[1382]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jul 05 11:31:38 volprox sudo[1376]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:38 volprox volumio[997]: info: Scheduling reboots with hours: 0, minutes: 0 in timezone: Asia/Seoul Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 05 11:31:38 volprox volumio[997]: info: [1751682698025] CoreMusicLibrary::Adding element Randomizer Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 11:31:38 volprox volumio[997]: Cannot find translation for source YouTube2 Jul 05 11:31:38 volprox volumio[997]: Cannot find translation for source YouTube Music Jul 05 11:31:38 volprox volumio[997]: Cannot find translation for source Randomizer Jul 05 11:31:38 volprox volumio[997]: info: Volumio Calling Home Jul 05 11:31:38 volprox ntpd[928]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Jul 05 11:31:38 volprox volumio[997]: info: [now-playing] App is listening on port 4004. Jul 05 11:31:38 volprox volumio[997]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Jul 05 11:31:38 volprox volumio[997]: info: CoreStateMachine::setRepeat false single undefined Jul 05 11:31:38 volprox volumio[997]: info: CoreStateMachine::pushState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioPushState Jul 05 11:31:38 volprox volumio[997]: info: CoreStateMachine::setRandom true Jul 05 11:31:38 volprox volumio[997]: info: CoreStateMachine::pushState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioPushState Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 11:31:38 volprox volumio[997]: info: Discovery: Getting this device information Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 11:31:38 volprox volumio[997]: 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/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jul 05 11:31:38 volprox volumio[997]: info: MPD Permissions set Jul 05 11:31:38 volprox volumio[997]: info: MPD Permissions set Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 05 11:31:38 volprox volumio[997]: verbose: New Socket.io Connection to 172.30.1.70:3000 from 172.30.1.29 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Jul 05 11:31:38 volprox volumio[997]: info: VolumeController:: Volume=100 Mute =false Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreStateMachine::pushState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioPushState Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 05 11:31:38 volprox volumio[997]: info: Discovery: adding 83e5f107-19f4-428e-afde-43003911ea29 Jul 05 11:31:38 volprox volumio[997]: info: Discovery: Found device VolProx Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetVisibleSources Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetQueue Jul 05 11:31:38 volprox volumio[997]: info: CoreStateMachine::getQueue Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getQueue Jul 05 11:31:38 volprox volumio[997]: info: Listing playlists Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 05 11:31:38 volprox volumio[997]: info: Received Get System Info Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 11:31:38 volprox volumio[997]: info: Discovery: Getting this device information Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jul 05 11:31:38 volprox volumio[997]: info: Discovery: this is already registered, 83e5f107-19f4-428e-afde-43003911ea29 Jul 05 11:31:38 volprox volumio[997]: info: Discovery: Found device VolProx Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 05 11:31:38 volprox volumio[997]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jul 05 11:31:38 volprox volumio[997]: info: Starting Shairport Sync Jul 05 11:31:38 volprox volumio[997]: info: Starting Shairport Sync Jul 05 11:31:38 volprox volumio[997]: info: Starting Shairport Sync Jul 05 11:31:38 volprox sudo[1413]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 05 11:31:38 volprox sudo[1415]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 05 11:31:38 volprox sudo[1415]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:38 volprox sudo[1413]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:38 volprox sudo[1419]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 05 11:31:38 volprox sudo[1419]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:38 volprox systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jul 05 11:31:38 volprox systemd[1]: shairport-sync.service: Deactivated successfully. Jul 05 11:31:38 volprox systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 05 11:31:38 volprox systemd[1]: shairport-sync.service: Consumed 1.658s CPU time. Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetVisibleSources Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetQueue Jul 05 11:31:38 volprox volumio[997]: info: CoreStateMachine::getQueue Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getQueue Jul 05 11:31:38 volprox volumio[997]: info: Listing playlists Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 05 11:31:38 volprox volumio[997]: info: Received Get System Info Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 11:31:38 volprox volumio[997]: info: Discovery: Getting this device information Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 05 11:31:38 volprox sudo[1415]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:38 volprox sudo[1419]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:38 volprox sudo[1413]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:38 volprox ntpd[928]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Jul 05 11:31:38 volprox ntpd[928]: DNS: Pool taking: 121.174.142.82 Jul 05 11:31:38 volprox ntpd[928]: DNS: Pool taking: 203.32.26.46 Jul 05 11:31:38 volprox ntpd[928]: DNS: Pool taking: 2401:c080:1c00:24a1:5400:5ff:fe04:720 Jul 05 11:31:38 volprox ntpd[928]: DNS: Pool taking: 240b:400d:2:7cc8:f0d6:5ac6:f883:48db Jul 05 11:31:38 volprox ntpd[928]: DNS: Pool taking: 240b:400d:3:3300:aeda:71da:9779:d4f1 Jul 05 11:31:38 volprox ntpd[928]: DNS: Pool taking: 2001:678:8::123 Jul 05 11:31:38 volprox ntpd[928]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Jul 05 11:31:38 volprox volumio[997]: info: Shairport-Sync Started Jul 05 11:31:38 volprox volumio[997]: Error adding Membership: Error: addMembership EINVAL Jul 05 11:31:38 volprox volumio[997]: info: Shairport-Sync Started Jul 05 11:31:38 volprox volumio[997]: info: Shairport-Sync Started Jul 05 11:31:38 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:38 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:38 volprox volumio[997]: info: Volumio called home Jul 05 11:31:39 volprox ntpd[928]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Jul 05 11:31:39 volprox mpd[1383]: 2025-07-05T11:31:39 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 05 11:31:39 volprox ntpd[928]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Jul 05 11:31:39 volprox ntpd[928]: DNS: Pool taking: 121.174.142.81 Jul 05 11:31:39 volprox ntpd[928]: DNS: Pool taking: 194.0.5.123 Jul 05 11:31:39 volprox ntpd[928]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Jul 05 11:31:39 volprox systemd[1]: Started mpd.service - Music Player Daemon. Jul 05 11:31:39 volprox sudo[1354]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:39 volprox sudo[1344]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:39 volprox volumio[997]: error: MPD error: The expression evaluated to a falsy value: Jul 05 11:31:39 volprox volumio[997]: assert.ok(self.idling) Jul 05 11:31:39 volprox volumio[997]: error: The expression evaluated to a falsy value: Jul 05 11:31:39 volprox volumio[997]: assert.ok(self.idling) Jul 05 11:31:39 volprox volumio[997]: info: MPD running with PID1383 Jul 05 11:31:39 volprox volumio[997]: ,establishing connection Jul 05 11:31:39 volprox volumio[997]: error: updateQueue error: null Jul 05 11:31:39 volprox volumio[997]: error: updateQueue error: null Jul 05 11:31:39 volprox volumio[997]: info: [yt-cast-receiver] DIAL server listening on port 38098 Jul 05 11:31:39 volprox volumio[997]: info: Completed starting Core Plugins Jul 05 11:31:39 volprox volumio[997]: info: ------------------------------------------- Jul 05 11:31:39 volprox volumio[997]: info: ----- MyVolumio plugins startup ---- Jul 05 11:31:39 volprox volumio[997]: info: ------------------------------------------- Jul 05 11:31:39 volprox volumio[997]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 05 11:31:40 volprox ntpd[928]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Jul 05 11:31:40 volprox volumio[997]: verbose: New Socket.io Connection to 172.30.1.70:3000 from 172.30.1.29 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jul 05 11:31:40 volprox ntpd[928]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Jul 05 11:31:40 volprox ntpd[928]: DNS: Pool taking: 221.151.118.78 Jul 05 11:31:40 volprox ntpd[928]: DNS: Pool taking: 175.195.167.194 Jul 05 11:31:40 volprox ntpd[928]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Jul 05 11:31:41 volprox volumio[997]: info: Volumio Network Manager: Network status updated: 1 Jul 05 11:31:41 volprox sudo[1463]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 05 11:31:41 volprox sudo[1463]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:41 volprox sudo[1463]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:41 volprox sudo[1465]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 05 11:31:41 volprox sudo[1465]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:41 volprox sudo[1469]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 05 11:31:41 volprox sudo[1469]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:41 volprox sudo[1465]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:42 volprox systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jul 05 11:31:42 volprox sudo[1469]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:42 volprox volumio[997]: info: Upmpdcli Daemon Started Jul 05 11:31:42 volprox sudo[1492]: 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/VolProx Jul 05 11:31:42 volprox sudo[1492]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:42 volprox kernel: CIFS: Attempting to mount //172.30.1.60/music Jul 05 11:31:42 volprox sudo[1492]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:43 volprox upmpdcli[1517]: writing RSA key Jul 05 11:31:44 volprox ntpd[928]: CLOCK: time stepped by 0.693570 Jul 05 11:31:44 volprox ntpd[928]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes Jul 05 11:31:45 volprox volumio[997]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 05 11:31:49 volprox volumio[997]: Cannot compose Albumart path Jul 05 11:31:49 volprox volumio[997]: Cannot compose Albumart path Jul 05 11:31:49 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 11:31:49 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 11:31:49 volprox volumio[997]: info: Discovery: Getting this device information Jul 05 11:31:49 volprox volumio[997]: info: CoreCommandRouter::volumioGetState Jul 05 11:31:49 volprox volumio[997]: info: CorePlayQueue::getTrack 0 Jul 05 11:31:49 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 05 11:31:50 volprox volumio[997]: info: Adding plugin bluetooth to MyMusic Plugins Jul 05 11:31:50 volprox volumio[997]: info: Adding plugin multiroom to MyMusic Plugins Jul 05 11:31:50 volprox volumio[997]: info: Adding plugin metavolumio to MyMusic Plugins Jul 05 11:31:50 volprox volumio[997]: info: Adding plugin cd_controller to MyMusic Plugins Jul 05 11:31:50 volprox volumio[997]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 05 11:31:50 volprox volumio[997]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 05 11:31:50 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 11:31:50 volprox volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 05 11:31:50 volprox volumio[997]: info: Starting MyVolumio Remote Streaming Endpoints Jul 05 11:31:50 volprox volumio[997]: info: MyVolumio login type: Token Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 05 11:31:50 volprox volumio[997]: info: Streaming services startup Jul 05 11:31:50 volprox volumio[997]: info: Starting Streaming Daemon Jul 05 11:31:50 volprox sudo[1529]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 05 11:31:50 volprox sudo[1529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:50 volprox volumio[997]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 05 11:31:50 volprox sudo[1529]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:51 volprox volumio[997]: error: Cannot start Volumio Streaming Daemon Jul 05 11:31:51 volprox volumio[997]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 05 11:31:51 volprox volumio[997]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 05 11:31:51 volprox volumio[997]: error: MyVolumio Custom Token format not valid, refreshing it Jul 05 11:31:53 volprox volumio[997]: info: MyVolumio login type: Token Jul 05 11:31:53 volprox volumio[997]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 05 11:31:54 volprox volumio[997]: info: MyVolumio token set successfully Jul 05 11:31:54 volprox volumio[997]: info: MYVOLUMIO: Adding device Jul 05 11:31:54 volprox volumio[997]: info: MYVOLUMIO: Evaluating Server Jul 05 11:31:54 volprox volumio[997]: info: MyVolumio status changed Jul 05 11:31:54 volprox volumio[997]: info: Streaming services startup Jul 05 11:31:54 volprox volumio[997]: info: Starting Streaming Daemon Jul 05 11:31:54 volprox volumio[997]: info: Removing browser output: myVolumio user plan is not superstar Jul 05 11:31:54 volprox volumio[997]: info: Removing audio output: Jul 05 11:31:54 volprox volumio[997]: info: Stoppping Tunnel 1 Jul 05 11:31:54 volprox sudo[1577]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 05 11:31:54 volprox sudo[1577]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:54 volprox sudo[1579]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jul 05 11:31:54 volprox sudo[1579]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 05 11:31:54 volprox systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jul 05 11:31:54 volprox sudo[1577]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:54 volprox volumio[997]: error: Cannot start Volumio Streaming Daemon Jul 05 11:31:54 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. Jul 05 11:31:54 volprox volumio[997]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 05 11:31:54 volprox volumio[997]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 05 11:31:54 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. Jul 05 11:31:54 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. Jul 05 11:31:54 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. Jul 05 11:31:54 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. Jul 05 11:31:54 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. Jul 05 11:31:54 volprox sudo[1579]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:54 volprox setdatetime-helper.sh[1582]: Time is not synchronized. Attempting to sync... Jul 05 11:31:54 volprox volumio[997]: info: Remote SSH Stopped Jul 05 11:31:54 volprox sudo[1590]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Sat, 05 Jul 2025 02:31:54 GMT#015' Jul 05 11:31:54 volprox sudo[1590]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 05 11:31:54 volprox setdatetime-helper.sh[1591]: Sat Jul 5 11:31:54 KST 2025 Jul 05 11:31:54 volprox systemd-journald[504]: Time jumped backwards, rotating. Jul 05 11:31:54 volprox sudo[1590]: pam_unix(sudo:session): session closed for user root Jul 05 11:31:54 volprox setdatetime-helper.sh[1582]: Time synchronized successfully. Jul 05 11:31:54 volprox systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jul 05 11:31:54 volprox systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jul 05 11:31:54 volprox volumio[997]: error: Failed to ping endpoint as1.myvolumio.org : unknown error Jul 05 11:31:54 volprox volumio[997]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 11:31:54 volprox volumio[997]: Error: Unable to resolve or reject the same promise twice Jul 05 11:31:54 volprox volumio[997]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jul 05 11:31:54 volprox volumio[997]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32371) Jul 05 11:31:54 volprox volumio[997]: at Socket.emit (node:events:514:28) Jul 05 11:31:54 volprox volumio[997]: at addChunk (node:internal/streams/readable:343:12) Jul 05 11:31:54 volprox volumio[997]: at readableAddChunk (node:internal/streams/readable:316:9) Jul 05 11:31:54 volprox volumio[997]: at Readable.push (node:internal/streams/readable:253:10) Jul 05 11:31:54 volprox volumio[997]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Jul 05 11:31:54 volprox volumio[997]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 11:31:54 volprox sudo[1607]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-07-05 11:30' Jul 05 11:31:54 volprox sudo[1607]: 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="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 31 04:47:19 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="f0f6a90610a0a39b2758a5b3958219e6"