-- Logs begin at Tue 2025-06-17 09:08:59 CST, end at Tue 2025-06-17 17:08:58 CST. -- Jun 17 17:08:45 volumio kernel: Linux version 6.6.32-volumio (gkkpch@UbuntuVM24.04) (gcc (Ubuntu 13.2.0-23ubuntu4) 13.2.0, GNU ld (GNU Binutils for Ubuntu) 2.42) #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 Jun 17 17:08:45 volumio kernel: Command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=eaa81698-748d-4665-b2a2-9d572f68d885 bootpart=UUID=1409-87FE datapart=UUID=fc60d0ac-b65e-4cc0-a959-f9f77b233d55 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 Jun 17 17:08:45 volumio kernel: KERNEL supported cpus: Jun 17 17:08:45 volumio kernel: Intel GenuineIntel Jun 17 17:08:45 volumio kernel: AMD AuthenticAMD Jun 17 17:08:45 volumio kernel: Hygon HygonGenuine Jun 17 17:08:45 volumio kernel: Centaur CentaurHauls Jun 17 17:08:45 volumio kernel: zhaoxin Shanghai Jun 17 17:08:45 volumio kernel: BIOS-provided physical RAM map: Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bec88fff] usable Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x00000000bec89000-0x00000000bed8afff] reserved Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x00000000bed8b000-0x00000000bf6ebfff] usable Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x00000000bf6ec000-0x00000000bf7ebfff] reserved Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x00000000bf7ec000-0x00000000bf8ebfff] type 20 Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x00000000bf8ec000-0x00000000bf96bfff] reserved Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x00000000bf96c000-0x00000000bf97dfff] ACPI data Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x00000000bf97e000-0x00000000bf9fdfff] ACPI NVS Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x00000000bf9fe000-0x00000000bff7bfff] usable Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x00000000bff7c000-0x00000000bfffffff] reserved Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved Jun 17 17:08:45 volumio kernel: BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable Jun 17 17:08:45 volumio kernel: NX (Execute Disable) protection: active Jun 17 17:08:45 volumio kernel: APIC: Static calls initialized Jun 17 17:08:45 volumio kernel: efi: EFI v2.7 by EDK II Jun 17 17:08:45 volumio kernel: efi: TPMFinalLog=0xbf9e6000 SMBIOS=0xbf720000 ACPI=0xbf97d000 ACPI 2.0=0xbf97d014 MEMATTR=0xbe632018 Jun 17 17:08:45 volumio kernel: efi: Remove mem138: MMIO range=[0xffc00000-0xffffffff] (4MB) from e820 map Jun 17 17:08:45 volumio kernel: e820: remove [mem 0xffc00000-0xffffffff] reserved Jun 17 17:08:45 volumio kernel: SMBIOS 2.8 present. Jun 17 17:08:45 volumio kernel: DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 0.0.0 02/06/2015 Jun 17 17:08:45 volumio kernel: Hypervisor detected: KVM Jun 17 17:08:45 volumio kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jun 17 17:08:45 volumio kernel: kvm-clock: using sched offset of 13769347322 cycles Jun 17 17:08:45 volumio kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jun 17 17:08:45 volumio kernel: tsc: Detected 1497.600 MHz processor Jun 17 17:08:45 volumio kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jun 17 17:08:45 volumio kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jun 17 17:08:45 volumio kernel: last_pfn = 0x140000 max_arch_pfn = 0x400000000 Jun 17 17:08:45 volumio kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Jun 17 17:08:45 volumio kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jun 17 17:08:45 volumio kernel: last_pfn = 0xbff7c max_arch_pfn = 0x400000000 Jun 17 17:08:45 volumio kernel: Using GB pages for direct mapping Jun 17 17:08:45 volumio kernel: Secure boot could not be determined Jun 17 17:08:45 volumio kernel: RAMDISK: [mem 0x2fae7000-0x33d6afff] Jun 17 17:08:45 volumio kernel: ACPI: Early table checksum verification disabled Jun 17 17:08:45 volumio kernel: ACPI: RSDP 0x00000000BF97D014 000024 (v02 BOCHS ) Jun 17 17:08:45 volumio kernel: ACPI: XSDT 0x00000000BF97C0E8 00004C (v01 BOCHS BXPC 00000001 01000013) Jun 17 17:08:45 volumio kernel: ACPI: FACP 0x00000000BF979000 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 17 17:08:45 volumio kernel: ACPI: DSDT 0x00000000BF97A000 001B80 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 17 17:08:45 volumio kernel: ACPI: FACS 0x00000000BF9B4000 000040 Jun 17 17:08:45 volumio kernel: ACPI: APIC 0x00000000BF978000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 17 17:08:45 volumio kernel: ACPI: TPM2 0x00000000BF977000 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Jun 17 17:08:45 volumio kernel: ACPI: WAET 0x00000000BF976000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 17 17:08:45 volumio kernel: ACPI: BGRT 0x00000000BF975000 000038 (v01 INTEL EDK2 00000002 01000013) Jun 17 17:08:45 volumio kernel: ACPI: Reserving FACP table memory at [mem 0xbf979000-0xbf979073] Jun 17 17:08:45 volumio kernel: ACPI: Reserving DSDT table memory at [mem 0xbf97a000-0xbf97bb7f] Jun 17 17:08:45 volumio kernel: ACPI: Reserving FACS table memory at [mem 0xbf9b4000-0xbf9b403f] Jun 17 17:08:45 volumio kernel: ACPI: Reserving APIC table memory at [mem 0xbf978000-0xbf97808f] Jun 17 17:08:45 volumio kernel: ACPI: Reserving TPM2 table memory at [mem 0xbf977000-0xbf97704b] Jun 17 17:08:45 volumio kernel: ACPI: Reserving WAET table memory at [mem 0xbf976000-0xbf976027] Jun 17 17:08:45 volumio kernel: ACPI: Reserving BGRT table memory at [mem 0xbf975000-0xbf975037] Jun 17 17:08:45 volumio kernel: Zone ranges: Jun 17 17:08:45 volumio kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jun 17 17:08:45 volumio kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Jun 17 17:08:45 volumio kernel: Normal [mem 0x0000000100000000-0x000000013fffffff] Jun 17 17:08:45 volumio kernel: Movable zone start for each node Jun 17 17:08:45 volumio kernel: Early memory node ranges Jun 17 17:08:45 volumio kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Jun 17 17:08:45 volumio kernel: node 0: [mem 0x0000000000100000-0x00000000bec88fff] Jun 17 17:08:45 volumio kernel: node 0: [mem 0x00000000bed8b000-0x00000000bf6ebfff] Jun 17 17:08:45 volumio kernel: node 0: [mem 0x00000000bf9fe000-0x00000000bff7bfff] Jun 17 17:08:45 volumio kernel: node 0: [mem 0x0000000100000000-0x000000013fffffff] Jun 17 17:08:45 volumio kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] Jun 17 17:08:45 volumio kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jun 17 17:08:45 volumio kernel: On node 0, zone DMA: 96 pages in unavailable ranges Jun 17 17:08:45 volumio kernel: On node 0, zone DMA32: 258 pages in unavailable ranges Jun 17 17:08:45 volumio kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Jun 17 17:08:45 volumio kernel: On node 0, zone Normal: 132 pages in unavailable ranges Jun 17 17:08:45 volumio kernel: ACPI: PM-Timer IO Port: 0xb008 Jun 17 17:08:45 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jun 17 17:08:45 volumio kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jun 17 17:08:45 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jun 17 17:08:45 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jun 17 17:08:45 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jun 17 17:08:45 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jun 17 17:08:45 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jun 17 17:08:45 volumio kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jun 17 17:08:45 volumio kernel: e820: update [mem 0xbdf89000-0xbdf91fff] usable ==> reserved Jun 17 17:08:45 volumio kernel: TSC deadline timer available Jun 17 17:08:45 volumio kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Jun 17 17:08:45 volumio kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jun 17 17:08:45 volumio kernel: kvm-guest: KVM setup pv remote TLB flush Jun 17 17:08:45 volumio kernel: kvm-guest: setup PV sched yield Jun 17 17:08:45 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] Jun 17 17:08:45 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000fffff] Jun 17 17:08:45 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xbdf89000-0xbdf91fff] Jun 17 17:08:45 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xbec89000-0xbed8afff] Jun 17 17:08:45 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xbf6ec000-0xbf7ebfff] Jun 17 17:08:45 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xbf7ec000-0xbf8ebfff] Jun 17 17:08:45 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xbf8ec000-0xbf96bfff] Jun 17 17:08:45 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xbf96c000-0xbf97dfff] Jun 17 17:08:45 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xbf97e000-0xbf9fdfff] Jun 17 17:08:45 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xbff7c000-0xbfffffff] Jun 17 17:08:45 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xc0000000-0xffffffff] Jun 17 17:08:45 volumio kernel: [mem 0xc0000000-0xffffffff] available for PCI devices Jun 17 17:08:45 volumio kernel: Booting paravirtualized kernel on KVM Jun 17 17:08:45 volumio kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Jun 17 17:08:45 volumio kernel: setup_percpu: NR_CPUS:8 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jun 17 17:08:45 volumio kernel: percpu: Embedded 56 pages/cpu s191400 r8192 d29784 u524288 Jun 17 17:08:45 volumio kernel: pcpu-alloc: s191400 r8192 d29784 u524288 alloc=1*2097152 Jun 17 17:08:45 volumio kernel: pcpu-alloc: [0] 0 1 2 3 Jun 17 17:08:45 volumio kernel: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=eaa81698-748d-4665-b2a2-9d572f68d885 bootpart=UUID=1409-87FE datapart=UUID=fc60d0ac-b65e-4cc0-a959-f9f77b233d55 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 Jun 17 17:08:45 volumio kernel: Unknown kernel command line parameters "splash BOOT_IMAGE=/vmlinuz biosdevname=0 imgpart=UUID=eaa81698-748d-4665-b2a2-9d572f68d885 bootpart=UUID=1409-87FE datapart=UUID=fc60d0ac-b65e-4cc0-a959-f9f77b233d55 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh use_kmsg=no", will be passed to user space. Jun 17 17:08:45 volumio kernel: random: crng init done Jun 17 17:08:45 volumio kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jun 17 17:08:45 volumio kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jun 17 17:08:45 volumio kernel: Built 1 zonelists, mobility grouping on. Total pages: 1028761 Jun 17 17:08:45 volumio kernel: mem auto-init: stack:all(zero), heap alloc:off, heap free:off Jun 17 17:08:45 volumio kernel: software IO TLB: area num 4. Jun 17 17:08:45 volumio kernel: Memory: 3913700K/4189212K available (14336K kernel code, 1878K rwdata, 4640K rodata, 2988K init, 1148K bss, 275256K reserved, 0K cma-reserved) Jun 17 17:08:45 volumio kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jun 17 17:08:45 volumio kernel: ftrace: allocating 40433 entries in 158 pages Jun 17 17:08:45 volumio kernel: ftrace: allocated 158 pages with 5 groups Jun 17 17:08:45 volumio kernel: Dynamic Preempt: voluntary Jun 17 17:08:45 volumio kernel: rcu: Preemptible hierarchical RCU implementation. Jun 17 17:08:45 volumio kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Jun 17 17:08:45 volumio kernel: Trampoline variant of Tasks RCU enabled. Jun 17 17:08:45 volumio kernel: Rude variant of Tasks RCU enabled. Jun 17 17:08:45 volumio kernel: Tracing variant of Tasks RCU enabled. Jun 17 17:08:45 volumio kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Jun 17 17:08:45 volumio kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jun 17 17:08:45 volumio kernel: NR_IRQS: 4352, nr_irqs: 456, preallocated irqs: 16 Jun 17 17:08:45 volumio kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jun 17 17:08:45 volumio kernel: Console: colour dummy device 80x25 Jun 17 17:08:45 volumio kernel: printk: console [tty0] enabled Jun 17 17:08:45 volumio kernel: ACPI: Core revision 20230628 Jun 17 17:08:45 volumio kernel: APIC: Switch to symmetric I/O mode setup Jun 17 17:08:45 volumio kernel: x2apic enabled Jun 17 17:08:45 volumio kernel: APIC: Switched APIC routing to: physical x2apic Jun 17 17:08:45 volumio kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Jun 17 17:08:45 volumio kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Jun 17 17:08:45 volumio kernel: kvm-guest: setup PV IPIs Jun 17 17:08:45 volumio kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x159647815e3, max_idle_ns: 440795269835 ns Jun 17 17:08:45 volumio kernel: Calibrating delay loop (skipped) preset value.. 2995.20 BogoMIPS (lpj=5990400) Jun 17 17:08:45 volumio kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jun 17 17:08:45 volumio kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Jun 17 17:08:45 volumio kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Jun 17 17:08:45 volumio kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jun 17 17:08:45 volumio kernel: Spectre V2 : Mitigation: Retpolines Jun 17 17:08:45 volumio kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Jun 17 17:08:45 volumio kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Jun 17 17:08:45 volumio kernel: Spectre V2 : Enabling Restricted Speculation for firmware calls Jun 17 17:08:45 volumio kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Jun 17 17:08:45 volumio kernel: Register File Data Sampling: Vulnerable: No microcode Jun 17 17:08:45 volumio kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jun 17 17:08:45 volumio kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jun 17 17:08:45 volumio kernel: x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers' Jun 17 17:08:45 volumio kernel: x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR' Jun 17 17:08:45 volumio kernel: x86/fpu: xstate_offset[3]: 576, xstate_sizes[3]: 64 Jun 17 17:08:45 volumio kernel: x86/fpu: xstate_offset[4]: 640, xstate_sizes[4]: 64 Jun 17 17:08:45 volumio kernel: x86/fpu: Enabled xstate features 0x1b, context size is 704 bytes, using 'compacted' format. Jun 17 17:08:45 volumio kernel: Freeing SMP alternatives memory: 32K Jun 17 17:08:45 volumio kernel: pid_max: default: 32768 minimum: 301 Jun 17 17:08:45 volumio kernel: LSM: initializing lsm=capability,yama,integrity Jun 17 17:08:45 volumio kernel: Yama: becoming mindful. Jun 17 17:08:45 volumio kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 17 17:08:45 volumio kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 17 17:08:45 volumio kernel: smpboot: CPU0: Intel(R) Pentium(R) CPU J4205 @ 1.50GHz (family: 0x6, model: 0x5c, stepping: 0x9) Jun 17 17:08:45 volumio kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Jun 17 17:08:45 volumio kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Jun 17 17:08:45 volumio kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Jun 17 17:08:45 volumio kernel: Performance Events: Goldmont events, full-width counters, Intel PMU driver. Jun 17 17:08:45 volumio kernel: ... version: 2 Jun 17 17:08:45 volumio kernel: ... bit width: 48 Jun 17 17:08:45 volumio kernel: ... generic registers: 4 Jun 17 17:08:45 volumio kernel: ... value mask: 0000ffffffffffff Jun 17 17:08:45 volumio kernel: ... max period: 00007fffffffffff Jun 17 17:08:45 volumio kernel: ... fixed-purpose events: 3 Jun 17 17:08:45 volumio kernel: ... event mask: 000000070000000f Jun 17 17:08:45 volumio kernel: signal: max sigframe size: 2032 Jun 17 17:08:45 volumio kernel: rcu: Hierarchical SRCU implementation. Jun 17 17:08:45 volumio kernel: rcu: Max phase no-delay instances is 1000. Jun 17 17:08:45 volumio kernel: smp: Bringing up secondary CPUs ... Jun 17 17:08:45 volumio kernel: smpboot: x86: Booting SMP configuration: Jun 17 17:08:45 volumio kernel: .... node #0, CPUs: #1 #2 #3 Jun 17 17:08:45 volumio kernel: smp: Brought up 1 node, 4 CPUs Jun 17 17:08:45 volumio kernel: smpboot: Max logical packages: 1 Jun 17 17:08:45 volumio kernel: smpboot: Total of 4 processors activated (11980.80 BogoMIPS) Jun 17 17:08:45 volumio kernel: devtmpfs: initialized Jun 17 17:08:45 volumio kernel: x86/mm: Memory block size: 128MB Jun 17 17:08:45 volumio kernel: ACPI: PM: Registering ACPI NVS region [mem 0xbf97e000-0xbf9fdfff] (524288 bytes) Jun 17 17:08:45 volumio kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Jun 17 17:08:45 volumio kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jun 17 17:08:45 volumio kernel: pinctrl core: initialized pinctrl subsystem Jun 17 17:08:45 volumio kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jun 17 17:08:45 volumio kernel: audit: initializing netlink subsys (disabled) Jun 17 17:08:45 volumio kernel: audit: type=2000 audit(1750122517.922:1): state=initialized audit_enabled=0 res=1 Jun 17 17:08:45 volumio kernel: thermal_sys: Registered thermal governor 'fair_share' Jun 17 17:08:45 volumio kernel: thermal_sys: Registered thermal governor 'bang_bang' Jun 17 17:08:45 volumio kernel: thermal_sys: Registered thermal governor 'step_wise' Jun 17 17:08:45 volumio kernel: thermal_sys: Registered thermal governor 'user_space' Jun 17 17:08:45 volumio kernel: EISA bus registered Jun 17 17:08:45 volumio kernel: cpuidle: using governor ladder Jun 17 17:08:45 volumio kernel: cpuidle: using governor menu Jun 17 17:08:45 volumio kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jun 17 17:08:45 volumio kernel: PCI: Using configuration type 1 for base access Jun 17 17:08:45 volumio kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jun 17 17:08:45 volumio kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jun 17 17:08:45 volumio kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jun 17 17:08:45 volumio kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jun 17 17:08:45 volumio kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jun 17 17:08:45 volumio kernel: ACPI: Added _OSI(Module Device) Jun 17 17:08:45 volumio kernel: ACPI: Added _OSI(Processor Device) Jun 17 17:08:45 volumio kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jun 17 17:08:45 volumio kernel: ACPI: Added _OSI(Processor Aggregator Device) Jun 17 17:08:45 volumio kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jun 17 17:08:45 volumio kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Jun 17 17:08:45 volumio kernel: ACPI: Interpreter enabled Jun 17 17:08:45 volumio kernel: ACPI: PM: (supports S0 S5) Jun 17 17:08:45 volumio kernel: ACPI: Using IOAPIC for interrupt routing Jun 17 17:08:45 volumio kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jun 17 17:08:45 volumio kernel: PCI: Using E820 reservations for host bridge windows Jun 17 17:08:45 volumio kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Jun 17 17:08:45 volumio kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jun 17 17:08:45 volumio kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Jun 17 17:08:45 volumio kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Jun 17 17:08:45 volumio kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Jun 17 17:08:45 volumio kernel: acpiphp: Slot [2] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [4] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [5] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [6] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [7] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [8] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [9] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [10] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [11] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [12] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [13] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [14] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [15] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [16] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [17] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [18] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [19] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [20] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [21] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [22] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [23] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [24] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [25] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [26] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [27] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [28] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [29] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [30] registered Jun 17 17:08:45 volumio kernel: acpiphp: Slot [31] registered Jun 17 17:08:45 volumio kernel: PCI host bridge to bus 0000:00 Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x7000000000-0x707fffffff window] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: root bus resource [mem 0xfed40000-0xfed44fff] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jun 17 17:08:45 volumio kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Jun 17 17:08:45 volumio kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Jun 17 17:08:45 volumio kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 Jun 17 17:08:45 volumio kernel: pci 0000:00:01.1: reg 0x20: [io 0xc100-0xc10f] Jun 17 17:08:45 volumio kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Jun 17 17:08:45 volumio kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Jun 17 17:08:45 volumio kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Jun 17 17:08:45 volumio kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Jun 17 17:08:45 volumio kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 Jun 17 17:08:45 volumio kernel: pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI Jun 17 17:08:45 volumio kernel: pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB Jun 17 17:08:45 volumio kernel: pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 Jun 17 17:08:45 volumio kernel: pci 0000:00:02.0: reg 0x10: [io 0xc0e0-0xc0ff] Jun 17 17:08:45 volumio kernel: pci 0000:00:02.0: reg 0x14: [mem 0xc1048000-0xc1048fff] Jun 17 17:08:45 volumio kernel: pci 0000:00:02.0: reg 0x20: [mem 0x7000000000-0x7000003fff 64bit pref] Jun 17 17:08:45 volumio kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfffc0000-0xffffffff pref] Jun 17 17:08:45 volumio kernel: pci 0000:00:03.0: [1234:1111] type 00 class 0x030000 Jun 17 17:08:45 volumio kernel: pci 0000:00:03.0: reg 0x10: [mem 0xc0000000-0xc0ffffff pref] Jun 17 17:08:45 volumio kernel: pci 0000:00:03.0: reg 0x18: [mem 0xc1047000-0xc1047fff] Jun 17 17:08:45 volumio kernel: pci 0000:00:03.0: reg 0x30: [mem 0xffff0000-0xffffffff pref] Jun 17 17:08:45 volumio kernel: pci 0000:00:03.0: BAR 0: assigned to efifb Jun 17 17:08:45 volumio kernel: pci 0000:00:03.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jun 17 17:08:45 volumio kernel: pci 0000:00:04.0: [1af4:1002] type 00 class 0x00ff00 Jun 17 17:08:45 volumio kernel: pci 0000:00:04.0: reg 0x10: [io 0xc080-0xc0bf] Jun 17 17:08:45 volumio kernel: pci 0000:00:04.0: reg 0x20: [mem 0x7000004000-0x7000007fff 64bit pref] Jun 17 17:08:45 volumio kernel: pci 0000:00:05.0: [1af4:1004] type 00 class 0x010000 Jun 17 17:08:45 volumio kernel: pci 0000:00:05.0: reg 0x10: [io 0xc040-0xc07f] Jun 17 17:08:45 volumio kernel: pci 0000:00:05.0: reg 0x14: [mem 0xc1046000-0xc1046fff] Jun 17 17:08:45 volumio kernel: pci 0000:00:05.0: reg 0x20: [mem 0x7000008000-0x700000bfff 64bit pref] Jun 17 17:08:45 volumio kernel: pci 0000:00:06.0: [8086:2668] type 00 class 0x040300 Jun 17 17:08:45 volumio kernel: pci 0000:00:06.0: reg 0x10: [mem 0xc1040000-0xc1043fff] Jun 17 17:08:45 volumio kernel: pci 0000:00:07.0: [1af4:1003] type 00 class 0x078000 Jun 17 17:08:45 volumio kernel: pci 0000:00:07.0: reg 0x10: [io 0xc000-0xc03f] Jun 17 17:08:45 volumio kernel: pci 0000:00:07.0: reg 0x14: [mem 0xc1045000-0xc1045fff] Jun 17 17:08:45 volumio kernel: pci 0000:00:07.0: reg 0x20: [mem 0x700000c000-0x700000ffff 64bit pref] Jun 17 17:08:45 volumio kernel: pci 0000:00:1e.0: [1b36:000d] type 00 class 0x0c0330 Jun 17 17:08:45 volumio kernel: pci 0000:00:1e.0: reg 0x10: [mem 0x7000010000-0x7000013fff 64bit] Jun 17 17:08:45 volumio kernel: pci 0000:00:1f.0: [8086:2922] type 00 class 0x010601 Jun 17 17:08:45 volumio kernel: pci 0000:00:1f.0: reg 0x20: [io 0xc0c0-0xc0df] Jun 17 17:08:45 volumio kernel: pci 0000:00:1f.0: reg 0x24: [mem 0xc1044000-0xc1044fff] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: on NUMA node 0 Jun 17 17:08:45 volumio kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jun 17 17:08:45 volumio kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jun 17 17:08:45 volumio kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jun 17 17:08:45 volumio kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jun 17 17:08:45 volumio kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Jun 17 17:08:45 volumio kernel: iommu: Default domain type: Translated Jun 17 17:08:45 volumio kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jun 17 17:08:45 volumio kernel: SCSI subsystem initialized Jun 17 17:08:45 volumio kernel: libata version 3.00 loaded. Jun 17 17:08:45 volumio kernel: ACPI: bus type USB registered Jun 17 17:08:45 volumio kernel: usbcore: registered new interface driver usbfs Jun 17 17:08:45 volumio kernel: usbcore: registered new interface driver hub Jun 17 17:08:45 volumio kernel: usbcore: registered new device driver usb Jun 17 17:08:45 volumio kernel: efivars: Registered efivars operations Jun 17 17:08:45 volumio kernel: PCI: Using ACPI for IRQ routing Jun 17 17:08:45 volumio kernel: PCI: pci_cache_line_size set to 64 bytes Jun 17 17:08:45 volumio kernel: e820: reserve RAM buffer [mem 0xbdf89000-0xbfffffff] Jun 17 17:08:45 volumio kernel: e820: reserve RAM buffer [mem 0xbec89000-0xbfffffff] Jun 17 17:08:45 volumio kernel: e820: reserve RAM buffer [mem 0xbf6ec000-0xbfffffff] Jun 17 17:08:45 volumio kernel: e820: reserve RAM buffer [mem 0xbff7c000-0xbfffffff] Jun 17 17:08:45 volumio kernel: pci 0000:00:03.0: vgaarb: setting as boot VGA device Jun 17 17:08:45 volumio kernel: pci 0000:00:03.0: vgaarb: bridge control possible Jun 17 17:08:45 volumio kernel: pci 0000:00:03.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jun 17 17:08:45 volumio kernel: vgaarb: loaded Jun 17 17:08:45 volumio kernel: clocksource: Switched to clocksource kvm-clock Jun 17 17:08:45 volumio kernel: VFS: Disk quotas dquot_6.6.0 Jun 17 17:08:45 volumio kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jun 17 17:08:45 volumio kernel: pnp: PnP ACPI init Jun 17 17:08:45 volumio kernel: pnp 00:02: [dma 2] Jun 17 17:08:45 volumio kernel: pnp: PnP ACPI: found 4 devices Jun 17 17:08:45 volumio kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jun 17 17:08:45 volumio kernel: NET: Registered PF_INET protocol family Jun 17 17:08:45 volumio kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jun 17 17:08:45 volumio kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jun 17 17:08:45 volumio kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jun 17 17:08:45 volumio kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jun 17 17:08:45 volumio kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jun 17 17:08:45 volumio kernel: TCP: Hash tables configured (established 32768 bind 32768) Jun 17 17:08:45 volumio kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 17 17:08:45 volumio kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 17 17:08:45 volumio kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jun 17 17:08:45 volumio kernel: pci 0000:00:02.0: can't claim BAR 6 [mem 0xfffc0000-0xffffffff pref]: no compatible bridge window Jun 17 17:08:45 volumio kernel: pci 0000:00:02.0: BAR 6: assigned [mem 0xc1000000-0xc103ffff pref] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: resource 8 [mem 0x7000000000-0x707fffffff window] Jun 17 17:08:45 volumio kernel: pci_bus 0000:00: resource 9 [mem 0xfed40000-0xfed44fff] Jun 17 17:08:45 volumio kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Jun 17 17:08:45 volumio kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Jun 17 17:08:45 volumio kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 10 Jun 17 17:08:45 volumio kernel: pci 0000:00:1e.0: quirk_usb_early_handoff+0x0/0x770 took 53547 usecs Jun 17 17:08:45 volumio kernel: PCI: CLS 0 bytes, default 64 Jun 17 17:08:45 volumio kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Jun 17 17:08:45 volumio kernel: software IO TLB: mapped [mem 0x00000000b7dfe000-0x00000000bbdfe000] (64MB) Jun 17 17:08:45 volumio kernel: Trying to unpack rootfs image as initramfs... Jun 17 17:08:45 volumio kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Jun 17 17:08:45 volumio kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x159647815e3, max_idle_ns: 440795269835 ns Jun 17 17:08:45 volumio kernel: Initialise system trusted keyrings Jun 17 17:08:45 volumio kernel: workingset: timestamp_bits=46 max_order=20 bucket_order=0 Jun 17 17:08:45 volumio kernel: zbud: loaded Jun 17 17:08:45 volumio kernel: Key type asymmetric registered Jun 17 17:08:45 volumio kernel: Asymmetric key parser 'x509' registered Jun 17 17:08:45 volumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) Jun 17 17:08:45 volumio kernel: io scheduler mq-deadline registered Jun 17 17:08:45 volumio kernel: io scheduler kyber registered Jun 17 17:08:45 volumio kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Jun 17 17:08:45 volumio kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 Jun 17 17:08:45 volumio kernel: ACPI: button: Power Button [PWRF] Jun 17 17:08:45 volumio kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Jun 17 17:08:45 volumio kernel: Linux agpgart interface v0.103 Jun 17 17:08:45 volumio kernel: ata_piix 0000:00:01.1: version 2.13 Jun 17 17:08:45 volumio kernel: scsi host0: ata_piix Jun 17 17:08:45 volumio kernel: scsi host1: ata_piix Jun 17 17:08:45 volumio kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc100 irq 14 Jun 17 17:08:45 volumio kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc108 irq 15 Jun 17 17:08:45 volumio kernel: xhci_hcd 0000:00:1e.0: xHCI Host Controller Jun 17 17:08:45 volumio kernel: xhci_hcd 0000:00:1e.0: new USB bus registered, assigned bus number 1 Jun 17 17:08:45 volumio kernel: xhci_hcd 0000:00:1e.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010 Jun 17 17:08:45 volumio kernel: xhci_hcd 0000:00:1e.0: xHCI Host Controller Jun 17 17:08:45 volumio kernel: xhci_hcd 0000:00:1e.0: new USB bus registered, assigned bus number 2 Jun 17 17:08:45 volumio kernel: xhci_hcd 0000:00:1e.0: Host supports USB 3.0 SuperSpeed Jun 17 17:08:45 volumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Jun 17 17:08:45 volumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jun 17 17:08:45 volumio kernel: usb usb1: Product: xHCI Host Controller Jun 17 17:08:45 volumio kernel: usb usb1: Manufacturer: Linux 6.6.32-volumio xhci-hcd Jun 17 17:08:45 volumio kernel: usb usb1: SerialNumber: 0000:00:1e.0 Jun 17 17:08:45 volumio kernel: hub 1-0:1.0: USB hub found Jun 17 17:08:45 volumio kernel: hub 1-0:1.0: 4 ports detected Jun 17 17:08:45 volumio kernel: usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. Jun 17 17:08:45 volumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Jun 17 17:08:45 volumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jun 17 17:08:45 volumio kernel: usb usb2: Product: xHCI Host Controller Jun 17 17:08:45 volumio kernel: usb usb2: Manufacturer: Linux 6.6.32-volumio xhci-hcd Jun 17 17:08:45 volumio kernel: usb usb2: SerialNumber: 0000:00:1e.0 Jun 17 17:08:45 volumio kernel: hub 2-0:1.0: USB hub found Jun 17 17:08:45 volumio kernel: hub 2-0:1.0: 4 ports detected Jun 17 17:08:45 volumio kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jun 17 17:08:45 volumio kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jun 17 17:08:45 volumio kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jun 17 17:08:45 volumio kernel: mousedev: PS/2 mouse device common for all mice Jun 17 17:08:45 volumio kernel: rtc_cmos 00:03: RTC can wake from S4 Jun 17 17:08:45 volumio kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 Jun 17 17:08:45 volumio kernel: rtc_cmos 00:03: registered as rtc0 Jun 17 17:08:45 volumio kernel: rtc_cmos 00:03: setting system clock to 2025-06-17T09:08:37 UTC (1750151317) Jun 17 17:08:45 volumio kernel: rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram Jun 17 17:08:45 volumio kernel: i2c_dev: i2c /dev entries driver Jun 17 17:08:45 volumio kernel: platform eisa.0: Probing EISA bus 0 Jun 17 17:08:45 volumio kernel: platform eisa.0: EISA: Cannot allocate resource for mainboard Jun 17 17:08:45 volumio kernel: intel_pstate: CPU model not supported Jun 17 17:08:45 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs Jun 17 17:08:45 volumio kernel: efifb: probing for efifb Jun 17 17:08:45 volumio kernel: efifb: framebuffer at 0xc0000000, using 1408k, total 1408k Jun 17 17:08:45 volumio kernel: efifb: mode is 800x600x24, linelength=2400, pages=1 Jun 17 17:08:45 volumio kernel: efifb: scrolling: redraw Jun 17 17:08:45 volumio kernel: efifb: Truecolor: size=0:8:8:8, shift=0:16:8:0 Jun 17 17:08:45 volumio kernel: Console: switching to colour frame buffer device 100x37 Jun 17 17:08:45 volumio kernel: fb0: EFI VGA frame buffer device Jun 17 17:08:45 volumio kernel: NET: Registered PF_INET6 protocol family Jun 17 17:08:45 volumio kernel: Segment Routing with IPv6 Jun 17 17:08:45 volumio kernel: In-situ OAM (IOAM) with IPv6 Jun 17 17:08:45 volumio kernel: mip6: Mobile IPv6 Jun 17 17:08:45 volumio kernel: NET: Registered PF_PACKET protocol family Jun 17 17:08:45 volumio kernel: mpls_gso: MPLS GSO support Jun 17 17:08:45 volumio kernel: IPI shorthand broadcast: enabled Jun 17 17:08:45 volumio kernel: sched_clock: Marking stable (396109892, 2909443)->(438192535, -39173200) Jun 17 17:08:45 volumio kernel: Loading compiled-in X.509 certificates Jun 17 17:08:45 volumio kernel: clk: Disabling unused clocks Jun 17 17:08:45 volumio kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Jun 17 17:08:45 volumio kernel: usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 Jun 17 17:08:45 volumio kernel: usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 Jun 17 17:08:45 volumio kernel: usb 1-1: Product: QEMU USB Tablet Jun 17 17:08:45 volumio kernel: usb 1-1: Manufacturer: QEMU Jun 17 17:08:45 volumio kernel: usb 1-1: SerialNumber: 28754-0000:00:1e.0-1 Jun 17 17:08:45 volumio kernel: Freeing initrd memory: 68112K Jun 17 17:08:45 volumio kernel: Freeing unused kernel image (initmem) memory: 2988K Jun 17 17:08:45 volumio kernel: Write protecting the kernel read-only data: 20480k Jun 17 17:08:45 volumio kernel: Freeing unused kernel image (rodata/data gap) memory: 1504K Jun 17 17:08:45 volumio kernel: Run /init as init process Jun 17 17:08:45 volumio kernel: with arguments: Jun 17 17:08:45 volumio kernel: /init Jun 17 17:08:45 volumio kernel: splash Jun 17 17:08:45 volumio kernel: with environment: Jun 17 17:08:45 volumio kernel: HOME=/ Jun 17 17:08:45 volumio kernel: TERM=linux Jun 17 17:08:45 volumio kernel: BOOT_IMAGE=/vmlinuz Jun 17 17:08:45 volumio kernel: biosdevname=0 Jun 17 17:08:45 volumio kernel: imgpart=UUID=eaa81698-748d-4665-b2a2-9d572f68d885 Jun 17 17:08:45 volumio kernel: bootpart=UUID=1409-87FE Jun 17 17:08:45 volumio kernel: datapart=UUID=fc60d0ac-b65e-4cc0-a959-f9f77b233d55 Jun 17 17:08:45 volumio kernel: hwdevice=x86 Jun 17 17:08:45 volumio kernel: uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg Jun 17 17:08:45 volumio kernel: imgfile=/volumio_current.sqsh Jun 17 17:08:45 volumio kernel: use_kmsg=no Jun 17 17:08:45 volumio kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0xb100, revision 0 Jun 17 17:08:45 volumio kernel: FDC 0 is a S82078B Jun 17 17:08:45 volumio kernel: ACPI: bus type drm_connector registered Jun 17 17:08:45 volumio kernel: hid: raw HID events driver (C) Jiri Kosina Jun 17 17:08:45 volumio kernel: ahci 0000:00:1f.0: version 3.0 Jun 17 17:08:45 volumio kernel: input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 Jun 17 17:08:45 volumio kernel: input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 Jun 17 17:08:45 volumio kernel: usbcore: registered new interface driver usbhid Jun 17 17:08:45 volumio kernel: usbhid: USB HID core driver Jun 17 17:08:45 volumio kernel: input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1e.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input5 Jun 17 17:08:45 volumio kernel: hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1e.0-1/input0 Jun 17 17:08:45 volumio kernel: Console: switching to colour dummy device 80x25 Jun 17 17:08:45 volumio kernel: bochs-drm 0000:00:03.0: vgaarb: deactivate vga console Jun 17 17:08:45 volumio kernel: [drm] Found bochs VGA, ID 0xb0c5. Jun 17 17:08:45 volumio kernel: [drm] Framebuffer size 16384 kB @ 0xc0000000, mmio @ 0xc1047000. Jun 17 17:08:45 volumio kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Jun 17 17:08:45 volumio kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11 Jun 17 17:08:45 volumio kernel: ahci 0000:00:1f.0: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Jun 17 17:08:45 volumio kernel: ahci 0000:00:1f.0: flags: 64bit ncq only Jun 17 17:08:45 volumio kernel: [drm] Found EDID data blob. Jun 17 17:08:45 volumio kernel: scsi host2: ahci Jun 17 17:08:45 volumio kernel: [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:03.0 on minor 0 Jun 17 17:08:45 volumio kernel: scsi host3: ahci Jun 17 17:08:45 volumio kernel: scsi host4: ahci Jun 17 17:08:45 volumio kernel: fbcon: bochs-drmdrmfb (fb0) is primary device Jun 17 17:08:45 volumio kernel: scsi host5: ahci Jun 17 17:08:45 volumio kernel: scsi host6: ahci Jun 17 17:08:45 volumio kernel: scsi host7: ahci Jun 17 17:08:45 volumio kernel: ata3: SATA max UDMA/133 abar m4096@0xc1044000 port 0xc1044100 irq 29 Jun 17 17:08:45 volumio kernel: ata4: SATA max UDMA/133 abar m4096@0xc1044000 port 0xc1044180 irq 29 Jun 17 17:08:45 volumio kernel: ata5: SATA max UDMA/133 abar m4096@0xc1044000 port 0xc1044200 irq 29 Jun 17 17:08:45 volumio kernel: ata6: SATA max UDMA/133 abar m4096@0xc1044000 port 0xc1044280 irq 29 Jun 17 17:08:45 volumio kernel: Console: switching to colour frame buffer device 160x50 Jun 17 17:08:45 volumio kernel: ata7: SATA max UDMA/133 abar m4096@0xc1044000 port 0xc1044300 irq 29 Jun 17 17:08:45 volumio kernel: ata8: SATA max UDMA/133 abar m4096@0xc1044000 port 0xc1044380 irq 29 Jun 17 17:08:45 volumio kernel: bochs-drm 0000:00:03.0: [drm] fb0: bochs-drmdrmfb frame buffer device Jun 17 17:08:45 volumio kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Jun 17 17:08:45 volumio kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jun 17 17:08:45 volumio kernel: ata6: SATA link down (SStatus 0 SControl 300) Jun 17 17:08:45 volumio kernel: ata5: SATA link down (SStatus 0 SControl 300) Jun 17 17:08:45 volumio kernel: ata8: SATA link down (SStatus 0 SControl 300) Jun 17 17:08:45 volumio kernel: ata4: SATA link down (SStatus 0 SControl 300) Jun 17 17:08:45 volumio kernel: ata7: SATA link down (SStatus 0 SControl 300) Jun 17 17:08:45 volumio kernel: ata3.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100 Jun 17 17:08:45 volumio kernel: ata3.00: 41943040 sectors, multi 16: LBA48 NCQ (depth 32) Jun 17 17:08:45 volumio kernel: ata3.00: applying bridge limits Jun 17 17:08:45 volumio kernel: ata3.00: configured for UDMA/100 Jun 17 17:08:45 volumio kernel: scsi 2:0:0:0: Direct-Access ATA QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 Jun 17 17:08:45 volumio kernel: sd 2:0:0:0: [sda] 41943040 512-byte logical blocks: (21.5 GB/20.0 GiB) Jun 17 17:08:45 volumio kernel: sd 2:0:0:0: [sda] Write Protect is off Jun 17 17:08:45 volumio kernel: sd 2:0:0:0: [sda] Mode Sense: 00 3a 00 00 Jun 17 17:08:45 volumio kernel: sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jun 17 17:08:45 volumio kernel: sd 2:0:0:0: [sda] Preferred minimum I/O size 512 bytes Jun 17 17:08:45 volumio kernel: sda: sda1 sda2 sda3 Jun 17 17:08:45 volumio kernel: sd 2:0:0:0: [sda] Attached SCSI disk Jun 17 17:08:45 volumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jun 17 17:08:45 volumio kernel: sdhci: Secure Digital Host Controller Interface driver Jun 17 17:08:45 volumio kernel: sdhci: Copyright(c) Pierre Ossman Jun 17 17:08:45 volumio kernel: fuse: init (API version 7.39) Jun 17 17:08:45 volumio kernel: usbcore: registered new interface driver usb-storage Jun 17 17:08:45 volumio kernel: usbcore: registered new interface driver uas Jun 17 17:08:45 volumio kernel: [drm] radeon kernel modesetting enabled. Jun 17 17:08:45 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jun 17 17:08:45 volumio kernel: EXT4-fs (sda2): recovery complete Jun 17 17:08:45 volumio kernel: EXT4-fs (sda2): mounted filesystem eaa81698-748d-4665-b2a2-9d572f68d885 r/w with ordered data mode. Quota mode: none. Jun 17 17:08:45 volumio kernel: loop: module loaded Jun 17 17:08:45 volumio kernel: block device autoloading is deprecated and will be removed. Jun 17 17:08:45 volumio kernel: loop0: detected capacity change from 0 to 1726872 Jun 17 17:08:45 volumio kernel: EXT4-fs (sda3): recovery complete Jun 17 17:08:45 volumio kernel: EXT4-fs (sda3): mounted filesystem fc60d0ac-b65e-4cc0-a959-f9f77b233d55 r/w with ordered data mode. Quota mode: none. Jun 17 17:08:45 volumio kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038-01-19 (0x7fffffff) Jun 17 17:08:45 volumio systemd[1]: Inserted module 'autofs4' Jun 17 17:08:45 volumio systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Jun 17 17:08:45 volumio systemd[1]: Detected virtualization kvm. Jun 17 17:08:45 volumio systemd[1]: Detected architecture x86-64. Jun 17 17:08:45 volumio systemd[1]: Set hostname to . Jun 17 17:08:45 volumio systemd[1]: File /lib/systemd/system/systemd-journald.service:12 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling. Jun 17 17:08:45 volumio systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Jun 17 17:08:45 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jun 17 17:08:45 volumio systemd[1]: Listening on Journal Socket. Jun 17 17:08:45 volumio systemd[1]: Starting Remount Root and Kernel File Systems... Jun 17 17:08:45 volumio systemd[1]: Started Forward Password Requests to Wall Directory Watch. Jun 17 17:08:45 volumio systemd-journald[472]: Journal started Jun 17 17:08:45 volumio systemd-journald[472]: Runtime journal (/run/log/journal/03b6e5ba37bc1493d92bff746809f11e) is 3.7M, max 30.0M, 26.2M free. Jun 17 17:08:45 volumio fake-hwclock[471]: Current system time: 2025-06-17 09:08:45 Jun 17 17:08:45 volumio fake-hwclock[471]: fake-hwclock saved clock information is in the past: 2025-06-17 01:06:20 Jun 17 17:08:45 volumio fake-hwclock[471]: To set system time to this saved clock anyway, use "force" Jun 17 17:08:45 volumio systemd[1]: Started Restore / save the current clock. Jun 17 17:08:45 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 17 17:08:45 volumio systemd[1]: Started Apply Kernel Variables. Jun 17 17:08:45 volumio systemd[1]: Started udev Coldplug all Devices. Jun 17 17:08:45 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown... Jun 17 17:08:45 volumio systemd[1]: Started Load/Save Random Seed. Jun 17 17:08:45 volumio kernel: RPC: Registered named UNIX socket transport module. Jun 17 17:08:45 volumio kernel: RPC: Registered udp transport module. Jun 17 17:08:45 volumio kernel: RPC: Registered tcp transport module. Jun 17 17:08:45 volumio kernel: RPC: Registered tcp-with-tls transport module. Jun 17 17:08:45 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jun 17 17:08:45 volumio systemd[1]: Mounted RPC Pipe File System. Jun 17 17:08:45 volumio systemd[1]: Started Create System Users. Jun 17 17:08:45 volumio systemd[1]: Starting Create Static Device Nodes in /dev... Jun 17 17:08:45 volumio systemd[1]: Started Create Static Device Nodes in /dev. Jun 17 17:08:45 volumio systemd[1]: Starting udev Kernel Device Manager... Jun 17 17:08:45 volumio systemd[1]: Reached target Local File Systems (Pre). Jun 17 17:08:45 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jun 17 17:08:45 volumio systemd[1]: Mounting /tmp... Jun 17 17:08:45 volumio systemd[1]: Mounting /var/spool/cups... Jun 17 17:08:45 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jun 17 17:08:45 volumio systemd[1]: Mounting /var/log... Jun 17 17:08:45 volumio systemd[1]: Mounted /tmp. Jun 17 17:08:45 volumio systemd[1]: Mounted /var/spool/cups. Jun 17 17:08:45 volumio systemd[1]: Mounted /var/log. Jun 17 17:08:45 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Jun 17 17:08:45 volumio systemd[1]: Mounting /var/spool/cups/tmp... Jun 17 17:08:45 volumio systemd[1]: Mounted /var/spool/cups/tmp. Jun 17 17:08:45 volumio systemd-udevd[496]: Network interface NamePolicy= disabled on kernel command line, ignoring. Jun 17 17:08:45 volumio systemd-journald[472]: Runtime journal (/run/log/journal/03b6e5ba37bc1493d92bff746809f11e) is 3.7M, max 30.0M, 26.2M free. Jun 17 17:08:45 volumio systemd[1]: Started Flush Journal to Persistent Storage. Jun 17 17:08:45 volumio systemd[1]: Started udev Kernel Device Manager. Jun 17 17:08:45 volumio systemd[1]: Starting Show Plymouth Boot Screen... Jun 17 17:08:45 volumio systemd[1]: plymouth-start.service: Succeeded. Jun 17 17:08:45 volumio systemd[1]: Started Show Plymouth Boot Screen. Jun 17 17:08:45 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jun 17 17:08:45 volumio systemd[1]: Reached target Local Encrypted Volumes. Jun 17 17:08:45 volumio systemd[1]: Reached target Paths. Jun 17 17:08:45 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jun 17 17:08:45 volumio kernel: pstore: Using crash dump compression: deflate Jun 17 17:08:45 volumio kernel: pstore: Registered efi_pstore as persistent store backend Jun 17 17:08:45 volumio systemd-udevd[525]: Using default interface naming scheme 'v240'. Jun 17 17:08:46 volumio kernel: sd 2:0:0:0: Attached scsi generic sg0 type 0 Jun 17 17:08:46 volumio systemd-udevd[525]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jun 17 17:08:46 volumio systemd-udevd[507]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jun 17 17:08:46 volumio kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Jun 17 17:08:46 volumio kernel: cryptd: max_cpu_qlen set to 1000 Jun 17 17:08:46 volumio systemd-udevd[515]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 17 17:08:46 volumio kernel: SSE version of gcm_enc/dec engaged. Jun 17 17:08:46 volumio systemd-udevd[521]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 17 17:08:46 volumio systemd-udevd[505]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 17 17:08:46 volumio kernel: snd_hda_codec_generic hdaudioC0D0: autoconfig for Generic: line_outs=1 (0x3/0x0/0x0/0x0/0x0) type:line Jun 17 17:08:46 volumio kernel: snd_hda_codec_generic hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Jun 17 17:08:46 volumio kernel: snd_hda_codec_generic hdaudioC0D0: hp_outs=0 (0x0/0x0/0x0/0x0/0x0) Jun 17 17:08:46 volumio kernel: snd_hda_codec_generic hdaudioC0D0: mono: mono_out=0x0 Jun 17 17:08:46 volumio kernel: snd_hda_codec_generic hdaudioC0D0: inputs: Jun 17 17:08:46 volumio kernel: snd_hda_codec_generic hdaudioC0D0: Line=0x5 Jun 17 17:08:46 volumio systemd-udevd[511]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 17 17:08:46 volumio systemd-udevd[517]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 17 17:08:46 volumio systemd-udevd[526]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 17 17:08:46 volumio systemd-udevd[508]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 17 17:08:46 volumio systemd-udevd[514]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 17 17:08:46 volumio kernel: alsactl[603]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Jun 17 17:08:46 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown. Jun 17 17:08:46 volumio systemd[1]: Found device QEMU_HARDDISK boot. Jun 17 17:08:46 volumio systemd[1]: Condition check resulted in Virtio network device being skipped. Jun 17 17:08:46 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jun 17 17:08:46 volumio systemd[1]: Starting Show Plymouth Boot Screen... Jun 17 17:08:46 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jun 17 17:08:46 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/1409-87FE... Jun 17 17:08:46 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Jun 17 17:08:46 volumio systemd[1]: Started File System Check Daemon to report status. Jun 17 17:08:46 volumio systemd[1]: plymouth-start.service: Succeeded. Jun 17 17:08:46 volumio systemd[1]: Started Show Plymouth Boot Screen. Jun 17 17:08:46 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jun 17 17:08:46 volumio systemd-fsck[608]: fsck.fat 4.1 (2017-01-24) Jun 17 17:08:46 volumio systemd-fsck[608]: There are differences between boot sector and its backup. Jun 17 17:08:46 volumio systemd-fsck[608]: This is mostly harmless. Differences: (offset:original/backup) Jun 17 17:08:46 volumio systemd-fsck[608]: 3:53/6d, 4:59/6b, 5:53/66, 6:4c/73, 7:49/2e, 8:4e/66, 9:55/61, 10:58/74 Jun 17 17:08:46 volumio systemd-fsck[608]: , 90:fa/0e, 91:fc/1f, 92:31/be, 93:c9/77, 94:8e/7c, 95:d1/ac, 96:bc/22 Jun 17 17:08:46 volumio systemd-fsck[608]: , 97:76/c0, 98:7b/74, 99:52/0b, 100:06/56, 101:57/b4, 102:1e/0e, 103:56/bb Jun 17 17:08:46 volumio systemd-fsck[608]: , 104:8e/07, 105:c1/00, 106:b1/cd, 107:26/10, 108:bf/5e, 109:78/eb Jun 17 17:08:46 volumio systemd-fsck[608]: , 110:7b/f0, 111:f3/32, 112:a5/e4, 113:8e/cd, 114:d9/16, 115:bb/cd Jun 17 17:08:46 volumio systemd-fsck[608]: , 116:78/19, 117:00/eb, 118:0f/fe, 119:b4/54, 120:37/68, 121:0f/69 Jun 17 17:08:46 volumio systemd-fsck[608]: , 122:a0/73, 123:56/20, 124:20/69, 125:d2/73, 126:78/20, 127:1b/6e Jun 17 17:08:46 volumio systemd-fsck[608]: , 128:31/6f, 129:c0/74, 130:b1/20, 131:06/61, 132:89/20, 133:3f/62 Jun 17 17:08:46 volumio systemd-fsck[608]: , 134:89/6f, 135:47/6f, 136:02/74, 137:f3/61, 138:64/62, 139:a5/6c Jun 17 17:08:46 volumio systemd-fsck[608]: , 140:8a/65, 141:0e/20, 142:18/64, 143:7c/69, 144:88/73, 145:4d/6b Jun 17 17:08:46 volumio systemd-fsck[608]: , 146:f8/2e, 147:50/20, 148:50/20, 150:50/6c, 151:cd/65, 152:13/61 Jun 17 17:08:46 volumio systemd-fsck[608]: , 153:eb/73, 154:62/65, 155:8b/20, 156:55/69, 157:aa/6e, 158:8b/73 Jun 17 17:08:46 volumio systemd-fsck[608]: , 159:75/65, 160:a8/72, 161:c1/74, 162:ee/20, 163:04/61, 164:01/20 Jun 17 17:08:46 volumio systemd-fsck[608]: , 165:f2/62, 166:83/6f, 167:fa/6f, 168:4f/74, 169:76/61, 170:31/62 Jun 17 17:08:46 volumio systemd-fsck[608]: , 171:81/6c, 172:fa/65, 173:b2/20, 174:07/66, 175:73/6c, 176:2b/6f Jun 17 17:08:46 volumio systemd-fsck[608]: , 177:f6/70, 178:45/70, 179:b4/79, 180:7f/20, 181:75/61, 182:25/6e Jun 17 17:08:46 volumio systemd-fsck[608]: , 183:38/64, 184:4d/0d, 185:b8/0a, 186:74/70, 187:20/72, 188:66/65 Jun 17 17:08:46 volumio systemd-fsck[608]: , 189:3d/73, 190:21/73, 191:47/20, 192:50/61, 193:54/6e, 194:75/79 Jun 17 17:08:46 volumio systemd-fsck[608]: , 195:10/20, 196:80/6b, 197:7d/65, 198:b8/79, 199:ed/20, 200:75/74 Jun 17 17:08:46 volumio systemd-fsck[608]: , 201:0a/6f, 202:66/20, 203:ff/74, 204:75/72, 205:ec/79, 206:66/20 Jun 17 17:08:46 volumio systemd-fsck[608]: , 207:ff/61, 208:75/67, 209:e8/61, 210:eb/69, 211:0f/6e, 212:51/20 Jun 17 17:08:46 volumio systemd-fsck[608]: , 213:51/2e, 214:66/2e, 215:ff/2e, 216:75/20, 217:bc/0d, 218:eb/0a Jun 17 17:08:46 volumio systemd-fsck[608]: , 219:07/00, 220:51/00, 221:51/00, 222:66/00, 223:ff/00, 224:36/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 225:1c/00, 226:7c/00, 227:b4/00, 228:08/00, 229:e8/00, 230:e9/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 232:72/00, 233:13/00, 234:20/00, 235:e4/00, 236:75/00, 237:0f/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 238:c1/00, 239:ea/00, 240:08/00, 241:42/00, 242:89/00, 243:16/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 244:1a/00, 245:7c/00, 246:83/00, 247:e1/00, 248:3f/00, 249:89/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 250:0e/00, 251:18/00, 252:7c/00, 253:fb/00, 254:bb/00, 255:aa/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 256:55/00, 257:b4/00, 258:41/00, 259:e8/00, 260:cb/00, 262:72/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 263:10/00, 264:81/00, 265:fb/00, 266:55/00, 267:aa/00, 268:75/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 269:0a/00, 270:f6/00, 271:c1/00, 272:01/00, 273:74/00, 274:05/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 275:c6/00, 276:06/00, 277:46/00, 278:7d/00, 280:66/00, 281:b8/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 282:c6/00, 283:9b/00, 286:66/00, 287:ba/00, 292:bb/00, 294:80/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 295:e8/00, 296:0e/00, 298:66/00, 299:81/00, 300:3e/00, 301:1c/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 302:80/00, 303:d5/00, 304:cf/00, 305:c7/00, 306:62/00, 307:75/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 308:74/00, 309:e9/00, 310:f8/00, 311:02/00, 312:66/00, 313:03/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 314:06/00, 315:60/00, 316:7b/00, 317:66/00, 318:13/00, 319:16/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 320:64/00, 321:7b/00, 322:b9/00, 323:10/00, 325:eb/00, 326:2b/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 327:66/00, 328:52/00, 329:66/00, 330:50/00, 331:06/00, 332:53/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 333:6a/00, 334:01/00, 335:6a/00, 336:10/00, 337:89/00, 338:e6/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 339:66/00, 340:60/00, 341:b4/00, 342:42/00, 343:e8/00, 344:77/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 346:66/00, 347:61/00, 348:8d/00, 349:64/00, 350:10/00, 351:72/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 352:01/00, 353:c3/00, 354:66/00, 355:60/00, 356:31/00, 357:c0/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 358:e8/00, 359:68/00, 361:66/00, 362:61/00, 363:e2/00, 364:da/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 365:c6/00, 366:06/00, 367:46/00, 368:7d/00, 369:2b/00, 370:66/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 371:60/00, 372:66/00, 373:0f/00, 374:b7/00, 375:36/00, 376:18/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 377:7c/00, 378:66/00, 379:0f/00, 380:b7/00, 381:3e/00, 382:1a/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 383:7c/00, 384:66/00, 385:f7/00, 386:f6/00, 387:31/00, 388:c9/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 389:87/00, 390:ca/00, 391:66/00, 392:f7/00, 393:f7/00, 394:66/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 395:3d/00, 396:ff/00, 397:03/00, 400:77/00, 401:17/00, 402:c0/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 403:e4/00, 404:06/00, 405:41/00, 406:08/00, 407:e1/00, 408:88/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 409:c5/00, 410:88/00, 411:d6/00, 412:b8/00, 413:01/00, 414:02/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 415:e8/00, 416:2f/00, 418:66/00, 419:61/00, 420:72/00, 421:01/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 422:c3/00, 423:e2/00, 424:c9/00, 425:31/00, 426:f6/00, 427:8e/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 428:d6/00, 429:bc/00, 430:68/00, 431:7b/00, 432:8e/00, 433:de/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 434:66/00, 435:8f/00, 436:06/00, 437:78/00, 439:be/00, 440:da/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 441:7d/00, 442:ac/00, 443:20/00, 444:c0/00, 445:74/00, 446:09/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 447:b4/00, 448:0e/00, 449:bb/00, 450:07/00, 452:cd/00, 453:10/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 454:eb/00, 455:f2/00, 456:31/00, 457:c0/00, 458:cd/00, 459:16/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 460:cd/00, 461:19/00, 462:f4/00, 463:eb/00, 464:fd/00, 465:8a/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 466:16/00, 467:74/00, 468:7b/00, 469:06/00, 470:cd/00, 471:13/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 472:07/00, 473:c3/00, 474:42/00, 475:6f/00, 476:6f/00, 477:74/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 478:20/00, 479:65/00, 480:72/00, 481:72/00, 482:6f/00, 483:72/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 484:0d/00, 485:0a/00, 504:fe/00, 505:02/00, 506:b2/00, 507:3e/00 Jun 17 17:08:46 volumio systemd-fsck[608]: , 508:18/00, 509:37/00 Jun 17 17:08:46 volumio systemd-fsck[608]: Not automatically fixing this. Jun 17 17:08:46 volumio systemd-fsck[608]: /dev/sda1: 18 files, 159616/344788 clusters Jun 17 17:08:46 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/1409-87FE. Jun 17 17:08:46 volumio systemd[1]: Mounting /boot... Jun 17 17:08:46 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jun 17 17:08:46 volumio systemd[1]: Mounted /boot. Jun 17 17:08:46 volumio systemd[1]: Reached target Local File Systems. Jun 17 17:08:46 volumio systemd[1]: Starting Preprocess NFS configuration... Jun 17 17:08:46 volumio systemd[1]: Started ifup for eth0. Jun 17 17:08:46 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jun 17 17:08:46 volumio systemd[1]: Starting Create Volatile Files and Directories... Jun 17 17:08:46 volumio systemd[1]: Starting Raise network interfaces... Jun 17 17:08:46 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Jun 17 17:08:46 volumio systemd[1]: nfs-config.service: Succeeded. Jun 17 17:08:46 volumio systemd[1]: Started Preprocess NFS configuration. Jun 17 17:08:46 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jun 17 17:08:46 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jun 17 17:08:46 volumio systemd[1]: Reached target NFS client services. Jun 17 17:08:46 volumio systemd[1]: Received SIGRTMIN+20 from PID 355 (plymouthd). Jun 17 17:08:46 volumio systemd[1]: plymouth-read-write.service: Succeeded. Jun 17 17:08:46 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jun 17 17:08:46 volumio systemd[1]: Started Create Volatile Files and Directories. Jun 17 17:08:47 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jun 17 17:08:47 volumio systemd[1]: Starting RPC bind portmap service... Jun 17 17:08:47 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Jun 17 17:08:47 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Jun 17 17:08:47 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Jun 17 17:08:47 volumio systemd[1]: Reached target System Initialization. Jun 17 17:08:47 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Jun 17 17:08:47 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jun 17 17:08:47 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Jun 17 17:08:47 volumio systemd[1]: Started Daily apt download activities. Jun 17 17:08:47 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jun 17 17:08:47 volumio systemd[1]: Listening on triggerhappy.socket. Jun 17 17:08:47 volumio systemd[1]: Reached target Sockets. Jun 17 17:08:47 volumio systemd[1]: Started Daily man-db regeneration. Jun 17 17:08:47 volumio systemd[1]: Reached target Timers. Jun 17 17:08:47 volumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Jun 17 17:08:47 volumio systemd[1]: Reached target Basic System. Jun 17 17:08:47 volumio systemd[1]: Starting triggerhappy global hotkey daemon... Jun 17 17:08:47 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jun 17 17:08:47 volumio systemd[1]: Starting Login Service... Jun 17 17:08:47 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Jun 17 17:08:47 volumio thd[642]: Unable to parse trigger line: Jun 17 17:08:47 volumio thd[642]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Jun 17 17:08:47 volumio thd[642]: Unable to parse trigger line: Jun 17 17:08:47 volumio thd[642]: Unable to parse trigger line: Jun 17 17:08:47 volumio thd[642]: Found socket passed from systemd Jun 17 17:08:47 volumio systemd[1]: Starting DHCP Client Daemon... Jun 17 17:08:47 volumio systemd[1]: Started D-Bus System Message Bus. Jun 17 17:08:47 volumio systemd[1]: Started Volumio Log Rotation Service. Jun 17 17:08:47 volumio kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Jun 17 17:08:47 volumio kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Jun 17 17:08:47 volumio systemd[1]: Started volumio-remote-updater.service. Jun 17 17:08:47 volumio systemd[1]: Started Manage Sound Card State (restore and store). Jun 17 17:08:47 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 17 17:08:47 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Jun 17 17:08:47 volumio systemd[1]: Starting Save/Restore Sound Card State... Jun 17 17:08:47 volumio alsactl[655]: alsactl 1.1.8 daemon started Jun 17 17:08:47 volumio systemd[1]: Starting Wireless Services... Jun 17 17:08:47 volumio systemd[1]: Starting WPA supplicant... Jun 17 17:08:47 volumio systemd[1]: Started Volumio Iptables Module. Jun 17 17:08:47 volumio systemd[1]: Started MPD Monitor Service. Jun 17 17:08:47 volumio systemd[1]: Starting Volumio Time Update Utility... Jun 17 17:08:47 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Jun 17 17:08:47 volumio systemd[1]: Started RPC bind portmap service. Jun 17 17:08:47 volumio systemd[1]: Started triggerhappy global hotkey daemon. Jun 17 17:08:47 volumio systemd[1]: Reached target RPC Port Mapper. Jun 17 17:08:47 volumio systemd[1]: Reached target Remote File Systems (Pre). Jun 17 17:08:47 volumio systemd[1]: Reached target Remote File Systems. Jun 17 17:08:47 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Jun 17 17:08:47 volumio sh[616]: command failed: No such device (-19) Jun 17 17:08:47 volumio ifup[622]: command failed: No such device (-19) Jun 17 17:08:47 volumio volumio-time-update[664]: volumio-time-update-util: Fetching time from Volumio... Jun 17 17:08:47 volumio mpd_monitor.sh[663]: MPD Monitor Service: Starting MPD Monitor Service Jun 17 17:08:47 volumio avahi-daemon[644]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Jun 17 17:08:47 volumio systemd-logind[645]: New seat seat0. Jun 17 17:08:47 volumio avahi-daemon[644]: Successfully dropped root privileges. Jun 17 17:08:47 volumio avahi-daemon[644]: avahi-daemon 0.7 starting up. Jun 17 17:08:47 volumio systemd-logind[645]: Watching system buttons on /dev/input/event0 (Power Button) Jun 17 17:08:47 volumio systemd-logind[645]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Jun 17 17:08:47 volumio mpd_monitor.sh[663]: MPD error: Cannot assign requested address Jun 17 17:08:47 volumio mpd_monitor.sh[663]: MPD Monitor Service: MPD Appears to be inactive, restarting Jun 17 17:08:47 volumio sh[616]: sending commands to master dhcpcd process Jun 17 17:08:47 volumio dhcpcd[706]: sending commands to master dhcpcd process Jun 17 17:08:47 volumio kernel: 8021q: 802.1Q VLAN Support v1.8 Jun 17 17:08:47 volumio mpd_monitor.sh[663]: mpd: no process found Jun 17 17:08:47 volumio ifup[622]: command failed: No such device (-19) Jun 17 17:08:47 volumio haveged[639]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K Jun 17 17:08:47 volumio haveged[639]: haveged: cpu: (L4 VC); data: 32K (L2 L4 V); inst: 32K (L2 L4 V); idx: 24/40; sz: 31410/52825 Jun 17 17:08:47 volumio haveged[639]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00072 Jun 17 17:08:47 volumio haveged[639]: haveged: fills: 0, generated: 0 Jun 17 17:08:47 volumio dhcpcd[648]: no interfaces have a carrier Jun 17 17:08:47 volumio dhcpcd[648]: no interfaces have a carrier Jun 17 17:08:47 volumio dhcpcd[759]: eth0: waiting for carrier Jun 17 17:08:47 volumio dhcpcd[648]: forked to background, child pid 759 Jun 17 17:08:47 volumio dhcpcd[648]: forked to background, child pid 759 Jun 17 17:08:47 volumio dhcpcd[759]: eth0: carrier acquired Jun 17 17:08:47 volumio kernel: 8021q: adding VLAN 0 to HW filter on device eth0 Jun 17 17:08:47 volumio dhcpcd[759]: DUID 00:04:8d:63:28:1e:ff:c1:43:f3:94:0b:70:ce:a3:6a:07:c2 Jun 17 17:08:47 volumio dhcpcd[759]: eth0: IAID 6e:1d:34:da Jun 17 17:08:47 volumio dhcpcd[759]: eth0: adding address fe80::6cd2:6eff:fe1d:34da Jun 17 17:08:47 volumio dhcpcd[759]: ipv6_addaddr1: Permission denied Jun 17 17:08:47 volumio dhcpcd[759]: control command: /sbin/dhcpcd eth0 Jun 17 17:08:47 volumio systemd[1]: Started Login Service. Jun 17 17:08:47 volumio systemd[1]: Started DHCP Client Daemon. Jun 17 17:08:47 volumio systemd[1]: Started Save/Restore Sound Card State. Jun 17 17:08:47 volumio avahi-daemon[644]: Successfully called chroot(). Jun 17 17:08:47 volumio avahi-daemon[644]: Successfully dropped remaining capabilities. Jun 17 17:08:47 volumio wpa_supplicant[661]: Successfully initialized wpa_supplicant Jun 17 17:08:47 volumio avahi-daemon[644]: No service file found in /etc/avahi/services. Jun 17 17:08:47 volumio avahi-daemon[644]: Network interface enumeration completed. Jun 17 17:08:47 volumio avahi-daemon[644]: Server startup complete. Host name is volumio.local. Local service cookie is 2767585434. Jun 17 17:08:47 volumio systemd[1]: Started WPA supplicant. Jun 17 17:08:47 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jun 17 17:08:47 volumio systemd[1]: Listening on mpd.socket. Jun 17 17:08:47 volumio systemd[1]: Reached target Sound Card. Jun 17 17:08:47 volumio sh[616]: eth0=eth0 Jun 17 17:08:47 volumio volumio-remote-updater[654]: Error: No active session Jun 17 17:08:47 volumio volumio-remote-updater[654]: [2025-06-17 17:08:47] [info] asio async_connect error: system:111 (Connection refused) Jun 17 17:08:47 volumio volumio-remote-updater[654]: [2025-06-17 17:08:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 17 17:08:47 volumio volumio-remote-updater[654]: [2025-06-17 17:08:47] [error] handle_connect error: Underlying Transport Error Jun 17 17:08:47 volumio ifup[622]: command failed: No such device (-19) Jun 17 17:08:47 volumio systemd[1]: iptables.service: Succeeded. Jun 17 17:08:47 volumio volumio[656]: Could not open config: /tmp/upmpdcli.conf Jun 17 17:08:47 volumio volumio-time-update[664]: volumio-time-update-util: Date not found in response Jun 17 17:08:47 volumio volumio-time-update[664]: volumio-time-update-util: Retrying in 5 seconds... Jun 17 17:08:47 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jun 17 17:08:47 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jun 17 17:08:48 volumio loadcpufreq[666]: Loading cpufreq kernel modules...failed. Jun 17 17:08:48 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Jun 17 17:08:48 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Jun 17 17:08:48 volumio systemd[1]: Started Raise network interfaces. Jun 17 17:08:48 volumio systemd[1]: Reached target Network. Jun 17 17:08:48 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Jun 17 17:08:48 volumio systemd[1]: Starting Permit User Sessions... Jun 17 17:08:48 volumio systemd[1]: Starting Music Player Daemon... Jun 17 17:08:48 volumio systemd[1]: Starting Network Time Service... Jun 17 17:08:48 volumio systemd[1]: Reached target Network is Online. Jun 17 17:08:48 volumio systemd[1]: Starting Samba NMB Daemon... Jun 17 17:08:48 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Jun 17 17:08:48 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 17 17:08:48 volumio systemd[1]: Starting /etc/rc.local Compatibility... Jun 17 17:08:48 volumio systemd[1]: Started Permit User Sessions. Jun 17 17:08:48 volumio cpufrequtils[862]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Jun 17 17:08:48 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Jun 17 17:08:48 volumio systemd[1]: Started /etc/rc.local Compatibility. Jun 17 17:08:48 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Jun 17 17:08:48 volumio systemd[1]: Starting Hold until boot process finishes up... Jun 17 17:08:48 volumio systemd[1]: Received SIGRTMIN+21 from PID 355 (plymouthd). Jun 17 17:08:48 volumio systemd[1]: plymouth-quit.service: Succeeded. Jun 17 17:08:48 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Jun 17 17:08:48 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Jun 17 17:08:48 volumio systemd[1]: Started Hold until boot process finishes up. Jun 17 17:08:48 volumio systemd[1]: Received SIGRTMIN+21 from PID 355 (n/a). Jun 17 17:08:48 volumio systemd[1]: Started Getty on tty1. Jun 17 17:08:48 volumio systemd[1]: Reached target Login Prompts. Jun 17 17:08:48 volumio ifplugd(eth0)[909]: ifplugd 0.28 initializing. Jun 17 17:08:48 volumio ifplugd(eth0)[909]: Using interface eth0/6E:D2:6E:1D:34:DA with driver (version: 1.0.0) Jun 17 17:08:48 volumio ifplugd(eth0)[909]: Using detection mode: SIOCETHTOOL Jun 17 17:08:48 volumio ifplugd(eth0)[909]: Initialization complete, link beat detected. Jun 17 17:08:48 volumio ntpd[875]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 17 17:08:48 volumio ntpd[875]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jun 17 17:08:48 volumio systemd[1]: Started Network Time Service. Jun 17 17:08:48 volumio ntpd[910]: proto: precision = 0.091 usec (-23) Jun 17 17:08:48 volumio ntpd[910]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 17 17:08:48 volumio ntpd[910]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 17 17:08:48 volumio ntpd[910]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 903 days ago Jun 17 17:08:48 volumio ntpd[910]: Listen and drop on 0 v6wildcard [::]:123 Jun 17 17:08:48 volumio ntpd[910]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 17 17:08:48 volumio ntpd[910]: Listen normally on 2 lo 127.0.0.1:123 Jun 17 17:08:48 volumio ntpd[910]: Listening on routing socket on fd #19 for interface updates Jun 17 17:08:48 volumio ntpd[910]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 17 17:08:48 volumio ntpd[910]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 17 17:08:48 volumio ifplugd(eth0)[909]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jun 17 17:08:48 volumio ifplugd(eth0)[909]: client: ifup: interface eth0 already configured Jun 17 17:08:48 volumio sudo[874]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 17 17:08:48 volumio sudo[874]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:48 volumio sudo[874]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 17 17:08:48 volumio sudo[874]: pam_unix(sudo:session): session closed for user root Jun 17 17:08:48 volumio ifplugd(eth0)[909]: Program executed successfully. Jun 17 17:08:48 volumio ifplugd[880]: Network Interface Plugging Daemon...start eth0...done. Jun 17 17:08:48 volumio systemd[1]: Started LSB: Brings up/down network automatically. Jun 17 17:08:48 volumio dhcpcd[759]: eth0: rebinding lease of 192.168.8.124 Jun 17 17:08:48 volumio dhcpcd[759]: eth0: soliciting an IPv6 router Jun 17 17:08:48 volumio dhcpcd[759]: eth0: probing address 192.168.8.124/24 Jun 17 17:08:48 volumio nmbd[887]: [2025/06/17 17:08:48.876159, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jun 17 17:08:48 volumio nmbd[887]: started asyncdns process 922 Jun 17 17:08:48 volumio nmbd[887]: [2025/06/17 17:08:48.877545, 0] ../lib/util/become_daemon.c:149(daemon_status) Jun 17 17:08:48 volumio nmbd[887]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jun 17 17:08:48 volumio nmbd[887]: [2025/06/17 17:08:48.877661, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jun 17 17:08:48 volumio nmbd[887]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jun 17 17:08:49 volumio wireless.js[660]: WIRELESS: No wireless interface, exiting Jun 17 17:08:49 volumio iw[927]: command failed: No such device (-19) Jun 17 17:08:49 volumio iwconfig[930]: Error for wireless request "Set Power Management" (8B2C) : Jun 17 17:08:49 volumio iwconfig[930]: SET failed on device wlan0 ; No such device. Jun 17 17:08:49 volumio systemd[1]: wireless.service: Succeeded. Jun 17 17:08:49 volumio systemd[1]: Started Wireless Services. Jun 17 17:08:49 volumio systemd[1]: Started Volumio Backend Module. Jun 17 17:08:49 volumio systemd[1]: Started Volumio Cpu Tweaker. Jun 17 17:08:49 volumio systemd[1]: Started Start Volumio Kiosk. Jun 17 17:08:49 volumio systemd[1]: Started Intel SST and HDA soundcard init service. Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: Setting RT Priority for mpd Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: pid 35's current scheduling policy: SCHED_FIFO Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: pid 35's current scheduling priority: 99 Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: Setting MPD Affinity Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: pid 3's current affinity mask: f Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: Error setting new values. Common errors: Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: - Do you have proper administration rights? (super-user?) Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: - Is the governor you requested available and modprobed? Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: - Trying to set an invalid policy? Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: - Trying to set a specific frequency, but userspace governor is not available, Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: for example because of hardware which cannot be set to a specific frequency Jun 17 17:08:49 volumio volumio-cpu-tweak[934]: or because the userspace governor isn't loaded? Jun 17 17:08:49 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Jun 17 17:08:49 volumio ntpd[910]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jun 17 17:08:49 volumio startx[935]: X.Org X Server 1.20.4 Jun 17 17:08:49 volumio startx[935]: X Protocol Version 11, Revision 0 Jun 17 17:08:49 volumio startx[935]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Jun 17 17:08:49 volumio startx[935]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Jun 17 17:08:49 volumio startx[935]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=eaa81698-748d-4665-b2a2-9d572f68d885 bootpart=UUID=1409-87FE datapart=UUID=fc60d0ac-b65e-4cc0-a959-f9f77b233d55 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 Jun 17 17:08:49 volumio startx[935]: Build Date: 18 December 2021 09:05:36AM Jun 17 17:08:49 volumio startx[935]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Jun 17 17:08:49 volumio startx[935]: Current version of pixman: 0.36.0 Jun 17 17:08:49 volumio startx[935]: Before reporting problems, check http://wiki.x.org Jun 17 17:08:49 volumio startx[935]: to make sure that you have the latest version. Jun 17 17:08:49 volumio startx[935]: Markers: (--) probed, (**) from config file, (==) default setting, Jun 17 17:08:49 volumio startx[935]: (++) from command line, (!!) notice, (II) informational, Jun 17 17:08:49 volumio startx[935]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jun 17 17:08:49 volumio startx[935]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Jun 17 17:08:49 2025 Jun 17 17:08:49 volumio startx[935]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jun 17 17:08:49 volumio startx[935]: pci id for fd 14: 1234:1111, driver (null) Jun 17 17:08:49 volumio systemd[1]: soundcard-init.service: Succeeded. Jun 17 17:08:50 volumio ntpd[910]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jun 17 17:08:50 volumio kernel: broken atomic modeset userspace detected, disabling atomic Jun 17 17:08:50 volumio startx[935]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Jun 17 17:08:51 volumio mpd[920]: Jun 17 17:08 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 17 17:08:51 volumio systemd[1]: Started Music Player Daemon. Jun 17 17:08:51 volumio mpd_monitor.sh[663]: MPD Monitor Service: MPD restarted due to no mpc output. Jun 17 17:08:51 volumio ntpd[910]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jun 17 17:08:51 volumio volumio[933]: info: ------------------------------------------- Jun 17 17:08:51 volumio volumio[933]: info: ----- Volumio3 ---- Jun 17 17:08:51 volumio volumio[933]: info: ------------------------------------------- Jun 17 17:08:51 volumio volumio[933]: info: ----- System startup ---- Jun 17 17:08:51 volumio volumio[933]: info: ------------------------------------------- Jun 17 17:08:52 volumio ntpd[910]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jun 17 17:08:52 volumio volumio-remote-updater[654]: [2025-06-17 17:08:52] [connect] Successful connection Jun 17 17:08:52 volumio volumio-time-update[664]: volumio-time-update-util: Fetching time from Volumio... Jun 17 17:08:52 volumio volumio-time-update[664]: volumio-time-update-util: Date not found in response Jun 17 17:08:52 volumio volumio-time-update[664]: volumio-time-update-util: Retrying in 5 seconds... Jun 17 17:08:53 volumio dhcpcd[759]: eth0: leased 192.168.8.124 for 86400 seconds Jun 17 17:08:53 volumio dhcpcd[759]: eth0: adding route to 192.168.8.0/24 Jun 17 17:08:53 volumio dhcpcd[759]: eth0: adding default route via 192.168.8.1 Jun 17 17:08:53 volumio avahi-daemon[644]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.8.124. Jun 17 17:08:53 volumio avahi-daemon[644]: New relevant interface eth0.IPv4 for mDNS. Jun 17 17:08:53 volumio avahi-daemon[644]: Registering new address record for 192.168.8.124 on eth0.IPv4. Jun 17 17:08:53 volumio volumio[933]: info: MYVOLUMIO Environment detected Jun 17 17:08:53 volumio ntpd[910]: ntpd exiting on signal 15 (Terminated) Jun 17 17:08:53 volumio systemd[1]: Stopping Network Time Service... Jun 17 17:08:53 volumio systemd[1]: ntp.service: Succeeded. Jun 17 17:08:53 volumio systemd[1]: Stopped Network Time Service. Jun 17 17:08:53 volumio systemd[1]: Starting Network Time Service... Jun 17 17:08:53 volumio volumio[933]: info: Plugin folders cleanup Jun 17 17:08:53 volumio volumio[933]: info: Scanning into folder /volumio/app/plugins/ Jun 17 17:08:53 volumio volumio[933]: info: Scanning category audio_interface Jun 17 17:08:53 volumio ntpd[1182]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 17 17:08:53 volumio ntpd[1182]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jun 17 17:08:53 volumio systemd[1]: Started Network Time Service. Jun 17 17:08:53 volumio volumio[933]: info: Scanning category miscellanea Jun 17 17:08:53 volumio ntpd[1188]: proto: precision = 0.089 usec (-23) Jun 17 17:08:53 volumio ntpd[1188]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 17 17:08:53 volumio ntpd[1188]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 17 17:08:53 volumio ntpd[1188]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 903 days ago Jun 17 17:08:53 volumio ntpd[1188]: Listen and drop on 0 v6wildcard [::]:123 Jun 17 17:08:53 volumio ntpd[1188]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 17 17:08:53 volumio ntpd[1188]: Listen normally on 2 lo 127.0.0.1:123 Jun 17 17:08:53 volumio ntpd[1188]: Listen normally on 3 eth0 192.168.8.124:123 Jun 17 17:08:53 volumio ntpd[1188]: Listening on routing socket on fd #20 for interface updates Jun 17 17:08:53 volumio ntpd[1188]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 17 17:08:53 volumio ntpd[1188]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 17 17:08:53 volumio volumio[933]: info: Scanning category music_service Jun 17 17:08:53 volumio volumio[933]: info: Scanning category plugins.json Jun 17 17:08:53 volumio volumio[933]: info: Scanning category system_controller Jun 17 17:08:53 volumio volumio[933]: info: Scanning category user_interface Jun 17 17:08:53 volumio volumio[933]: info: Scanning into folder /data/plugins/ Jun 17 17:08:53 volumio volumio[933]: info: Plugin folders cleanup completed Jun 17 17:08:53 volumio volumio[933]: info: ------------------------------------------- Jun 17 17:08:53 volumio volumio[933]: info: ----- Core plugins startup ---- Jun 17 17:08:53 volumio volumio[933]: info: ------------------------------------------- Jun 17 17:08:53 volumio volumio[933]: info: Loading plugins from folder /volumio/app/plugins/ Jun 17 17:08:53 volumio volumio[933]: info: Adding plugin upnp to MyMusic Plugins Jun 17 17:08:53 volumio volumio[933]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 17 17:08:53 volumio volumio[933]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 17 17:08:53 volumio volumio[933]: info: Loading plugins from folder /data/plugins/ Jun 17 17:08:53 volumio volumio[933]: info: Loading plugin "system"... Jun 17 17:08:53 volumio volumio[933]: info: Loading plugin "appearance"... Jun 17 17:08:53 volumio nmbd[887]: [2025/06/17 17:08:53.883130, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 17 17:08:53 volumio nmbd[887]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jun 17 17:08:53 volumio systemd[1]: Started Samba NMB Daemon. Jun 17 17:08:53 volumio nmbd[887]: [2025/06/17 17:08:53.898584, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jun 17 17:08:53 volumio nmbd[887]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.8.124 for name WORKGROUP<1d>. Jun 17 17:08:53 volumio nmbd[887]: This response was from IP 192.168.8.116, reporting an IP address of 192.168.8.116. Jun 17 17:08:53 volumio systemd[1]: Starting Samba Winbind Daemon... Jun 17 17:08:54 volumio winbindd[1193]: [2025/06/17 17:08:54.164704, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jun 17 17:08:54 volumio winbindd[1193]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jun 17 17:08:54 volumio winbindd[1193]: [2025/06/17 17:08:54.177444, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 17 17:08:54 volumio winbindd[1193]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jun 17 17:08:54 volumio systemd[1]: Started Samba Winbind Daemon. Jun 17 17:08:54 volumio systemd[1]: Starting Samba SMB Daemon... Jun 17 17:08:54 volumio ntpd[1188]: Soliciting pool server 193.182.111.141 Jun 17 17:08:54 volumio smbd[1198]: [2025/06/17 17:08:54.624772, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 17 17:08:54 volumio systemd[1]: Started Samba SMB Daemon. Jun 17 17:08:54 volumio smbd[1198]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 17 17:08:55 volumio volumio[933]: info: Loading plugin "network"... Jun 17 17:08:55 volumio volumio[933]: info: Refreshing Cached IP Addresses Jun 17 17:08:55 volumio sudo[1218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 17 17:08:55 volumio sudo[1218]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:55 volumio sudo[1220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 17 17:08:55 volumio sudo[1220]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:55 volumio sudo[1218]: pam_unix(sudo:session): session closed for user root Jun 17 17:08:55 volumio sudo[1220]: pam_unix(sudo:session): session closed for user root Jun 17 17:08:55 volumio volumio[933]: info: Loading plugin "services"... Jun 17 17:08:55 volumio volumio[933]: info: Loading plugin "alsa_controller"... Jun 17 17:08:55 volumio sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 17 17:08:55 volumio sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:55 volumio sudo[1231]: pam_unix(sudo:session): session closed for user root Jun 17 17:08:55 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 17 17:08:55 volumio volumio[933]: info: Loading plugin "wizard"... Jun 17 17:08:55 volumio volumio[933]: info: Loading plugin "networkfs"... Jun 17 17:08:55 volumio ntpd[1188]: Soliciting pool server 108.59.2.24 Jun 17 17:08:55 volumio volumio[933]: info: Starting Udev Watcher for removable devices Jun 17 17:08:55 volumio sudo[1250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=wenxing,password=Xing2265725,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //198.168.8.116/media/music /mnt/NAS/飞牛 Jun 17 17:08:55 volumio sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:55 volumio sudo[1252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=wenxing,password=Xing2265725,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //192.168.8.116/media/music /mnt/NAS/飞牛 Jun 17 17:08:55 volumio sudo[1252]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:55 volumio volumio[933]: info: Ignoring mount for partition: boot Jun 17 17:08:55 volumio volumio[933]: info: Ignoring mount for partition: volumio Jun 17 17:08:55 volumio volumio[933]: info: Ignoring mount for partition: volumio_data Jun 17 17:08:55 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 17 17:08:55 volumio volumio[933]: info: Loading plugin "volumio_command_line_client"... Jun 17 17:08:55 volumio ntpd[1188]: Soliciting pool server 84.16.73.33 Jun 17 17:08:55 volumio volumio[933]: info: Loading plugin "upnp"... Jun 17 17:08:55 volumio volumio[933]: info: [1750151335602] Starting Upmpd Daemon Jun 17 17:08:55 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 17 17:08:55 volumio volumio[933]: info: Loading plugin "my_music"... Jun 17 17:08:55 volumio volumio[933]: info: Loading plugin "mpd"... Jun 17 17:08:55 volumio kernel: FS-Cache: Loaded Jun 17 17:08:55 volumio kernel: Key type dns_resolver registered Jun 17 17:08:55 volumio kernel: Key type cifs.spnego registered Jun 17 17:08:55 volumio kernel: Key type cifs.idmap registered Jun 17 17:08:55 volumio kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Jun 17 17:08:55 volumio kernel: CIFS: VFS: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Jun 17 17:08:55 volumio kernel: CIFS: Attempting to mount //192.168.8.116/media/music Jun 17 17:08:55 volumio 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. Jun 17 17:08:55 volumio dbus-daemon[649]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.7' (uid=0 pid=1121 comm="/usr/lib/chromium/chromium --show-component-extens") Jun 17 17:08:55 volumio systemd[1]: Starting Bluetooth service... Jun 17 17:08:55 volumio kernel: CIFS: Attempting to mount //198.168.8.116/media/music Jun 17 17:08:55 volumio sudo[1252]: pam_unix(sudo:session): session closed for user root Jun 17 17:08:56 volumio volumio[933]: info: Loading plugin "upnp_browser"... Jun 17 17:08:56 volumio kernel: Bluetooth: Core ver 2.22 Jun 17 17:08:56 volumio kernel: NET: Registered PF_BLUETOOTH protocol family Jun 17 17:08:56 volumio kernel: Bluetooth: HCI device and connection manager initialized Jun 17 17:08:56 volumio kernel: Bluetooth: HCI socket layer initialized Jun 17 17:08:56 volumio kernel: Bluetooth: L2CAP socket layer initialized Jun 17 17:08:56 volumio kernel: Bluetooth: SCO socket layer initialized Jun 17 17:08:56 volumio bluetoothd[1284]: Bluetooth daemon 5.50 Jun 17 17:08:56 volumio bluetoothd[1284]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Jun 17 17:08:56 volumio dbus-daemon[649]: [system] Successfully activated service 'org.bluez' Jun 17 17:08:56 volumio systemd[1]: Started Bluetooth service. Jun 17 17:08:56 volumio bluetoothd[1284]: Starting SDP server Jun 17 17:08:56 volumio bluetoothd[1284]: Excluding (cli) sap Jun 17 17:08:56 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Jun 17 17:08:56 volumio kernel: Bluetooth: BNEP filters: protocol multicast Jun 17 17:08:56 volumio kernel: Bluetooth: BNEP socket layer initialized Jun 17 17:08:56 volumio bluetoothd[1284]: Bluetooth management interface 1.22 initialized Jun 17 17:08:56 volumio dbus-daemon[649]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.8' (uid=0 pid=1284 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Jun 17 17:08:56 volumio systemd[1]: Starting Hostname Service... Jun 17 17:08:56 volumio dbus-daemon[649]: [system] Successfully activated service 'org.freedesktop.hostname1' Jun 17 17:08:56 volumio systemd[1]: Started Hostname Service. Jun 17 17:08:56 volumio ntpd[1188]: Soliciting pool server 139.199.214.202 Jun 17 17:08:56 volumio ntpd[1188]: Soliciting pool server 193.182.111.14 Jun 17 17:08:56 volumio ntpd[1188]: Soliciting pool server 116.203.151.74 Jun 17 17:08:56 volumio volumio[933]: info: Loading plugin "alarm-clock"... Jun 17 17:08:56 volumio volumio[933]: info: Loading plugin "airplay_emulation"... Jun 17 17:08:57 volumio volumio[933]: info: Starting Shairport Sync Jun 17 17:08:57 volumio volumio[933]: info: Loading plugin "last_100"... Jun 17 17:08:57 volumio volumio[933]: info: Loading plugin "webradio"... Jun 17 17:08:57 volumio volumio[933]: info: Loading plugin "i2s_dacs"... Jun 17 17:08:57 volumio volumio[933]: info: I2S DAC not set, start Auto-detection Jun 17 17:08:57 volumio volumio[933]: info: Loading plugin "volumiodiscovery"... Jun 17 17:08:57 volumio volumio[933]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 17 17:08:57 volumio volumio[933]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 17 17:08:57 volumio volumio[933]: *** WARNING *** For more information see Jun 17 17:08:57 volumio node[933]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 17 17:08:57 volumio volumio[933]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 17 17:08:57 volumio volumio[933]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 17 17:08:57 volumio volumio[933]: *** WARNING *** For more information see Jun 17 17:08:57 volumio node[933]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 17 17:08:57 volumio node[933]: *** WARNING *** For more information see Jun 17 17:08:57 volumio node[933]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 17 17:08:57 volumio node[933]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 17 17:08:57 volumio node[933]: *** WARNING *** For more information see Jun 17 17:08:57 volumio volumio[933]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 17 17:08:57 volumio volumio[933]: info: Discovery: Started advertising with name: Volumio Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 17 17:08:57 volumio volumio[933]: info: Loading plugin "outputs"... Jun 17 17:08:57 volumio volumio[933]: info: Loading plugin "albumart"... Jun 17 17:08:57 volumio volumio[933]: info: Plugin example_plugin is not enabled Jun 17 17:08:57 volumio volumio[933]: info: Loading plugin "inputs"... Jun 17 17:08:57 volumio volumio[933]: info: Loading plugin "updater_comm"... Jun 17 17:08:57 volumio volumio[933]: Forking 3 albumart workers Jun 17 17:08:57 volumio volumio[933]: info: Plugin mpdemulation is not enabled Jun 17 17:08:57 volumio volumio[933]: info: Loading plugin "rest_api"... Jun 17 17:08:57 volumio volumio[933]: info: Loading plugin "websocket"... Jun 17 17:08:57 volumio volumio[933]: info: Starting Socket.io Server version 2.3.0 Jun 17 17:08:57 volumio ntpd[1188]: Soliciting pool server 162.159.200.1 Jun 17 17:08:57 volumio ntpd[1188]: Soliciting pool server 47.115.137.18 Jun 17 17:08:57 volumio ntpd[1188]: Soliciting pool server 193.182.111.142 Jun 17 17:08:57 volumio volumio[933]: info: Loading i18n strings for locale zh Jun 17 17:08:57 volumio volumio[933]: Updating browse sources language Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 17 17:08:57 volumio ntpd[1188]: Soliciting pool server 81.168.83.93 Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::initPlayerControls Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 17 17:08:57 volumio volumio[933]: Express server listening on port 3000 Jun 17 17:08:57 volumio volumio[933]: [Metrics] WebUI: 6s 909.96ms Jun 17 17:08:57 volumio volumio[933]: info: Setting Device type: x86 Jun 17 17:08:57 volumio volumio[933]: info: CoreStateMachine::resetVolumioState Jun 17 17:08:57 volumio volumio[933]: info: CoreStateMachine::getcurrentVolume Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::volumioRetrievevolume Jun 17 17:08:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 17:08:57 volumio volumio[933]: Starting albumart workers Jun 17 17:08:57 volumio volumio[933]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 17 17:08:57 volumio volumio[933]: info: Completed loading Core Plugins Jun 17 17:08:57 volumio volumio[933]: info: Preparing to generate the ALSA configuration file Jun 17 17:08:57 volumio volumio[933]: Starting albumart workers Jun 17 17:08:57 volumio volumio[933]: Starting albumart workers Jun 17 17:08:57 volumio volumio[933]: info: Volumio Network Manager: Network status updated: 1 Jun 17 17:08:57 volumio volumio-time-update[664]: volumio-time-update-util: Fetching time from Volumio... Jun 17 17:08:57 volumio volumio[933]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jun 17 17:08:57 volumio volumio[933]: wlan0 Interface doesn't support scanning. Jun 17 17:08:57 volumio volumio[933]: info: Cannot use regular scanning, forcing with ap-force Jun 17 17:08:58 volumio sudo[1428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jun 17 17:08:58 volumio sudo[1428]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:58 volumio sudo[1428]: pam_unix(sudo:session): session closed for user root Jun 17 17:08:58 volumio volumio[933]: command failed: No such device (-19) Jun 17 17:08:58 volumio volumio[933]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jun 17 17:08:58 volumio volumio[933]: command failed: No such device (-19) Jun 17 17:08:58 volumio volumio[933]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jun 17 17:08:58 volumio volumio[933]: info: Reloading queue from file Jun 17 17:08:58 volumio volumio[933]: info: Asound.conf file unchanged, so no further update is needed Jun 17 17:08:58 volumio volumio[933]: info: Output device has changed, restarting MPD Jun 17 17:08:58 volumio sudo[1447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 17 17:08:58 volumio volumio[933]: info: Output device has changed, restarting Shairport Sync Jun 17 17:08:58 volumio sudo[1447]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 17:08:58 volumio sudo[1447]: pam_unix(sudo:session): session closed for user root Jun 17 17:08:58 volumio sudo[1449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 17 17:08:58 volumio sudo[1449]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:58 volumio systemd[1]: Stopping Music Player Daemon... Jun 17 17:08:58 volumio volumio[933]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 17 17:08:58 volumio volumio[933]: info: ___________ START PLUGINS ___________ Jun 17 17:08:58 volumio volumio[933]: info: ControllerMpd::onStart: Initializing MPD Jun 17 17:08:58 volumio volumio[933]: info: Creating MPD Configuration file Jun 17 17:08:58 volumio sudo[1472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 17 17:08:58 volumio sudo[1472]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:58 volumio sudo[1472]: pam_unix(sudo:session): session closed for user root Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 17 17:08:58 volumio volumio[933]: info: [1750151338491] CoreMusicLibrary::Adding element 媒体服务器 Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 17 17:08:58 volumio sudo[1475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 17 17:08:58 volumio systemd[1]: mpd.service: Succeeded. Jun 17 17:08:58 volumio sudo[1475]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:58 volumio systemd[1]: Stopped Music Player Daemon. Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 17:08:58 volumio systemd[1]: Starting Music Player Daemon... Jun 17 17:08:58 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 17 17:08:58 volumio systemd[1]: mpd.service: Succeeded. Jun 17 17:08:58 volumio systemd[1]: Stopped Music Player Daemon. Jun 17 17:08:58 volumio systemd[1]: Starting Music Player Daemon... Jun 17 17:08:58 volumio volumio[933]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 17:08:58 volumio ntpd[1188]: Soliciting pool server 162.159.200.123 Jun 17 17:08:58 volumio ntpd[1188]: Soliciting pool server 202.118.1.81 Jun 17 17:08:58 volumio volumio[933]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 17 17:08:58 volumio volumio[933]: info: [1750151338583] CoreMusicLibrary::Adding element Last_100 Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 17 17:08:58 volumio volumio[933]: info: [1750151338587] CoreMusicLibrary::Adding element Webradio Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 17 17:08:58 volumio sudo[1481]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 17 17:08:58 volumio sudo[1481]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:58 volumio volumio[933]: info: Initializing BBC Radios Jun 17 17:08:58 volumio sudo[1481]: pam_unix(sudo:session): session closed for user root Jun 17 17:08:58 volumio volumio-time-update[664]: volumio-time-update-util: Setting system time to: 2025-06-17 09:08:59 Jun 17 17:08:58 volumio sudo[1489]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-06-17 09:08:59 Jun 17 17:08:58 volumio sudo[1489]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 17:08:58 volumio dbus-daemon[649]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.14' (uid=0 pid=1491 comm="timedatectl set-time 2025-06-17 09:08:59 ") Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 17 17:08:58 volumio systemd[1]: Starting Time & Date Service... Jun 17 17:08:58 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 17:08:58 volumio volumio[933]: info: Volumio Calling Home Jun 17 17:08:58 volumio dbus-daemon[649]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 17 17:08:58 volumio systemd[1]: Started Time & Date Service. Jun 17 09:10:01 volumio volumio[933]: info: CoreCommandRouter::volumioPause Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::pause Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::stPlaybackTimer Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::servicePause Jun 17 09:10:01 volumio volumio[933]: info: CorePlayQueue::getTrack 1 Jun 17 09:10:01 volumio volumio[933]: info: CoreCommandRouter::servicePause Jun 17 09:10:01 volumio volumio[933]: info: ControllerMpd::pause Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand pause Jun 17 09:10:01 volumio volumio[933]: info: sendMpdCommand pause took 3 milliseconds Jun 17 09:10:01 volumio volumio[933]: info: Jun 17 09:10:01 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:01 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:01 volumio volumio[933]: info: Jun 17 09:10:01 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:01 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:01 volumio volumio[933]: info: Jun 17 09:10:01 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:01 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:01 volumio volumio[933]: info: sendMpdCommand status took 4 milliseconds Jun 17 09:10:01 volumio volumio[933]: info: sendMpdCommand status took 3 milliseconds Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:01 volumio volumio[933]: info: sendMpdCommand status took 4 milliseconds Jun 17 09:10:01 volumio volumio[933]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 17 09:10:01 volumio volumio[933]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::parseTrackInfo Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::parseTrackInfo Jun 17 09:10:01 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:01 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:01 volumio volumio[933]: info: CorePlayQueue::getTrack 1 Jun 17 09:10:01 volumio volumio[933]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5463,"duration":4415,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"王傑 - [UPM24K] 王傑 DAVE BEST SOUND BEST HITS [No. 0663].wav","artist":null,"album":null,"uri":"NAS/飞牛/王傑 - [UPM24K] 王傑 DAVE BEST SOUND BEST HITS [No. 0663].wav","trackType":"wav"} Jun 17 09:10:01 volumio volumio[933]: verbose: CURRENT POSITION 1 Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::syncState stateService pause Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus pause Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:01 volumio volumio[933]: info: CorePlayQueue::getTrack 1 Jun 17 09:10:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 09:10:01 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::stPlaybackTimer Jun 17 09:10:01 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:01 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:01 volumio volumio[933]: info: CorePlayQueue::getTrack 1 Jun 17 09:10:01 volumio volumio[933]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5463,"duration":4415,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"王傑 - [UPM24K] 王傑 DAVE BEST SOUND BEST HITS [No. 0663].wav","artist":null,"album":null,"uri":"NAS/飞牛/王傑 - [UPM24K] 王傑 DAVE BEST SOUND BEST HITS [No. 0663].wav","trackType":"wav"} Jun 17 09:10:01 volumio volumio[933]: verbose: CURRENT POSITION 1 Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::syncState stateService pause Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus pause Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:01 volumio volumio[933]: info: CorePlayQueue::getTrack 1 Jun 17 09:10:01 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::stPlaybackTimer Jun 17 09:10:01 volumio volumio[933]: info: ------------------------------ 27ms Jun 17 09:10:01 volumio volumio[933]: info: ------------------------------ 27ms Jun 17 09:10:01 volumio volumio[933]: info: sendMpdCommand playlistinfo took 20 milliseconds Jun 17 09:10:01 volumio volumio[933]: verbose: ControllerMpd::parseTrackInfo Jun 17 09:10:01 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:01 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:01 volumio volumio[933]: info: CorePlayQueue::getTrack 1 Jun 17 09:10:01 volumio volumio[933]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5463,"duration":4415,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"王傑 - [UPM24K] 王傑 DAVE BEST SOUND BEST HITS [No. 0663].wav","artist":null,"album":null,"uri":"NAS/飞牛/王傑 - [UPM24K] 王傑 DAVE BEST SOUND BEST HITS [No. 0663].wav","trackType":"wav"} Jun 17 09:10:01 volumio volumio[933]: verbose: CURRENT POSITION 1 Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::syncState stateService pause Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus pause Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:01 volumio volumio[933]: info: CorePlayQueue::getTrack 1 Jun 17 09:10:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 09:10:01 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:01 volumio volumio[933]: info: CoreStateMachine::stPlaybackTimer Jun 17 09:10:01 volumio volumio[933]: info: ------------------------------ 36ms Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::volumioNext Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::next Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::stop Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::updateTrackBlock Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrackBlock Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::stPlaybackTimer Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 1 Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::serviceStop Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 1 Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::serviceStop Jun 17 09:10:02 volumio volumio[933]: info: ControllerMpd::stop Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 09:10:02 volumio volumio[933]: info: sendMpdCommand stop took 6 milliseconds Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::play index undefined Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::startPlaybackTimer Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::clearAddPlayTracks NAS/飞牛/陈慧娴CDImage.wav Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::updateTrackBlock Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrackBlock Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:02 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:02 volumio volumio[933]: info: sendMpdCommand stop took 2 milliseconds Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand clear Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:02 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:02 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:02 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:02 volumio volumio[933]: info: sendMpdCommand status took 5 milliseconds Jun 17 09:10:02 volumio volumio[933]: info: sendMpdCommand clear took 4 milliseconds Jun 17 09:10:02 volumio volumio[933]: info: sendMpdCommand status took 3 milliseconds Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand add "NAS/飞牛/陈慧娴CDImage.wav" Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:02 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:02 volumio volumio[933]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 17 09:10:02 volumio volumio[933]: verbose: CURRENT POSITION 2 Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::syncState stateService stop Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus stop Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:02 volumio volumio[933]: info: No code Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:02 volumio volumio[933]: info: ------------------------------ 23ms Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:02 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:02 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:02 volumio volumio[933]: error: updateQueue error: null Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:02 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:02 volumio volumio[933]: info: sendMpdCommand status took 27 milliseconds Jun 17 09:10:02 volumio volumio[933]: info: ------------------------------ 26ms Jun 17 09:10:02 volumio volumio[933]: info: sendMpdCommand playlistinfo took 24 milliseconds Jun 17 09:10:02 volumio volumio[933]: info: sendMpdCommand add "NAS/飞牛/陈慧娴CDImage.wav" took 24 milliseconds Jun 17 09:10:02 volumio volumio[933]: info: ------------------------------ 4ms Jun 17 09:10:02 volumio volumio[933]: info: ------------------------------ 4ms Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::parseTrackInfo Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand play Jun 17 09:10:02 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:02 volumio volumio[933]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 17 09:10:02 volumio volumio[933]: verbose: CURRENT POSITION 2 Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::syncState stateService stop Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus stop Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:02 volumio volumio[933]: info: No code Jun 17 09:10:02 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:02 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:02 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:02 volumio volumio[933]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 17 09:10:02 volumio volumio[933]: info: ------------------------------ 53ms Jun 17 09:10:02 volumio volumio[933]: info: ------------------------------ 57ms Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:02 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:02 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:02 volumio volumio[933]: info: ------------------------------ 34ms Jun 17 09:10:02 volumio volumio[933]: info: sendMpdCommand play took 31 milliseconds Jun 17 09:10:02 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:02 volumio volumio[933]: info: ------------------------------ 7ms Jun 17 09:10:02 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:02 volumio volumio[933]: info: ------------------------------ 6ms Jun 17 09:10:02 volumio volumio[933]: info: Jun 17 09:10:02 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:02 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:02 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:03 volumio volumio[933]: info: Jun 17 09:10:03 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:03 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:03 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:03 volumio volumio[933]: info: sendMpdCommand status took 4 milliseconds Jun 17 09:10:03 volumio volumio[933]: info: sendMpdCommand status took 4 milliseconds Jun 17 09:10:03 volumio volumio[933]: info: sendMpdCommand status took 3 milliseconds Jun 17 09:10:03 volumio volumio[933]: info: sendMpdCommand status took 2 milliseconds Jun 17 09:10:03 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:03 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:03 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:03 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:03 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:03 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:03 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:03 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:03 volumio volumio[933]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 17 09:10:03 volumio volumio[933]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 17 09:10:03 volumio volumio[933]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 17 09:10:03 volumio volumio[933]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 17 09:10:03 volumio volumio[933]: verbose: ControllerMpd::parseTrackInfo Jun 17 09:10:03 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:03 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:03 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:03 volumio volumio[933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3562,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"陈慧娴CDImage.wav","artist":null,"album":null,"uri":"NAS/飞牛/陈慧娴CDImage.wav","trackType":"wav"} Jun 17 09:10:03 volumio volumio[933]: verbose: CURRENT POSITION 2 Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::syncState stateService play Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus stop Jun 17 09:10:03 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:03 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:03 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:03 volumio volumio[933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3562,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"陈慧娴CDImage.wav","artist":null,"album":null,"uri":"NAS/飞牛/陈慧娴CDImage.wav","trackType":"wav"} Jun 17 09:10:03 volumio volumio[933]: verbose: CURRENT POSITION 2 Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::syncState stateService play Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus play Jun 17 09:10:03 volumio volumio[933]: info: Received an update from plugin. extracting info from payload Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:03 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 09:10:03 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:03 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:03 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:03 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:03 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:03 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:03 volumio volumio[933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3562,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"陈慧娴CDImage.wav","artist":null,"album":null,"uri":"NAS/飞牛/陈慧娴CDImage.wav","trackType":"wav"} Jun 17 09:10:03 volumio volumio[933]: verbose: CURRENT POSITION 2 Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::syncState stateService play Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus play Jun 17 09:10:03 volumio volumio[933]: info: Received an update from plugin. extracting info from payload Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:03 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:03 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:03 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:03 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:03 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:03 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:03 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:03 volumio volumio[933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3562,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"陈慧娴CDImage.wav","artist":null,"album":null,"uri":"NAS/飞牛/陈慧娴CDImage.wav","trackType":"wav"} Jun 17 09:10:03 volumio volumio[933]: verbose: CURRENT POSITION 2 Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::syncState stateService play Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus play Jun 17 09:10:03 volumio volumio[933]: info: Received an update from plugin. extracting info from payload Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:03 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:03 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:03 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:03 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:03 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:03 volumio volumio[933]: info: ------------------------------ 38ms Jun 17 09:10:03 volumio volumio[933]: info: ------------------------------ 70ms Jun 17 09:10:03 volumio volumio[933]: info: ------------------------------ 69ms Jun 17 09:10:03 volumio volumio[933]: info: ------------------------------ 69ms Jun 17 09:10:08 volumio sudo[1983]: pam_unix(sudo:session): session closed for user root Jun 17 09:10:08 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 17 09:10:08 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Jun 17 09:10:08 volumio volumio[933]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:10:11 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:11 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:10:11 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:11 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:10:11 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:11 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:10:11 volumio volumio[933]: verbose: New Socket.io Connection to 192.168.8.124:3000 from 192.168.8.108 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Jun 17 09:10:12 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 17 09:10:24 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:10:24 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:10:24 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:10:24 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:24 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:24 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:10:34 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:10:34 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:10:34 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:10:34 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:34 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:34 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:10:37 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:10:37 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:10:37 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:10:37 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:37 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:37 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:10:41 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:41 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:42 volumio volumio[933]: verbose: New Socket.io Connection to 192.168.8.124:3000 from 192.168.8.108 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Jun 17 09:10:42 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:42 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:42 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 17 09:10:42 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 17 09:10:42 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:42 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:42 volumio sudo[2141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 17 09:10:42 volumio sudo[2141]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 09:10:42 volumio sudo[2141]: pam_unix(sudo:session): session closed for user root Jun 17 09:10:42 volumio sudo[2144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 17 09:10:42 volumio sudo[2144]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 09:10:42 volumio sudo[2144]: pam_unix(sudo:session): session closed for user root Jun 17 09:10:42 volumio volumio[933]: verbose: New Socket.io Connection to 192.168.8.124 from 192.168.8.108 UA: Mozilla/5.0 (Linux; Android 15; V2453A Build/AP3A.240905.015.A2_V000L1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/126.0.6478.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::volumioGetVisibleSources Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:43 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 17 09:10:43 volumio sudo[2149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 17 09:10:43 volumio sudo[2149]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 09:10:43 volumio sudo[2149]: pam_unix(sudo:session): session closed for user root Jun 17 09:10:43 volumio sudo[2152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 17 09:10:43 volumio sudo[2152]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 17 09:10:43 volumio sudo[2152]: pam_unix(sudo:session): session closed for user root Jun 17 09:10:43 volumio volumio[933]: verbose: New Socket.io Connection to 192.168.8.124 from 192.168.8.108 UA: Mozilla/5.0 (Linux; Android 15; V2453A Build/AP3A.240905.015.A2_V000L1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/126.0.6478.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:43 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 17 09:10:43 volumio volumio[933]: info: Listing playlists Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 17 09:10:43 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 17 09:10:44 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:10:44 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:10:44 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:10:44 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:44 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:44 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:10:45 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 17 09:10:45 volumio volumio[933]: info: Received Get System Info Jun 17 09:10:45 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:10:45 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:10:45 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:10:45 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:45 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:45 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:10:49 volumio volumio[933]: info: CoreCommandRouter::volumioGetVisibleSources Jun 17 09:10:49 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 17 09:10:49 volumio volumio[933]: info: CoreCommandRouter::volumioGetQueue Jun 17 09:10:49 volumio volumio[933]: info: CoreStateMachine::getQueue Jun 17 09:10:49 volumio volumio[933]: info: CorePlayQueue::getQueue Jun 17 09:10:54 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:10:54 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:10:54 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:10:54 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:10:54 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:54 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:10:56 volumio volumio[933]: info: VolumeController::SetAlsaVolume62 Jun 17 09:10:56 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:56 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:56 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 09:10:56 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:57 volumio volumio[933]: info: VolumeController::SetAlsaVolume61 Jun 17 09:10:57 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:57 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:57 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 09:10:57 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioNext Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::next Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::stop Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::stPlaybackTimer Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::updateTrackBlock Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrackBlock Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::serviceStop Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 2 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::serviceStop Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::stop Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand stop took 9 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::play index undefined Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::startPlaybackTimer Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::clearAddPlayTracks NAS/飞牛/徐小凤 - 环球DSD视听之王.wav Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::updateTrackBlock Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrackBlock Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand stop took 2 milliseconds Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand clear Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:59 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand status took 7 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand clear took 8 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand status took 6 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand status took 3 milliseconds Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand add "NAS/飞牛/徐小凤 - 环球DSD视听之王.wav" Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 17 09:10:59 volumio volumio[933]: verbose: CURRENT POSITION 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState stateService stop Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus stop Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: No code Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 17 09:10:59 volumio volumio[933]: verbose: CURRENT POSITION 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState stateService stop Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus stop Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: No code Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 80ms Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 80ms Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:59 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:59 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:59 volumio volumio[933]: error: updateQueue error: null Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:59 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 83ms Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand playlistinfo took 80 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand add "NAS/飞牛/徐小凤 - 环球DSD视听之王.wav" took 80 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 6ms Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseTrackInfo Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand play Jun 17 09:10:59 volumio volumio[933]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 93ms Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:59 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces system playlist update Jun 17 09:10:59 volumio volumio[933]: info: Ignoring MPD Status Update Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 18ms Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 16ms Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand play took 12 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 11ms Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 10ms Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand status took 15 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand status took 8 milliseconds Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:59 volumio volumio[933]: info: Jun 17 09:10:59 volumio volumio[933]: ---------------------------- MPD announces state update: player Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::getState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand status took 11 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand status took 8 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand status took 6 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand status took 4 milliseconds Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseTrackInfo Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseTrackInfo Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseState Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":3849,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"徐小凤 - 环球DSD视听之王.wav","artist":"???","album":"??DSD????","uri":"NAS/飞牛/徐小凤 - 环球DSD视听之王.wav","trackType":"wav"} Jun 17 09:10:59 volumio volumio[933]: verbose: CURRENT POSITION 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState stateService play Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus stop Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":3849,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"徐小凤 - 环球DSD视听之王.wav","artist":"???","album":"??DSD????","uri":"NAS/飞牛/徐小凤 - 环球DSD视听之王.wav","trackType":"wav"} Jun 17 09:10:59 volumio volumio[933]: verbose: CURRENT POSITION 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState stateService play Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus play Jun 17 09:10:59 volumio volumio[933]: info: Received an update from plugin. extracting info from payload Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 44ms Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 56ms Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand playlistinfo took 34 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand playlistinfo took 33 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand playlistinfo took 33 milliseconds Jun 17 09:10:59 volumio volumio[933]: info: sendMpdCommand playlistinfo took 32 milliseconds Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseTrackInfo Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseTrackInfo Jun 17 09:10:59 volumio volumio[933]: verbose: ControllerMpd::parseTrackInfo Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":3849,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"徐小凤 - 环球DSD视听之王.wav","artist":"???","album":"??DSD????","uri":"NAS/飞牛/徐小凤 - 环球DSD视听之王.wav","trackType":"wav"} Jun 17 09:10:59 volumio volumio[933]: verbose: CURRENT POSITION 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState stateService play Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus play Jun 17 09:10:59 volumio volumio[933]: info: Received an update from plugin. extracting info from payload Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":3849,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"徐小凤 - 环球DSD视听之王.wav","artist":"???","album":"??DSD????","uri":"NAS/飞牛/徐小凤 - 环球DSD视听之王.wav","trackType":"wav"} Jun 17 09:10:59 volumio volumio[933]: verbose: CURRENT POSITION 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState stateService play Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus play Jun 17 09:10:59 volumio volumio[933]: info: Received an update from plugin. extracting info from payload Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":3849,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"徐小凤 - 环球DSD视听之王.wav","artist":"???","album":"??DSD????","uri":"NAS/飞牛/徐小凤 - 环球DSD视听之王.wav","trackType":"wav"} Jun 17 09:10:59 volumio volumio[933]: verbose: CURRENT POSITION 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState stateService play Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus play Jun 17 09:10:59 volumio volumio[933]: info: Received an update from plugin. extracting info from payload Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: ControllerMpd::pushState Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::servicePushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":3849,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"徐小凤 - 环球DSD视听之王.wav","artist":"???","album":"??DSD????","uri":"NAS/飞牛/徐小凤 - 环球DSD视听之王.wav","trackType":"wav"} Jun 17 09:10:59 volumio volumio[933]: verbose: CURRENT POSITION 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState stateService play Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::syncState currentStatus play Jun 17 09:10:59 volumio volumio[933]: info: Received an update from plugin. extracting info from payload Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: CoreStateMachine::pushState Jun 17 09:10:59 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:10:59 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 132ms Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 129ms Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 125ms Jun 17 09:10:59 volumio volumio[933]: info: ------------------------------ 123ms Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 17 09:11:03 volumio volumio[933]: info: Retrieving Cloud Streaming UI Jun 17 09:11:03 volumio volumio[933]: info: Getting Tidal Cloud Configuration Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 17 09:11:03 volumio volumio[933]: info: Getting Qobuz Cloud Configuration Jun 17 09:11:03 volumio volumio[933]: info: Asking plugin for UI Config Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 17 09:11:03 volumio volumio[933]: info: Getting Spotify Cloud Configuration Jun 17 09:11:03 volumio volumio[933]: info: Asking plugin for UI Config Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 17 09:11:03 volumio volumio[933]: info: Saving Spotify Acccount Jun 17 09:11:03 volumio volumio[933]: info: Got Tidal Cloud Configuration Jun 17 09:11:03 volumio volumio[933]: info: Got it Jun 17 09:11:03 volumio volumio[933]: info: Got it Jun 17 09:11:03 volumio volumio[933]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 17 09:11:03 volumio volumio[933]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::volumioGetBrowseSources Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::volumioGetBrowseSources Jun 17 09:11:03 volumio volumio[933]: info: CoreCommandRouter::volumioGetBrowseSources Jun 17 09:11:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 17 09:11:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 17 09:11:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:11:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:11:04 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:11:04 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:11:04 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:11:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:11:07 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:11:07 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:11:07 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:11:07 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:11:07 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:11:07 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:11:08 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 17 09:11:12 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 17 09:11:14 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:11:14 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:11:14 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:11:14 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:11:14 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:11:14 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:11:16 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 17 09:11:18 volumio volumio[933]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%3F%3F/14656ddd-4a3b-470d-a6b5-8154c17428e1.jpg' Jun 17 09:11:19 volumio volumio[933]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%3F%3F%3F/bc2c23ba-666b-4bea-a9c0-7c324f8867ec.jpg' Jun 17 09:11:25 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 09:11:25 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 09:11:25 volumio volumio[933]: info: Discovery: Getting this device information Jun 17 09:11:25 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Jun 17 09:11:25 volumio volumio[933]: info: CorePlayQueue::getTrack 3 Jun 17 09:11:25 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 09:11:25 volumio volumio[933]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Beyond/Beyond%20The%20Stage/26ca3923-d9f3-4362-9679-621b394d6c8c.jpg' Jun 17 09:11:25 volumio volumio[933]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Beyond/Control/a42d8c5b-5f1d-4e65-a868-81b47af70599.jpg' Jun 17 09:11:26 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 17 09:11:28 volumio volumio[933]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 17 09:11:28 volumio volumio[933]: Error: connect ECONNREFUSED 162.220.12.226:443 Jun 17 09:11:28 volumio volumio[933]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 17 09:11:28 volumio volumio[933]: errno: -111, Jun 17 09:11:28 volumio volumio[933]: code: 'ECONNREFUSED', Jun 17 09:11:28 volumio volumio[933]: syscall: 'connect', Jun 17 09:11:28 volumio volumio[933]: address: '162.220.12.226', Jun 17 09:11:28 volumio volumio[933]: port: 443 Jun 17 09:11:28 volumio volumio[933]: } Jun 17 09:11:28 volumio volumio[933]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 17 09:11:29 volumio sudo[2393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-17 09:10 Jun 17 09:11:29 volumio sudo[2393]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"