-- Logs begin at Mon 2025-01-20 22:00:52 +07, end at Mon 2025-01-20 22:01:06 +07. -- Jan 20 22:00:52 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 Jan 20 22:00:52 volumio kernel: Command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=3f028649-eecb-444a-b737-1c6582e1c917 bootpart=UUID=6B5A-4D5C datapart=UUID=297d87e1-ef5b-446f-8570-1df41617e746 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 Jan 20 22:00:52 volumio kernel: KERNEL supported cpus: Jan 20 22:00:52 volumio kernel: Intel GenuineIntel Jan 20 22:00:52 volumio kernel: AMD AuthenticAMD Jan 20 22:00:52 volumio kernel: Hygon HygonGenuine Jan 20 22:00:52 volumio kernel: Centaur CentaurHauls Jan 20 22:00:52 volumio kernel: zhaoxin Shanghai Jan 20 22:00:52 volumio kernel: BIOS-provided physical RAM map: Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x0000000000100000-0x000000008db11fff] usable Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x000000008db12000-0x000000008ddf5fff] reserved Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x000000008ddf6000-0x000000008de05fff] ACPI data Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x000000008de06000-0x000000008dee1fff] ACPI NVS Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x000000008dee2000-0x000000008e5ccfff] reserved Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x000000008e5cd000-0x000000008e621fff] type 20 Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x000000008e622000-0x000000008e622fff] usable Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x000000008e623000-0x000000008e828fff] ACPI NVS Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x000000008e829000-0x000000008ec57fff] usable Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x000000008ec58000-0x000000008eff3fff] reserved Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x000000008eff4000-0x000000008effffff] usable Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x00000000fec10000-0x00000000fec10fff] reserved Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x00000000fed00000-0x00000000fed00fff] reserved Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x00000000fed80000-0x00000000fed8ffff] reserved Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x00000000ff000000-0x00000000ffffffff] reserved Jan 20 22:00:52 volumio kernel: BIOS-e820: [mem 0x0000000100001000-0x000000043effffff] usable Jan 20 22:00:52 volumio kernel: NX (Execute Disable) protection: active Jan 20 22:00:52 volumio kernel: APIC: Static calls initialized Jan 20 22:00:52 volumio kernel: efi: EFI v32.3.1 by American Megatrends Jan 20 22:00:52 volumio kernel: efi: ACPI=0x8ddfe000 ACPI 2.0=0x8ddfe000 SMBIOS=0xf04c0 Jan 20 22:00:52 volumio kernel: efi: Not removing mem159: MMIO range=[0xfec00000-0xfec00fff] (4KB) from e820 map Jan 20 22:00:52 volumio kernel: efi: Not removing mem160: MMIO range=[0xfec10000-0xfec10fff] (4KB) from e820 map Jan 20 22:00:52 volumio kernel: efi: Not removing mem161: MMIO range=[0xfed00000-0xfed00fff] (4KB) from e820 map Jan 20 22:00:52 volumio kernel: efi: Not removing mem162: MMIO range=[0xfed80000-0xfed80fff] (4KB) from e820 map Jan 20 22:00:52 volumio kernel: efi: Not removing mem163: MMIO range=[0xfed81000-0xfed8ffff] (60KB) from e820 map Jan 20 22:00:52 volumio kernel: efi: Remove mem164: MMIO range=[0xff000000-0xffffffff] (16MB) from e820 map Jan 20 22:00:52 volumio kernel: e820: remove [mem 0xff000000-0xffffffff] reserved Jan 20 22:00:52 volumio kernel: SMBIOS 2.7 present. Jan 20 22:00:52 volumio kernel: DMI: System manufacturer System Product Name/F2A85-M LE, BIOS 6504 11/26/2014 Jan 20 22:00:52 volumio kernel: tsc: Fast TSC calibration using PIT Jan 20 22:00:52 volumio kernel: tsc: Detected 3818.853 MHz processor Jan 20 22:00:52 volumio kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jan 20 22:00:52 volumio kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jan 20 22:00:52 volumio kernel: last_pfn = 0x43f000 max_arch_pfn = 0x400000000 Jan 20 22:00:52 volumio kernel: MTRR map: 7 entries (5 fixed + 2 variable; max 22), built from 9 variable MTRRs Jan 20 22:00:52 volumio kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jan 20 22:00:52 volumio kernel: e820: update [mem 0x8f000000-0xffffffff] usable ==> reserved Jan 20 22:00:52 volumio kernel: last_pfn = 0x8f000 max_arch_pfn = 0x400000000 Jan 20 22:00:52 volumio kernel: found SMP MP-table at [mem 0x000fd7c0-0x000fd7cf] Jan 20 22:00:52 volumio kernel: Using GB pages for direct mapping Jan 20 22:00:52 volumio kernel: Secure boot could not be determined Jan 20 22:00:52 volumio kernel: RAMDISK: [mem 0x2fae7000-0x33d6afff] Jan 20 22:00:52 volumio kernel: ACPI: Early table checksum verification disabled Jan 20 22:00:52 volumio kernel: ACPI: RSDP 0x000000008DDFE000 000024 (v02 ALASKA) Jan 20 22:00:52 volumio kernel: ACPI: XSDT 0x000000008DDFE078 000064 (v01 ALASKA A M I 01072009 AMI 00010013) Jan 20 22:00:52 volumio kernel: ACPI: FACP 0x000000008DE048F8 00010C (v05 ALASKA A M I 01072009 AMI 00010013) Jan 20 22:00:52 volumio kernel: ACPI BIOS Warning (bug): Optional FADT field Pm2ControlBlock has valid Length but zero Address: 0x0000000000000000/0x1 (20230628/tbfadt-615) Jan 20 22:00:52 volumio kernel: ACPI: DSDT 0x000000008DDFE170 006788 (v02 ALASKA A M I 00000000 INTL 20051117) Jan 20 22:00:52 volumio kernel: ACPI: FACS 0x000000008DED7080 000040 Jan 20 22:00:52 volumio kernel: ACPI: APIC 0x000000008DE04A08 000072 (v03 ALASKA A M I 01072009 AMI 00010013) Jan 20 22:00:52 volumio kernel: ACPI: FPDT 0x000000008DE04A80 000044 (v01 ALASKA A M I 01072009 AMI 00010013) Jan 20 22:00:52 volumio kernel: ACPI: MCFG 0x000000008DE04AC8 00003C (v01 ALASKA A M I 01072009 MSFT 00010013) Jan 20 22:00:52 volumio kernel: ACPI: SSDT 0x000000008DE05910 0004B7 (v02 AMD ANNAPURN 00000001 MSFT 04000000) Jan 20 22:00:52 volumio kernel: ACPI: HPET 0x000000008DE04B60 000038 (v01 ALASKA A M I 01072009 AMI 00000005) Jan 20 22:00:52 volumio kernel: ACPI: BGRT 0x000000008DE04B98 000038 (v00 ALASKA A M I 01072009 AMI 00010013) Jan 20 22:00:52 volumio kernel: ACPI: SSDT 0x000000008DE04BD0 000D40 (v01 AMD ANNAPURN 00000001 AMD 00000001) Jan 20 22:00:52 volumio kernel: ACPI: Reserving FACP table memory at [mem 0x8de048f8-0x8de04a03] Jan 20 22:00:52 volumio kernel: ACPI: Reserving DSDT table memory at [mem 0x8ddfe170-0x8de048f7] Jan 20 22:00:52 volumio kernel: ACPI: Reserving FACS table memory at [mem 0x8ded7080-0x8ded70bf] Jan 20 22:00:52 volumio kernel: ACPI: Reserving APIC table memory at [mem 0x8de04a08-0x8de04a79] Jan 20 22:00:52 volumio kernel: ACPI: Reserving FPDT table memory at [mem 0x8de04a80-0x8de04ac3] Jan 20 22:00:52 volumio kernel: ACPI: Reserving MCFG table memory at [mem 0x8de04ac8-0x8de04b03] Jan 20 22:00:52 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x8de05910-0x8de05dc6] Jan 20 22:00:52 volumio kernel: ACPI: Reserving HPET table memory at [mem 0x8de04b60-0x8de04b97] Jan 20 22:00:52 volumio kernel: ACPI: Reserving BGRT table memory at [mem 0x8de04b98-0x8de04bcf] Jan 20 22:00:52 volumio kernel: ACPI: Reserving SSDT table memory at [mem 0x8de04bd0-0x8de0590f] Jan 20 22:00:52 volumio kernel: Zone ranges: Jan 20 22:00:52 volumio kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jan 20 22:00:52 volumio kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Jan 20 22:00:52 volumio kernel: Normal [mem 0x0000000100000000-0x000000043effffff] Jan 20 22:00:52 volumio kernel: Movable zone start for each node Jan 20 22:00:52 volumio kernel: Early memory node ranges Jan 20 22:00:52 volumio kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Jan 20 22:00:52 volumio kernel: node 0: [mem 0x0000000000100000-0x000000008db11fff] Jan 20 22:00:52 volumio kernel: node 0: [mem 0x000000008e622000-0x000000008e622fff] Jan 20 22:00:52 volumio kernel: node 0: [mem 0x000000008e829000-0x000000008ec57fff] Jan 20 22:00:52 volumio kernel: node 0: [mem 0x000000008eff4000-0x000000008effffff] Jan 20 22:00:52 volumio kernel: node 0: [mem 0x0000000100001000-0x000000043effffff] Jan 20 22:00:52 volumio kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000043effffff] Jan 20 22:00:52 volumio kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jan 20 22:00:52 volumio kernel: On node 0, zone DMA: 96 pages in unavailable ranges Jan 20 22:00:52 volumio kernel: On node 0, zone DMA32: 2832 pages in unavailable ranges Jan 20 22:00:52 volumio kernel: On node 0, zone DMA32: 518 pages in unavailable ranges Jan 20 22:00:52 volumio kernel: On node 0, zone DMA32: 924 pages in unavailable ranges Jan 20 22:00:52 volumio kernel: On node 0, zone Normal: 4097 pages in unavailable ranges Jan 20 22:00:52 volumio kernel: On node 0, zone Normal: 4096 pages in unavailable ranges Jan 20 22:00:52 volumio kernel: ACPI: PM-Timer IO Port: 0x808 Jan 20 22:00:52 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0xff] high edge lint[0x1]) Jan 20 22:00:52 volumio kernel: IOAPIC[0]: apic_id 5, version 33, address 0xfec00000, GSI 0-23 Jan 20 22:00:52 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jan 20 22:00:52 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 low level) Jan 20 22:00:52 volumio kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jan 20 22:00:52 volumio kernel: ACPI: HPET id: 0x10228210 base: 0xfed00000 Jan 20 22:00:52 volumio kernel: efi_bgrt: Ignoring BGRT: invalid image address Jan 20 22:00:52 volumio kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000fffff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x8db12000-0x8ddf5fff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x8ddf6000-0x8de05fff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x8de06000-0x8dee1fff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x8dee2000-0x8e5ccfff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x8e5cd000-0x8e621fff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x8e623000-0x8e828fff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x8ec58000-0x8eff3fff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0x8f000000-0xfebfffff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xfec00000-0xfec00fff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xfec01000-0xfec0ffff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xfec10000-0xfec10fff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xfec11000-0xfecfffff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xfed00000-0xfed00fff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xfed01000-0xfed7ffff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xfed80000-0xfed8ffff] Jan 20 22:00:52 volumio kernel: PM: hibernation: Registered nosave memory: [mem 0xfed90000-0x100000fff] Jan 20 22:00:52 volumio kernel: [mem 0x8f000000-0xfebfffff] available for PCI devices Jan 20 22:00:52 volumio kernel: Booting paravirtualized kernel on bare hardware Jan 20 22:00:52 volumio kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Jan 20 22:00:52 volumio kernel: setup_percpu: NR_CPUS:8 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jan 20 22:00:52 volumio kernel: percpu: Embedded 56 pages/cpu s191400 r8192 d29784 u524288 Jan 20 22:00:52 volumio kernel: pcpu-alloc: s191400 r8192 d29784 u524288 alloc=1*2097152 Jan 20 22:00:52 volumio kernel: pcpu-alloc: [0] 0 1 2 3 Jan 20 22:00:52 volumio kernel: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=3f028649-eecb-444a-b737-1c6582e1c917 bootpart=UUID=6B5A-4D5C datapart=UUID=297d87e1-ef5b-446f-8570-1df41617e746 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 Jan 20 22:00:52 volumio kernel: Unknown kernel command line parameters "splash BOOT_IMAGE=/vmlinuz biosdevname=0 imgpart=UUID=3f028649-eecb-444a-b737-1c6582e1c917 bootpart=UUID=6B5A-4D5C datapart=UUID=297d87e1-ef5b-446f-8570-1df41617e746 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh use_kmsg=no", will be passed to user space. Jan 20 22:00:52 volumio kernel: Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear) Jan 20 22:00:52 volumio kernel: Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) Jan 20 22:00:52 volumio kernel: Built 1 zonelists, mobility grouping on. Total pages: 3922703 Jan 20 22:00:52 volumio kernel: mem auto-init: stack:all(zero), heap alloc:off, heap free:off Jan 20 22:00:52 volumio kernel: software IO TLB: area num 4. Jan 20 22:00:52 volumio kernel: Memory: 15293956K/15940528K available (14336K kernel code, 1878K rwdata, 4640K rodata, 2988K init, 1148K bss, 646316K reserved, 0K cma-reserved) Jan 20 22:00:52 volumio kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jan 20 22:00:52 volumio kernel: ftrace: allocating 40433 entries in 158 pages Jan 20 22:00:52 volumio kernel: ftrace: allocated 158 pages with 5 groups Jan 20 22:00:52 volumio kernel: Dynamic Preempt: voluntary Jan 20 22:00:52 volumio kernel: rcu: Preemptible hierarchical RCU implementation. Jan 20 22:00:52 volumio kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Jan 20 22:00:52 volumio kernel: Trampoline variant of Tasks RCU enabled. Jan 20 22:00:52 volumio kernel: Rude variant of Tasks RCU enabled. Jan 20 22:00:52 volumio kernel: Tracing variant of Tasks RCU enabled. Jan 20 22:00:52 volumio kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Jan 20 22:00:52 volumio kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jan 20 22:00:52 volumio kernel: NR_IRQS: 4352, nr_irqs: 456, preallocated irqs: 16 Jan 20 22:00:52 volumio kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 20 22:00:52 volumio kernel: Console: colour dummy device 80x25 Jan 20 22:00:52 volumio kernel: printk: console [tty0] enabled Jan 20 22:00:52 volumio kernel: ACPI: Core revision 20230628 Jan 20 22:00:52 volumio kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 133484873504 ns Jan 20 22:00:52 volumio kernel: APIC: Switch to symmetric I/O mode setup Jan 20 22:00:52 volumio kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jan 20 22:00:52 volumio kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x6e17d46fb31, max_idle_ns: 881590648004 ns Jan 20 22:00:52 volumio kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 7637.70 BogoMIPS (lpj=15275412) Jan 20 22:00:52 volumio kernel: Last level iTLB entries: 4KB 512, 2MB 1024, 4MB 512 Jan 20 22:00:52 volumio kernel: Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 512, 1GB 0 Jan 20 22:00:52 volumio kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jan 20 22:00:52 volumio kernel: Spectre V2 : Mitigation: Retpolines Jan 20 22:00:52 volumio kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Jan 20 22:00:52 volumio kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Jan 20 22:00:52 volumio kernel: RETBleed: Mitigation: untrained return thunk Jan 20 22:00:52 volumio kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Jan 20 22:00:52 volumio kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jan 20 22:00:52 volumio kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jan 20 22:00:52 volumio kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jan 20 22:00:52 volumio kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jan 20 22:00:52 volumio kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Jan 20 22:00:52 volumio kernel: Freeing SMP alternatives memory: 32K Jan 20 22:00:52 volumio kernel: pid_max: default: 32768 minimum: 301 Jan 20 22:00:52 volumio kernel: LSM: initializing lsm=capability,yama,integrity Jan 20 22:00:52 volumio kernel: Yama: becoming mindful. Jan 20 22:00:52 volumio kernel: Mount-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 20 22:00:52 volumio kernel: Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 20 22:00:52 volumio kernel: smpboot: CPU0: AMD A10-5800K APU with Radeon(tm) HD Graphics (family: 0x15, model: 0x10, stepping: 0x1) Jan 20 22:00:52 volumio kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Jan 20 22:00:52 volumio kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Jan 20 22:00:52 volumio kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Jan 20 22:00:52 volumio kernel: Performance Events: Fam15h core perfctr, AMD PMU driver. Jan 20 22:00:52 volumio kernel: ... version: 0 Jan 20 22:00:52 volumio kernel: ... bit width: 48 Jan 20 22:00:52 volumio kernel: ... generic registers: 6 Jan 20 22:00:52 volumio kernel: ... value mask: 0000ffffffffffff Jan 20 22:00:52 volumio kernel: ... max period: 00007fffffffffff Jan 20 22:00:52 volumio kernel: ... fixed-purpose events: 0 Jan 20 22:00:52 volumio kernel: ... event mask: 000000000000003f Jan 20 22:00:52 volumio kernel: signal: max sigframe size: 1776 Jan 20 22:00:52 volumio kernel: rcu: Hierarchical SRCU implementation. Jan 20 22:00:52 volumio kernel: rcu: Max phase no-delay instances is 1000. Jan 20 22:00:52 volumio kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. Jan 20 22:00:52 volumio kernel: smp: Bringing up secondary CPUs ... Jan 20 22:00:52 volumio kernel: smpboot: x86: Booting SMP configuration: Jan 20 22:00:52 volumio kernel: .... node #0, CPUs: #2 #1 #3 Jan 20 22:00:52 volumio kernel: smp: Brought up 1 node, 4 CPUs Jan 20 22:00:52 volumio kernel: smpboot: Max logical packages: 1 Jan 20 22:00:52 volumio kernel: smpboot: Total of 4 processors activated (30550.82 BogoMIPS) Jan 20 22:00:52 volumio kernel: devtmpfs: initialized Jan 20 22:00:52 volumio kernel: x86/mm: Memory block size: 128MB Jan 20 22:00:52 volumio kernel: ACPI: PM: Registering ACPI NVS region [mem 0x8de06000-0x8dee1fff] (901120 bytes) Jan 20 22:00:52 volumio kernel: ACPI: PM: Registering ACPI NVS region [mem 0x8e623000-0x8e828fff] (2121728 bytes) Jan 20 22:00:52 volumio kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Jan 20 22:00:52 volumio kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jan 20 22:00:52 volumio kernel: pinctrl core: initialized pinctrl subsystem Jan 20 22:00:52 volumio kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 20 22:00:52 volumio kernel: audit: initializing netlink subsys (disabled) Jan 20 22:00:52 volumio kernel: audit: type=2000 audit(1737385235.168:1): state=initialized audit_enabled=0 res=1 Jan 20 22:00:52 volumio kernel: thermal_sys: Registered thermal governor 'fair_share' Jan 20 22:00:52 volumio kernel: thermal_sys: Registered thermal governor 'bang_bang' Jan 20 22:00:52 volumio kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 20 22:00:52 volumio kernel: thermal_sys: Registered thermal governor 'user_space' Jan 20 22:00:52 volumio kernel: EISA bus registered Jan 20 22:00:52 volumio kernel: cpuidle: using governor ladder Jan 20 22:00:52 volumio kernel: cpuidle: using governor menu Jan 20 22:00:52 volumio kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 20 22:00:52 volumio kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Jan 20 22:00:52 volumio kernel: PCI: not using MMCONFIG Jan 20 22:00:52 volumio kernel: PCI: Using configuration type 1 for base access Jan 20 22:00:52 volumio kernel: PCI: Using configuration type 1 for extended access Jan 20 22:00:52 volumio kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jan 20 22:00:52 volumio kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 20 22:00:52 volumio kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jan 20 22:00:52 volumio kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 20 22:00:52 volumio kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jan 20 22:00:52 volumio kernel: ACPI: Added _OSI(Module Device) Jan 20 22:00:52 volumio kernel: ACPI: Added _OSI(Processor Device) Jan 20 22:00:52 volumio kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jan 20 22:00:52 volumio kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 20 22:00:52 volumio kernel: ACPI: 3 ACPI AML tables successfully acquired and loaded Jan 20 22:00:52 volumio kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Jan 20 22:00:52 volumio kernel: ACPI: Interpreter enabled Jan 20 22:00:52 volumio kernel: ACPI: PM: (supports S0 S3 S4 S5) Jan 20 22:00:52 volumio kernel: ACPI: Using IOAPIC for interrupt routing Jan 20 22:00:52 volumio kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Jan 20 22:00:52 volumio kernel: PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved as ACPI motherboard resource Jan 20 22:00:52 volumio kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jan 20 22:00:52 volumio kernel: PCI: Using E820 reservations for host bridge windows Jan 20 22:00:52 volumio kernel: ACPI: Enabled 8 GPEs in block 00 to 1F Jan 20 22:00:52 volumio kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jan 20 22:00:52 volumio kernel: acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jan 20 22:00:52 volumio kernel: acpi PNP0A03:00: _OSC: platform does not support [PCIeHotplug SHPCHotplug PME LTR] Jan 20 22:00:52 volumio kernel: acpi PNP0A03:00: _OSC: OS now controls [AER PCIeCapability] Jan 20 22:00:52 volumio kernel: PCI host bridge to bus 0000:00 Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x03af window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: root bus resource [io 0x03e0-0x0cf7 window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: root bus resource [io 0x03b0-0x03df window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000dffff window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xffffffff window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jan 20 22:00:52 volumio kernel: pci 0000:00:00.0: [1022:1410] type 00 class 0x060000 Jan 20 22:00:52 volumio kernel: pci 0000:00:01.0: [1002:9901] type 00 class 0x030000 Jan 20 22:00:52 volumio kernel: pci 0000:00:01.0: reg 0x10: [mem 0xc0000000-0xcfffffff pref] Jan 20 22:00:52 volumio kernel: pci 0000:00:01.0: reg 0x14: [io 0xf000-0xf0ff] Jan 20 22:00:52 volumio kernel: pci 0000:00:01.0: reg 0x18: [mem 0xfef00000-0xfef3ffff] Jan 20 22:00:52 volumio kernel: pci 0000:00:01.0: enabling Extended Tags Jan 20 22:00:52 volumio kernel: pci 0000:00:01.0: BAR 0: assigned to efifb Jan 20 22:00:52 volumio kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jan 20 22:00:52 volumio kernel: pci 0000:00:01.0: supports D1 D2 Jan 20 22:00:52 volumio kernel: pci 0000:00:01.1: [1002:9902] type 00 class 0x040300 Jan 20 22:00:52 volumio kernel: pci 0000:00:01.1: reg 0x10: [mem 0xfef44000-0xfef47fff] Jan 20 22:00:52 volumio kernel: pci 0000:00:01.1: enabling Extended Tags Jan 20 22:00:52 volumio kernel: pci 0000:00:01.1: supports D1 D2 Jan 20 22:00:52 volumio kernel: pci 0000:00:10.0: [1022:7812] type 00 class 0x0c0330 Jan 20 22:00:52 volumio kernel: pci 0000:00:10.0: reg 0x10: [mem 0xfef4a000-0xfef4bfff 64bit] Jan 20 22:00:52 volumio kernel: pci 0000:00:10.0: PME# supported from D0 D3hot D3cold Jan 20 22:00:52 volumio kernel: pci 0000:00:10.1: [1022:7812] type 00 class 0x0c0330 Jan 20 22:00:52 volumio kernel: pci 0000:00:10.1: reg 0x10: [mem 0xfef48000-0xfef49fff 64bit] Jan 20 22:00:52 volumio kernel: pci 0000:00:10.1: PME# supported from D0 D3hot D3cold Jan 20 22:00:52 volumio kernel: pci 0000:00:11.0: [1022:7801] type 00 class 0x010601 Jan 20 22:00:52 volumio kernel: pci 0000:00:11.0: reg 0x10: [io 0xf140-0xf147] Jan 20 22:00:52 volumio kernel: pci 0000:00:11.0: reg 0x14: [io 0xf130-0xf133] Jan 20 22:00:52 volumio kernel: pci 0000:00:11.0: reg 0x18: [io 0xf120-0xf127] Jan 20 22:00:52 volumio kernel: pci 0000:00:11.0: reg 0x1c: [io 0xf110-0xf113] Jan 20 22:00:52 volumio kernel: pci 0000:00:11.0: reg 0x20: [io 0xf100-0xf10f] Jan 20 22:00:52 volumio kernel: pci 0000:00:11.0: reg 0x24: [mem 0xfef50000-0xfef507ff] Jan 20 22:00:52 volumio kernel: pci 0000:00:12.0: [1022:7807] type 00 class 0x0c0310 Jan 20 22:00:52 volumio kernel: pci 0000:00:12.0: reg 0x10: [mem 0xfef4f000-0xfef4ffff] Jan 20 22:00:52 volumio kernel: pci 0000:00:12.2: [1022:7808] type 00 class 0x0c0320 Jan 20 22:00:52 volumio kernel: pci 0000:00:12.2: reg 0x10: [mem 0xfef4e000-0xfef4e0ff] Jan 20 22:00:52 volumio kernel: pci 0000:00:12.2: supports D1 D2 Jan 20 22:00:52 volumio kernel: pci 0000:00:12.2: PME# supported from D0 D1 D2 D3hot Jan 20 22:00:52 volumio kernel: pci 0000:00:13.0: [1022:7807] type 00 class 0x0c0310 Jan 20 22:00:52 volumio kernel: pci 0000:00:13.0: reg 0x10: [mem 0xfef4d000-0xfef4dfff] Jan 20 22:00:52 volumio kernel: pci 0000:00:13.2: [1022:7808] type 00 class 0x0c0320 Jan 20 22:00:52 volumio kernel: pci 0000:00:13.2: reg 0x10: [mem 0xfef4c000-0xfef4c0ff] Jan 20 22:00:52 volumio kernel: pci 0000:00:13.2: supports D1 D2 Jan 20 22:00:52 volumio kernel: pci 0000:00:13.2: PME# supported from D0 D1 D2 D3hot Jan 20 22:00:52 volumio kernel: pci 0000:00:14.0: [1022:780b] type 00 class 0x0c0500 Jan 20 22:00:52 volumio kernel: pci 0000:00:14.2: [1022:780d] type 00 class 0x040300 Jan 20 22:00:52 volumio kernel: pci 0000:00:14.2: reg 0x10: [mem 0xfef40000-0xfef43fff 64bit] Jan 20 22:00:52 volumio kernel: pci 0000:00:14.2: PME# supported from D0 D3hot D3cold Jan 20 22:00:52 volumio kernel: pci 0000:00:14.3: [1022:780e] type 00 class 0x060100 Jan 20 22:00:52 volumio kernel: pci 0000:00:14.4: [1022:780f] type 01 class 0x060401 Jan 20 22:00:52 volumio kernel: pci 0000:00:15.0: [1022:43a0] type 01 class 0x060400 Jan 20 22:00:52 volumio kernel: pci 0000:00:15.0: enabling Extended Tags Jan 20 22:00:52 volumio kernel: pci 0000:00:15.0: supports D1 D2 Jan 20 22:00:52 volumio kernel: pci 0000:00:15.1: [1022:43a1] type 01 class 0x060400 Jan 20 22:00:52 volumio kernel: pci 0000:00:15.1: enabling Extended Tags Jan 20 22:00:52 volumio kernel: pci 0000:00:15.1: supports D1 D2 Jan 20 22:00:52 volumio kernel: pci 0000:00:18.0: [1022:1400] type 00 class 0x060000 Jan 20 22:00:52 volumio kernel: pci 0000:00:18.1: [1022:1401] type 00 class 0x060000 Jan 20 22:00:52 volumio kernel: pci 0000:00:18.2: [1022:1402] type 00 class 0x060000 Jan 20 22:00:52 volumio kernel: pci 0000:00:18.3: [1022:1403] type 00 class 0x060000 Jan 20 22:00:52 volumio kernel: pci 0000:00:18.4: [1022:1404] type 00 class 0x060000 Jan 20 22:00:52 volumio kernel: pci 0000:00:18.5: [1022:1405] type 00 class 0x060000 Jan 20 22:00:52 volumio kernel: pci_bus 0000:01: extended config space not accessible Jan 20 22:00:52 volumio kernel: pci 0000:00:14.4: PCI bridge to [bus 01] (subtractive decode) Jan 20 22:00:52 volumio kernel: pci 0000:00:14.4: bridge window [io 0x0000-0x03af window] (subtractive decode) Jan 20 22:00:52 volumio kernel: pci 0000:00:14.4: bridge window [io 0x03e0-0x0cf7 window] (subtractive decode) Jan 20 22:00:52 volumio kernel: pci 0000:00:14.4: bridge window [io 0x03b0-0x03df window] (subtractive decode) Jan 20 22:00:52 volumio kernel: pci 0000:00:14.4: bridge window [io 0x0d00-0xffff window] (subtractive decode) Jan 20 22:00:52 volumio kernel: pci 0000:00:14.4: bridge window [mem 0x000a0000-0x000dffff window] (subtractive decode) Jan 20 22:00:52 volumio kernel: pci 0000:00:14.4: bridge window [mem 0xc0000000-0xffffffff window] (subtractive decode) Jan 20 22:00:52 volumio kernel: pci 0000:00:15.0: PCI bridge to [bus 02] Jan 20 22:00:52 volumio kernel: pci 0000:03:00.0: [10ec:8168] type 00 class 0x020000 Jan 20 22:00:52 volumio kernel: pci 0000:03:00.0: reg 0x10: [io 0xe000-0xe0ff] Jan 20 22:00:52 volumio kernel: pci 0000:03:00.0: reg 0x18: [mem 0xd0004000-0xd0004fff 64bit pref] Jan 20 22:00:52 volumio kernel: pci 0000:03:00.0: reg 0x20: [mem 0xd0000000-0xd0003fff 64bit pref] Jan 20 22:00:52 volumio kernel: pci 0000:03:00.0: supports D1 D2 Jan 20 22:00:52 volumio kernel: pci 0000:03:00.0: PME# supported from D0 D1 D2 D3hot D3cold Jan 20 22:00:52 volumio kernel: pci 0000:00:15.1: PCI bridge to [bus 03] Jan 20 22:00:52 volumio kernel: pci 0000:00:15.1: bridge window [io 0xe000-0xefff] Jan 20 22:00:52 volumio kernel: pci 0000:00:15.1: bridge window [mem 0xd0000000-0xd00fffff 64bit pref] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: on NUMA node 0 Jan 20 22:00:52 volumio kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 0 Jan 20 22:00:52 volumio kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 0 Jan 20 22:00:52 volumio kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 0 Jan 20 22:00:52 volumio kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 0 Jan 20 22:00:52 volumio kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 0 Jan 20 22:00:52 volumio kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 0 Jan 20 22:00:52 volumio kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 0 Jan 20 22:00:52 volumio kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 0 Jan 20 22:00:52 volumio kernel: iommu: Default domain type: Translated Jan 20 22:00:52 volumio kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jan 20 22:00:52 volumio kernel: SCSI subsystem initialized Jan 20 22:00:52 volumio kernel: libata version 3.00 loaded. Jan 20 22:00:52 volumio kernel: ACPI: bus type USB registered Jan 20 22:00:52 volumio kernel: usbcore: registered new interface driver usbfs Jan 20 22:00:52 volumio kernel: usbcore: registered new interface driver hub Jan 20 22:00:52 volumio kernel: usbcore: registered new device driver usb Jan 20 22:00:52 volumio kernel: efivars: Registered efivars operations Jan 20 22:00:52 volumio kernel: PCI: Using ACPI for IRQ routing Jan 20 22:00:52 volumio kernel: PCI: pci_cache_line_size set to 64 bytes Jan 20 22:00:52 volumio kernel: e820: reserve RAM buffer [mem 0x8db12000-0x8fffffff] Jan 20 22:00:52 volumio kernel: e820: reserve RAM buffer [mem 0x8e623000-0x8fffffff] Jan 20 22:00:52 volumio kernel: e820: reserve RAM buffer [mem 0x8ec58000-0x8fffffff] Jan 20 22:00:52 volumio kernel: e820: reserve RAM buffer [mem 0x8f000000-0x8fffffff] Jan 20 22:00:52 volumio kernel: e820: reserve RAM buffer [mem 0x43f000000-0x43fffffff] Jan 20 22:00:52 volumio kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jan 20 22:00:52 volumio kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jan 20 22:00:52 volumio kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jan 20 22:00:52 volumio kernel: vgaarb: loaded Jan 20 22:00:52 volumio kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jan 20 22:00:52 volumio kernel: hpet0: 3 comparators, 32-bit 14.318180 MHz counter Jan 20 22:00:52 volumio kernel: clocksource: Switched to clocksource tsc-early Jan 20 22:00:52 volumio kernel: VFS: Disk quotas dquot_6.6.0 Jan 20 22:00:52 volumio kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 20 22:00:52 volumio kernel: pnp: PnP ACPI init Jan 20 22:00:52 volumio kernel: system 00:00: [mem 0xe0000000-0xefffffff] has been reserved Jan 20 22:00:52 volumio kernel: system 00:01: [mem 0x90000000-0xbfffffff] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x04d0-0x04d1] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x040b] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x04d6] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0c00-0x0c01] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0c14] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0c50-0x0c51] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0c52] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0c6c] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0c6f] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0cd0-0x0cd1] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0cd2-0x0cd3] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0cd4-0x0cd5] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0cd6-0x0cd7] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0cd8-0x0cdf] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0800-0x089f] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0b20-0x0b3f] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0900-0x090f] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0x0910-0x091f] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [io 0xfe00-0xfefe] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [mem 0xfec00000-0xfec00fff] could not be reserved Jan 20 22:00:52 volumio kernel: system 00:03: [mem 0xfee00000-0xfee00fff] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [mem 0xfed80000-0xfed8ffff] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [mem 0xfed61000-0xfed70fff] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [mem 0xfec10000-0xfec10fff] has been reserved Jan 20 22:00:52 volumio kernel: system 00:03: [mem 0xfed00000-0xfed00fff] could not be reserved Jan 20 22:00:52 volumio kernel: system 00:03: [mem 0xff000000-0xffffffff] has been reserved Jan 20 22:00:52 volumio kernel: system 00:04: [io 0x0300-0x031f] has been reserved Jan 20 22:00:52 volumio kernel: system 00:04: [io 0x0290-0x029f] has been reserved Jan 20 22:00:52 volumio kernel: system 00:04: [io 0x0230-0x023f] has been reserved Jan 20 22:00:52 volumio kernel: pnp 00:05: [dma 0 disabled] Jan 20 22:00:52 volumio kernel: system 00:07: [io 0x04d0-0x04d1] has been reserved Jan 20 22:00:52 volumio kernel: pnp 00:09: [dma 0 disabled] Jan 20 22:00:52 volumio kernel: pnp: PnP ACPI: found 10 devices Jan 20 22:00:52 volumio kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jan 20 22:00:52 volumio kernel: NET: Registered PF_INET protocol family Jan 20 22:00:52 volumio kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 20 22:00:52 volumio kernel: tcp_listen_portaddr_hash hash table entries: 8192 (order: 5, 131072 bytes, linear) Jan 20 22:00:52 volumio kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 20 22:00:52 volumio kernel: TCP established hash table entries: 131072 (order: 8, 1048576 bytes, linear) Jan 20 22:00:52 volumio kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Jan 20 22:00:52 volumio kernel: TCP: Hash tables configured (established 131072 bind 65536) Jan 20 22:00:52 volumio kernel: UDP hash table entries: 8192 (order: 6, 262144 bytes, linear) Jan 20 22:00:52 volumio kernel: UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes, linear) Jan 20 22:00:52 volumio kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 20 22:00:52 volumio kernel: pci 0000:00:14.4: PCI bridge to [bus 01] Jan 20 22:00:52 volumio kernel: pci 0000:00:15.0: PCI bridge to [bus 02] Jan 20 22:00:52 volumio kernel: pci 0000:00:15.1: PCI bridge to [bus 03] Jan 20 22:00:52 volumio kernel: pci 0000:00:15.1: bridge window [io 0xe000-0xefff] Jan 20 22:00:52 volumio kernel: pci 0000:00:15.1: bridge window [mem 0xd0000000-0xd00fffff 64bit pref] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x03af window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: resource 5 [io 0x03e0-0x0cf7 window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: resource 6 [io 0x03b0-0x03df window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: resource 7 [io 0x0d00-0xffff window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: resource 8 [mem 0x000a0000-0x000dffff window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:00: resource 9 [mem 0xc0000000-0xffffffff window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:01: resource 4 [io 0x0000-0x03af window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:01: resource 5 [io 0x03e0-0x0cf7 window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:01: resource 6 [io 0x03b0-0x03df window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:01: resource 7 [io 0x0d00-0xffff window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:01: resource 8 [mem 0x000a0000-0x000dffff window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:01: resource 9 [mem 0xc0000000-0xffffffff window] Jan 20 22:00:52 volumio kernel: pci_bus 0000:03: resource 0 [io 0xe000-0xefff] Jan 20 22:00:52 volumio kernel: pci_bus 0000:03: resource 2 [mem 0xd0000000-0xd00fffff 64bit pref] Jan 20 22:00:52 volumio kernel: pci 0000:00:01.1: D0 power state depends on 0000:00:01.0 Jan 20 22:00:52 volumio kernel: pci 0000:00:12.0: quirk_usb_early_handoff+0x0/0x770 took 30814 usecs Jan 20 22:00:52 volumio kernel: pci 0000:00:12.2: PME# does not work under D3, disabling it Jan 20 22:00:52 volumio kernel: pci 0000:00:13.0: quirk_usb_early_handoff+0x0/0x770 took 31083 usecs Jan 20 22:00:52 volumio kernel: pci 0000:00:13.2: PME# does not work under D3, disabling it Jan 20 22:00:52 volumio kernel: PCI: CLS 64 bytes, default 64 Jan 20 22:00:52 volumio kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Jan 20 22:00:52 volumio kernel: software IO TLB: mapped [mem 0x000000007ced5000-0x0000000080ed5000] (64MB) Jan 20 22:00:52 volumio kernel: LVT offset 0 assigned for vector 0x400 Jan 20 22:00:52 volumio kernel: Trying to unpack rootfs image as initramfs... Jan 20 22:00:52 volumio kernel: perf: AMD IBS detected (0x000000ff) Jan 20 22:00:52 volumio kernel: amd_uncore: 4 amd_nb counters detected Jan 20 22:00:52 volumio kernel: Initialise system trusted keyrings Jan 20 22:00:52 volumio kernel: workingset: timestamp_bits=46 max_order=22 bucket_order=0 Jan 20 22:00:52 volumio kernel: zbud: loaded Jan 20 22:00:52 volumio kernel: Key type asymmetric registered Jan 20 22:00:52 volumio kernel: Asymmetric key parser 'x509' registered Jan 20 22:00:52 volumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) Jan 20 22:00:52 volumio kernel: io scheduler mq-deadline registered Jan 20 22:00:52 volumio kernel: io scheduler kyber registered Jan 20 22:00:52 volumio kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Jan 20 22:00:52 volumio kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jan 20 22:00:52 volumio kernel: ACPI: button: Power Button [PWRB] Jan 20 22:00:52 volumio kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1 Jan 20 22:00:52 volumio kernel: ACPI: button: Power Button [PWRF] Jan 20 22:00:52 volumio kernel: ACPI: \_PR_.P000: Found 2 idle states Jan 20 22:00:52 volumio kernel: ACPI: \_PR_.P001: Found 2 idle states Jan 20 22:00:52 volumio kernel: ACPI: \_PR_.P002: Found 2 idle states Jan 20 22:00:52 volumio kernel: ACPI: \_PR_.P003: Found 2 idle states Jan 20 22:00:52 volumio kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Jan 20 22:00:52 volumio kernel: 00:09: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jan 20 22:00:52 volumio kernel: Linux agpgart interface v0.103 Jan 20 22:00:52 volumio kernel: QUIRK: Enable AMD PLL fix Jan 20 22:00:52 volumio kernel: ohci-pci 0000:00:12.0: OHCI PCI host controller Jan 20 22:00:52 volumio kernel: ohci-pci 0000:00:12.0: new USB bus registered, assigned bus number 1 Jan 20 22:00:52 volumio kernel: ohci-pci 0000:00:12.0: irq 18, io mem 0xfef4f000 Jan 20 22:00:52 volumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.06 Jan 20 22:00:52 volumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:00:52 volumio kernel: usb usb1: Product: OHCI PCI host controller Jan 20 22:00:52 volumio kernel: usb usb1: Manufacturer: Linux 6.6.32-volumio ohci_hcd Jan 20 22:00:52 volumio kernel: usb usb1: SerialNumber: 0000:00:12.0 Jan 20 22:00:52 volumio kernel: hub 1-0:1.0: USB hub found Jan 20 22:00:52 volumio kernel: hub 1-0:1.0: 5 ports detected Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:13.2: EHCI Host Controller Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:13.2: new USB bus registered, assigned bus number 2 Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:13.2: applying AMD SB700/SB800/Hudson-2/3 EHCI dummy qh workaround Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:13.2: debug port 1 Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:13.2: irq 17, io mem 0xfef4c000 Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:13.2: USB 2.0 started, EHCI 1.00 Jan 20 22:00:52 volumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Jan 20 22:00:52 volumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:00:52 volumio kernel: usb usb2: Product: EHCI Host Controller Jan 20 22:00:52 volumio kernel: usb usb2: Manufacturer: Linux 6.6.32-volumio ehci_hcd Jan 20 22:00:52 volumio kernel: usb usb2: SerialNumber: 0000:00:13.2 Jan 20 22:00:52 volumio kernel: hub 2-0:1.0: USB hub found Jan 20 22:00:52 volumio kernel: hub 2-0:1.0: 5 ports detected Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:12.2: EHCI Host Controller Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:12.2: new USB bus registered, assigned bus number 3 Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:12.2: applying AMD SB700/SB800/Hudson-2/3 EHCI dummy qh workaround Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:12.2: debug port 1 Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:12.2: irq 17, io mem 0xfef4e000 Jan 20 22:00:52 volumio kernel: ehci-pci 0000:00:12.2: USB 2.0 started, EHCI 1.00 Jan 20 22:00:52 volumio kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Jan 20 22:00:52 volumio kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:00:52 volumio kernel: usb usb3: Product: EHCI Host Controller Jan 20 22:00:52 volumio kernel: usb usb3: Manufacturer: Linux 6.6.32-volumio ehci_hcd Jan 20 22:00:52 volumio kernel: usb usb3: SerialNumber: 0000:00:12.2 Jan 20 22:00:52 volumio kernel: hub 3-0:1.0: USB hub found Jan 20 22:00:52 volumio kernel: hub 3-0:1.0: 5 ports detected Jan 20 22:00:52 volumio kernel: hub 1-0:1.0: USB hub found Jan 20 22:00:52 volumio kernel: hub 1-0:1.0: 5 ports detected Jan 20 22:00:52 volumio kernel: ohci-pci 0000:00:13.0: OHCI PCI host controller Jan 20 22:00:52 volumio kernel: ohci-pci 0000:00:13.0: new USB bus registered, assigned bus number 4 Jan 20 22:00:52 volumio kernel: ohci-pci 0000:00:13.0: irq 18, io mem 0xfef4d000 Jan 20 22:00:52 volumio kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.06 Jan 20 22:00:52 volumio kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:00:52 volumio kernel: usb usb4: Product: OHCI PCI host controller Jan 20 22:00:52 volumio kernel: usb usb4: Manufacturer: Linux 6.6.32-volumio ohci_hcd Jan 20 22:00:52 volumio kernel: usb usb4: SerialNumber: 0000:00:13.0 Jan 20 22:00:52 volumio kernel: hub 4-0:1.0: USB hub found Jan 20 22:00:52 volumio kernel: hub 4-0:1.0: 5 ports detected Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.0: xHCI Host Controller Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.0: new USB bus registered, assigned bus number 5 Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.0: hcc params 0x014042c3 hci version 0x96 quirks 0x0000000000000608 Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.0: xHCI Host Controller Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.0: new USB bus registered, assigned bus number 6 Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.0: Host supports USB 3.0 SuperSpeed Jan 20 22:00:52 volumio kernel: usb usb5: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Jan 20 22:00:52 volumio kernel: usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:00:52 volumio kernel: usb usb5: Product: xHCI Host Controller Jan 20 22:00:52 volumio kernel: usb usb5: Manufacturer: Linux 6.6.32-volumio xhci-hcd Jan 20 22:00:52 volumio kernel: usb usb5: SerialNumber: 0000:00:10.0 Jan 20 22:00:52 volumio kernel: hub 5-0:1.0: USB hub found Jan 20 22:00:52 volumio kernel: hub 5-0:1.0: 2 ports detected Jan 20 22:00:52 volumio kernel: usb usb6: We don't know the algorithms for LPM for this host, disabling LPM. Jan 20 22:00:52 volumio kernel: usb usb6: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Jan 20 22:00:52 volumio kernel: usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:00:52 volumio kernel: usb usb6: Product: xHCI Host Controller Jan 20 22:00:52 volumio kernel: usb usb6: Manufacturer: Linux 6.6.32-volumio xhci-hcd Jan 20 22:00:52 volumio kernel: usb usb6: SerialNumber: 0000:00:10.0 Jan 20 22:00:52 volumio kernel: hub 6-0:1.0: USB hub found Jan 20 22:00:52 volumio kernel: hub 6-0:1.0: 2 ports detected Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.1: xHCI Host Controller Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.1: new USB bus registered, assigned bus number 7 Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.1: hcc params 0x014042c3 hci version 0x96 quirks 0x0000000000000608 Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.1: xHCI Host Controller Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.1: new USB bus registered, assigned bus number 8 Jan 20 22:00:52 volumio kernel: xhci_hcd 0000:00:10.1: Host supports USB 3.0 SuperSpeed Jan 20 22:00:52 volumio kernel: usb usb7: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Jan 20 22:00:52 volumio kernel: usb usb7: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:00:52 volumio kernel: usb usb7: Product: xHCI Host Controller Jan 20 22:00:52 volumio kernel: usb usb7: Manufacturer: Linux 6.6.32-volumio xhci-hcd Jan 20 22:00:52 volumio kernel: usb usb7: SerialNumber: 0000:00:10.1 Jan 20 22:00:52 volumio kernel: hub 7-0:1.0: USB hub found Jan 20 22:00:52 volumio kernel: hub 7-0:1.0: 2 ports detected Jan 20 22:00:52 volumio kernel: usb usb8: We don't know the algorithms for LPM for this host, disabling LPM. Jan 20 22:00:52 volumio kernel: usb usb8: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Jan 20 22:00:52 volumio kernel: usb usb8: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:00:52 volumio kernel: usb usb8: Product: xHCI Host Controller Jan 20 22:00:52 volumio kernel: usb usb8: Manufacturer: Linux 6.6.32-volumio xhci-hcd Jan 20 22:00:52 volumio kernel: usb usb8: SerialNumber: 0000:00:10.1 Jan 20 22:00:52 volumio kernel: hub 8-0:1.0: USB hub found Jan 20 22:00:52 volumio kernel: hub 8-0:1.0: 2 ports detected Jan 20 22:00:52 volumio kernel: i8042: PNP: No PS/2 controller found. Jan 20 22:00:52 volumio kernel: mousedev: PS/2 mouse device common for all mice Jan 20 22:00:52 volumio kernel: rtc_cmos 00:06: RTC can wake from S4 Jan 20 22:00:52 volumio kernel: rtc_cmos 00:06: registered as rtc0 Jan 20 22:00:52 volumio kernel: rtc_cmos 00:06: setting system clock to 2025-01-20T15:00:36 UTC (1737385236) Jan 20 22:00:52 volumio kernel: rtc_cmos 00:06: alarms up to one month, y3k, 114 bytes nvram, hpet irqs Jan 20 22:00:52 volumio kernel: i2c_dev: i2c /dev entries driver Jan 20 22:00:52 volumio kernel: platform eisa.0: Probing EISA bus 0 Jan 20 22:00:52 volumio kernel: platform eisa.0: EISA: Cannot allocate resource for mainboard Jan 20 22:00:52 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs Jan 20 22:00:52 volumio kernel: efifb: probing for efifb Jan 20 22:00:52 volumio kernel: efifb: framebuffer at 0xc0000000, using 3072k, total 3072k Jan 20 22:00:52 volumio kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Jan 20 22:00:52 volumio kernel: efifb: scrolling: redraw Jan 20 22:00:52 volumio kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jan 20 22:00:52 volumio kernel: Console: switching to colour frame buffer device 128x48 Jan 20 22:00:52 volumio kernel: fb0: EFI VGA frame buffer device Jan 20 22:00:52 volumio kernel: NET: Registered PF_INET6 protocol family Jan 20 22:00:52 volumio kernel: Segment Routing with IPv6 Jan 20 22:00:52 volumio kernel: In-situ OAM (IOAM) with IPv6 Jan 20 22:00:52 volumio kernel: mip6: Mobile IPv6 Jan 20 22:00:52 volumio kernel: NET: Registered PF_PACKET protocol family Jan 20 22:00:52 volumio kernel: mpls_gso: MPLS GSO support Jan 20 22:00:52 volumio kernel: x86/pm: family 0x15 cpu detected, MSR saving is needed during suspending. Jan 20 22:00:52 volumio kernel: microcode: CPU3: patch_level=0x06001119 Jan 20 22:00:52 volumio kernel: microcode: CPU0: patch_level=0x06001119 Jan 20 22:00:52 volumio kernel: microcode: CPU1: patch_level=0x06001119 Jan 20 22:00:52 volumio kernel: microcode: CPU2: patch_level=0x06001119 Jan 20 22:00:52 volumio kernel: microcode: Microcode Update Driver: v2.2. Jan 20 22:00:52 volumio kernel: IPI shorthand broadcast: enabled Jan 20 22:00:52 volumio kernel: sched_clock: Marking stable (748084089, 147346)->(767948495, -19717060) Jan 20 22:00:52 volumio kernel: Loading compiled-in X.509 certificates Jan 20 22:00:52 volumio kernel: acpi_cpufreq: overriding BIOS provided _PSD data Jan 20 22:00:52 volumio kernel: clk: Disabling unused clocks Jan 20 22:00:52 volumio kernel: usb 5-2: new high-speed USB device number 2 using xhci_hcd Jan 20 22:00:52 volumio kernel: usb 5-2: New USB device found, idVendor=3353, idProduct=a004, bcdDevice= 1.23 Jan 20 22:00:52 volumio kernel: usb 5-2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jan 20 22:00:52 volumio kernel: usb 5-2: Product: Tone2 Jan 20 22:00:52 volumio kernel: usb 5-2: Manufacturer: Khadas Jan 20 22:00:52 volumio kernel: usb 5-2: SerialNumber: 2AA3022A Jan 20 22:00:52 volumio kernel: Freeing initrd memory: 68112K Jan 20 22:00:52 volumio kernel: Freeing unused kernel image (initmem) memory: 2988K Jan 20 22:00:52 volumio kernel: Write protecting the kernel read-only data: 20480k Jan 20 22:00:52 volumio kernel: Freeing unused kernel image (rodata/data gap) memory: 1504K Jan 20 22:00:52 volumio kernel: Run /init as init process Jan 20 22:00:52 volumio kernel: with arguments: Jan 20 22:00:52 volumio kernel: /init Jan 20 22:00:52 volumio kernel: splash Jan 20 22:00:52 volumio kernel: with environment: Jan 20 22:00:52 volumio kernel: HOME=/ Jan 20 22:00:52 volumio kernel: TERM=linux Jan 20 22:00:52 volumio kernel: BOOT_IMAGE=/vmlinuz Jan 20 22:00:52 volumio kernel: biosdevname=0 Jan 20 22:00:52 volumio kernel: imgpart=UUID=3f028649-eecb-444a-b737-1c6582e1c917 Jan 20 22:00:52 volumio kernel: bootpart=UUID=6B5A-4D5C Jan 20 22:00:52 volumio kernel: datapart=UUID=297d87e1-ef5b-446f-8570-1df41617e746 Jan 20 22:00:52 volumio kernel: hwdevice=x86 Jan 20 22:00:52 volumio kernel: uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg Jan 20 22:00:52 volumio kernel: imgfile=/volumio_current.sqsh Jan 20 22:00:52 volumio kernel: use_kmsg=no Jan 20 22:00:52 volumio kernel: piix4_smbus 0000:00:14.0: SMBus Host Controller at 0xb00, revision 0 Jan 20 22:00:52 volumio kernel: piix4_smbus 0000:00:14.0: Using register 0x2e for SMBus port selection Jan 20 22:00:52 volumio kernel: ahci 0000:00:11.0: version 3.0 Jan 20 22:00:52 volumio kernel: ahci 0000:00:11.0: AHCI 0001.0300 32 slots 8 ports 6 Gbps 0xff impl SATA mode Jan 20 22:00:52 volumio kernel: ahci 0000:00:11.0: flags: 64bit ncq sntf ilck pm led clo pmp pio sxs Jan 20 22:00:52 volumio kernel: piix4_smbus 0000:00:14.0: Auxiliary SMBus Host Controller at 0xb20 Jan 20 22:00:52 volumio kernel: scsi host0: ahci Jan 20 22:00:52 volumio kernel: hid: raw HID events driver (C) Jiri Kosina Jan 20 22:00:52 volumio kernel: ACPI: bus type drm_connector registered Jan 20 22:00:52 volumio kernel: scsi host1: ahci Jan 20 22:00:52 volumio kernel: usbcore: registered new interface driver usbhid Jan 20 22:00:52 volumio kernel: usbhid: USB HID core driver Jan 20 22:00:52 volumio kernel: scsi host2: ahci Jan 20 22:00:52 volumio kernel: scsi host3: ahci Jan 20 22:00:52 volumio kernel: scsi host4: ahci Jan 20 22:00:52 volumio kernel: scsi host5: ahci Jan 20 22:00:52 volumio kernel: input: Khadas Tone2 as /devices/pci0000:00/0000:00:10.0/usb5/5-2/5-2:1.3/0003:3353:A004.0001/input/input2 Jan 20 22:00:52 volumio kernel: scsi host6: ahci Jan 20 22:00:52 volumio kernel: scsi host7: ahci Jan 20 22:00:52 volumio kernel: ata1: SATA max UDMA/133 abar m2048@0xfef50000 port 0xfef50100 irq 36 Jan 20 22:00:52 volumio kernel: ata2: SATA max UDMA/133 abar m2048@0xfef50000 port 0xfef50180 irq 36 Jan 20 22:00:52 volumio kernel: ata3: SATA max UDMA/133 abar m2048@0xfef50000 port 0xfef50200 irq 36 Jan 20 22:00:52 volumio kernel: ata4: SATA max UDMA/133 abar m2048@0xfef50000 port 0xfef50280 irq 36 Jan 20 22:00:52 volumio kernel: ata5: SATA max UDMA/133 abar m2048@0xfef50000 port 0xfef50300 irq 36 Jan 20 22:00:52 volumio kernel: ata6: SATA max UDMA/133 abar m2048@0xfef50000 port 0xfef50380 irq 36 Jan 20 22:00:52 volumio kernel: ata7: SATA max UDMA/133 abar m2048@0xfef50000 port 0xfef50400 irq 36 Jan 20 22:00:52 volumio kernel: ata8: SATA max UDMA/133 abar m2048@0xfef50000 port 0xfef50480 irq 36 Jan 20 22:00:52 volumio kernel: tsc: Refined TSC clocksource calibration: 3818.997 MHz Jan 20 22:00:52 volumio kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x6e18e4af21c, max_idle_ns: 881590542384 ns Jan 20 22:00:52 volumio kernel: clocksource: Switched to clocksource tsc Jan 20 22:00:52 volumio kernel: r8169 0000:03:00.0 eth0: RTL8168f/8111f, 08:60:6e:6c:a0:50, XID 480, IRQ 37 Jan 20 22:00:52 volumio kernel: r8169 0000:03:00.0 eth0: jumbo features [frames: 9194 bytes, tx checksumming: ko] Jan 20 22:00:52 volumio kernel: hid-generic 0003:3353:A004.0001: input,hidraw0: USB HID v1.10 Device [Khadas Tone2] on usb-0000:00:10.0-2/input3 Jan 20 22:00:52 volumio kernel: [drm] radeon kernel modesetting enabled. Jan 20 22:00:52 volumio kernel: Console: switching to colour dummy device 80x25 Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: vgaarb: deactivate vga console Jan 20 22:00:52 volumio kernel: [drm] initializing kernel modesetting (ARUBA 0x1002:0x9901 0x1043:0x8526 0x00). Jan 20 22:00:52 volumio kernel: ATOM BIOS: 113 Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: VRAM: 768M 0x0000000000000000 - 0x000000002FFFFFFF (768M used) Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: GTT: 1024M 0x0000000030000000 - 0x000000006FFFFFFF Jan 20 22:00:52 volumio kernel: [drm] Detected VRAM RAM=768M, BAR=256M Jan 20 22:00:52 volumio kernel: [drm] RAM width 64bits DDR Jan 20 22:00:52 volumio kernel: [drm] radeon: 768M of VRAM memory ready Jan 20 22:00:52 volumio kernel: [drm] radeon: 1024M of GTT memory ready. Jan 20 22:00:52 volumio kernel: [drm] Loading ARUBA Microcode Jan 20 22:00:52 volumio kernel: [drm] Internal thermal controller without fan control Jan 20 22:00:52 volumio kernel: [drm] radeon: dpm initialized Jan 20 22:00:52 volumio kernel: [drm] Found VCE firmware/feedback version 50.0.1 / 17! Jan 20 22:00:52 volumio kernel: [drm] GART: num cpu pages 262144, num gpu pages 262144 Jan 20 22:00:52 volumio kernel: ata3: SATA link down (SStatus 0 SControl 300) Jan 20 22:00:52 volumio kernel: ata4: SATA link down (SStatus 0 SControl 300) Jan 20 22:00:52 volumio kernel: ata6: SATA link down (SStatus 0 SControl 300) Jan 20 22:00:52 volumio kernel: ata7: SATA link down (SStatus 0 SControl 300) Jan 20 22:00:52 volumio kernel: ata8: SATA link down (SStatus 0 SControl 300) Jan 20 22:00:52 volumio kernel: ata1: SATA link down (SStatus 0 SControl 300) Jan 20 22:00:52 volumio kernel: ata2: SATA link down (SStatus 0 SControl 300) Jan 20 22:00:52 volumio kernel: [drm] PCIE GART of 1024M enabled (table at 0x00000000001D6000). Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: WB enabled Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: fence driver on ring 0 use gpu addr 0x0000000030000c00 Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: fence driver on ring 5 use gpu addr 0x0000000000075a18 Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: fence driver on ring 6 use gpu addr 0x0000000030000c18 Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: fence driver on ring 7 use gpu addr 0x0000000030000c1c Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: fence driver on ring 1 use gpu addr 0x0000000030000c04 Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: fence driver on ring 2 use gpu addr 0x0000000030000c08 Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: fence driver on ring 3 use gpu addr 0x0000000030000c0c Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: fence driver on ring 4 use gpu addr 0x0000000030000c10 Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: radeon: MSI limited to 32-bit Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: radeon: using MSI. Jan 20 22:00:52 volumio kernel: [drm] radeon: irq initialized. Jan 20 22:00:52 volumio kernel: [drm] ring test on 0 succeeded in 3 usecs Jan 20 22:00:52 volumio kernel: [drm] ring test on 3 succeeded in 3 usecs Jan 20 22:00:52 volumio kernel: [drm] ring test on 4 succeeded in 3 usecs Jan 20 22:00:52 volumio kernel: [drm] ring test on 5 succeeded in 1 usecs Jan 20 22:00:52 volumio kernel: [drm] UVD initialized successfully. Jan 20 22:00:52 volumio kernel: ata5: SATA link up 6.0 Gbps (SStatus 133 SControl 300) Jan 20 22:00:52 volumio kernel: ata5.00: ATA-8: KINGSTON SH103S3240G, 541ABBF0, max UDMA/133 Jan 20 22:00:52 volumio kernel: ata5.00: 468862128 sectors, multi 1: LBA48 NCQ (depth 32), AA Jan 20 22:00:52 volumio kernel: ata5.00: configured for UDMA/133 Jan 20 22:00:52 volumio kernel: scsi 4:0:0:0: Direct-Access ATA KINGSTON SH103S3 BBF0 PQ: 0 ANSI: 5 Jan 20 22:00:52 volumio kernel: sd 4:0:0:0: [sda] 468862128 512-byte logical blocks: (240 GB/224 GiB) Jan 20 22:00:52 volumio kernel: sd 4:0:0:0: [sda] Write Protect is off Jan 20 22:00:52 volumio kernel: sd 4:0:0:0: [sda] Mode Sense: 00 3a 00 00 Jan 20 22:00:52 volumio kernel: sd 4:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jan 20 22:00:52 volumio kernel: sd 4:0:0:0: [sda] Preferred minimum I/O size 512 bytes Jan 20 22:00:52 volumio kernel: sda: sda1 sda2 sda3 sda4 Jan 20 22:00:52 volumio kernel: sd 4:0:0:0: [sda] Attached SCSI disk Jan 20 22:00:52 volumio kernel: [drm] ring test on 6 succeeded in 18 usecs Jan 20 22:00:52 volumio kernel: [drm] ring test on 7 succeeded in 3 usecs Jan 20 22:00:52 volumio kernel: [drm] VCE initialized successfully. Jan 20 22:00:52 volumio kernel: [drm] ib test on ring 0 succeeded in 0 usecs Jan 20 22:00:52 volumio kernel: [drm] ib test on ring 3 succeeded in 0 usecs Jan 20 22:00:52 volumio kernel: [drm] ib test on ring 4 succeeded in 0 usecs Jan 20 22:00:52 volumio kernel: [drm] ib test on ring 5 succeeded Jan 20 22:00:52 volumio kernel: [drm] ib test on ring 6 succeeded Jan 20 22:00:52 volumio kernel: [drm] ib test on ring 7 succeeded Jan 20 22:00:52 volumio kernel: [drm] Radeon Display Connectors Jan 20 22:00:52 volumio kernel: [drm] Connector 0: Jan 20 22:00:52 volumio kernel: [drm] HDMI-A-1 Jan 20 22:00:52 volumio kernel: [drm] HPD1 Jan 20 22:00:52 volumio kernel: [drm] DDC: 0x6530 0x6530 0x6534 0x6534 0x6538 0x6538 0x653c 0x653c Jan 20 22:00:52 volumio kernel: [drm] Encoders: Jan 20 22:00:52 volumio kernel: [drm] DFP1: INTERNAL_UNIPHY2 Jan 20 22:00:52 volumio kernel: [drm] Connector 1: Jan 20 22:00:52 volumio kernel: [drm] VGA-1 Jan 20 22:00:52 volumio kernel: [drm] HPD2 Jan 20 22:00:52 volumio kernel: [drm] DDC: 0x6540 0x6540 0x6544 0x6544 0x6548 0x6548 0x654c 0x654c Jan 20 22:00:52 volumio kernel: [drm] Encoders: Jan 20 22:00:52 volumio kernel: [drm] CRT1: INTERNAL_UNIPHY2 Jan 20 22:00:52 volumio kernel: [drm] CRT1: NUTMEG Jan 20 22:00:52 volumio kernel: [drm] Connector 2: Jan 20 22:00:52 volumio kernel: [drm] DVI-D-1 Jan 20 22:00:52 volumio kernel: [drm] HPD3 Jan 20 22:00:52 volumio kernel: [drm] DDC: 0x6550 0x6550 0x6554 0x6554 0x6558 0x6558 0x655c 0x655c Jan 20 22:00:52 volumio kernel: [drm] Encoders: Jan 20 22:00:52 volumio kernel: [drm] DFP2: INTERNAL_UNIPHY Jan 20 22:00:52 volumio kernel: [drm] Initialized radeon 2.50.0 20080528 for 0000:00:01.0 on minor 0 Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: [drm] Cannot find any crtc or sizes Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: [drm] Cannot find any crtc or sizes Jan 20 22:00:52 volumio kernel: radeon 0000:00:01.0: [drm] Cannot find any crtc or sizes Jan 20 22:00:52 volumio kernel: [drm] amdgpu kernel modesetting enabled. Jan 20 22:00:52 volumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 20 22:00:52 volumio kernel: sdhci: Secure Digital Host Controller Interface driver Jan 20 22:00:52 volumio kernel: sdhci: Copyright(c) Pierre Ossman Jan 20 22:00:52 volumio kernel: fuse: init (API version 7.39) Jan 20 22:00:52 volumio kernel: usbcore: registered new interface driver usb-storage Jan 20 22:00:52 volumio kernel: usbcore: registered new interface driver uas Jan 20 22:00:52 volumio kernel: scsi host8: pata_legacy Jan 20 22:00:52 volumio kernel: ata9: PATA max PIO4 cmd 0x1f0 ctl 0x3f6 irq 14 Jan 20 22:00:52 volumio kernel: scsi host8: pata_legacy Jan 20 22:00:52 volumio kernel: ata10: PATA max PIO4 cmd 0x170 ctl 0x376 irq 15 Jan 20 22:00:52 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jan 20 22:00:52 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jan 20 22:00:52 volumio kernel: EXT4-fs (sda2): recovery complete Jan 20 22:00:52 volumio kernel: EXT4-fs (sda2): mounted filesystem 3f028649-eecb-444a-b737-1c6582e1c917 r/w with ordered data mode. Quota mode: none. Jan 20 22:00:52 volumio kernel: loop: module loaded Jan 20 22:00:52 volumio kernel: block device autoloading is deprecated and will be removed. Jan 20 22:00:52 volumio kernel: loop0: detected capacity change from 0 to 1725144 Jan 20 22:00:52 volumio kernel: EXT4-fs (sda3): recovery complete Jan 20 22:00:52 volumio kernel: EXT4-fs (sda3): mounted filesystem 297d87e1-ef5b-446f-8570-1df41617e746 r/w with ordered data mode. Quota mode: none. Jan 20 22:00:52 volumio systemd[1]: Inserted module 'autofs4' Jan 20 22:00:52 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) Jan 20 22:00:52 volumio systemd[1]: Detected architecture x86-64. Jan 20 22:00:52 volumio systemd[1]: Set hostname to . Jan 20 22:00:52 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. Jan 20 22:00:52 volumio systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Jan 20 22:00:52 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. Jan 20 22:00:52 volumio kernel: random: crng init done Jan 20 22:00:52 volumio systemd[1]: Started Forward Password Requests to Wall Directory Watch. Jan 20 22:00:52 volumio systemd[1]: Reached target System Time Synchronized. Jan 20 22:00:52 volumio systemd[1]: Listening on Journal Socket (/dev/log). Jan 20 22:00:52 volumio systemd[1]: Listening on udev Control Socket. Jan 20 22:00:52 volumio systemd-journald[496]: Journal started Jan 20 22:00:52 volumio systemd-journald[496]: Runtime journal (/run/log/journal/724bcbf01eebf9d6210f389b672e577a) is 3.7M, max 30.0M, 26.2M free. Jan 20 22:00:52 volumio fake-hwclock[498]: Current system time: 2025-01-20 15:00:52 Jan 20 22:00:52 volumio fake-hwclock[498]: fake-hwclock saved clock information is in the past: 2025-01-16 15:10:53 Jan 20 22:00:52 volumio fake-hwclock[498]: To set system time to this saved clock anyway, use "force" Jan 20 22:00:52 volumio systemd[1]: Started Load/Save Random Seed. Jan 20 22:00:52 volumio systemd[1]: Started Create System Users. Jan 20 22:00:52 volumio systemd[1]: Starting Create Static Device Nodes in /dev... Jan 20 22:00:52 volumio kernel: RPC: Registered named UNIX socket transport module. Jan 20 22:00:52 volumio kernel: RPC: Registered udp transport module. Jan 20 22:00:52 volumio kernel: RPC: Registered tcp transport module. Jan 20 22:00:52 volumio kernel: RPC: Registered tcp-with-tls transport module. Jan 20 22:00:52 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jan 20 22:00:52 volumio systemd[1]: Mounted RPC Pipe File System. Jan 20 22:00:52 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:00:52 volumio systemd[1]: Started udev Coldplug all Devices. Jan 20 22:00:52 volumio systemd[1]: Started Create Static Device Nodes in /dev. Jan 20 22:00:52 volumio systemd[1]: Starting udev Kernel Device Manager... Jan 20 22:00:52 volumio systemd[1]: Reached target Local File Systems (Pre). Jan 20 22:00:52 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jan 20 22:00:52 volumio systemd[1]: Mounting /var/log... Jan 20 22:00:52 volumio systemd[1]: Mounting /var/spool/cups... Jan 20 22:00:52 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jan 20 22:00:52 volumio systemd[1]: Mounting /tmp... Jan 20 22:00:52 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown... Jan 20 22:00:52 volumio systemd[1]: Mounted /var/log. Jan 20 22:00:52 volumio systemd[1]: Mounted /var/spool/cups. Jan 20 22:00:52 volumio systemd[1]: Mounted /tmp. Jan 20 22:00:52 volumio systemd[1]: Mounting /var/spool/cups/tmp... Jan 20 22:00:52 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Jan 20 22:00:52 volumio systemd[1]: Mounted /var/spool/cups/tmp. Jan 20 22:00:52 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown. Jan 20 22:00:52 volumio systemd-udevd[522]: Network interface NamePolicy= disabled on kernel command line, ignoring. Jan 20 22:00:52 volumio systemd-journald[496]: Runtime journal (/run/log/journal/724bcbf01eebf9d6210f389b672e577a) is 3.7M, max 30.0M, 26.2M free. Jan 20 22:00:52 volumio systemd[1]: Started udev Kernel Device Manager. Jan 20 22:00:52 volumio systemd[1]: Starting Show Plymouth Boot Screen... Jan 20 22:00:52 volumio systemd[1]: Started Flush Journal to Persistent Storage. Jan 20 22:00:52 volumio systemd[1]: plymouth-start.service: Succeeded. Jan 20 22:00:52 volumio systemd[1]: Started Show Plymouth Boot Screen. Jan 20 22:00:52 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jan 20 22:00:52 volumio systemd[1]: Reached target Paths. Jan 20 22:00:52 volumio systemd[1]: Reached target Local Encrypted Volumes. Jan 20 22:00:52 volumio systemd-udevd[538]: Using default interface naming scheme 'v240'. Jan 20 22:00:52 volumio kernel: pstore: Using crash dump compression: deflate Jan 20 22:00:52 volumio systemd-udevd[538]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jan 20 22:00:52 volumio kernel: sd 4:0:0:0: Attached scsi generic sg0 type 0 Jan 20 22:00:52 volumio kernel: pstore: Registered efi_pstore as persistent store backend Jan 20 22:00:52 volumio kernel: cryptd: max_cpu_qlen set to 1000 Jan 20 22:00:52 volumio systemd-udevd[563]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jan 20 22:00:52 volumio kernel: AVX version of gcm_enc/dec engaged. Jan 20 22:00:52 volumio kernel: AES CTR mode by8 optimization enabled Jan 20 22:00:52 volumio kernel: asus_wmi: ASUS WMI generic driver loaded Jan 20 22:00:52 volumio kernel: asus_wmi: Initialization: 0x0 Jan 20 22:00:52 volumio kernel: asus_wmi: BIOS WMI version: 0.9 Jan 20 22:00:52 volumio kernel: asus_wmi: SFUN value: 0x0 Jan 20 22:00:52 volumio kernel: eeepc-wmi eeepc-wmi: Detected ASUSWMI, use DCTS Jan 20 22:00:52 volumio kernel: input: Eee PC WMI hotkeys as /devices/platform/eeepc-wmi/input/input3 Jan 20 22:00:52 volumio kernel: snd_hda_intel 0000:00:01.1: enabling device (0000 -> 0002) Jan 20 22:00:52 volumio kernel: snd_hda_intel 0000:00:01.1: Force to non-snoop mode Jan 20 22:00:52 volumio kernel: snd_hda_intel 0000:00:01.1: bound 0000:00:01.0 (ops __SCT__tp_func_radeon_semaphore_wait [radeon]) Jan 20 22:00:52 volumio kernel: input: HDA ATI HDMI HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:01.1/sound/card0/input4 Jan 20 22:00:52 volumio kernel: snd_hda_codec_realtek hdaudioC1D0: autoconfig for ALC887-VD: line_outs=1 (0x14/0x0/0x0/0x0/0x0) type:line Jan 20 22:00:52 volumio kernel: snd_hda_codec_realtek hdaudioC1D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Jan 20 22:00:52 volumio kernel: snd_hda_codec_realtek hdaudioC1D0: hp_outs=1 (0x1b/0x0/0x0/0x0/0x0) Jan 20 22:00:52 volumio kernel: snd_hda_codec_realtek hdaudioC1D0: mono: mono_out=0x0 Jan 20 22:00:52 volumio kernel: snd_hda_codec_realtek hdaudioC1D0: dig-out=0x11/0x1e Jan 20 22:00:52 volumio kernel: snd_hda_codec_realtek hdaudioC1D0: inputs: Jan 20 22:00:52 volumio kernel: snd_hda_codec_realtek hdaudioC1D0: Front Mic=0x19 Jan 20 22:00:52 volumio kernel: snd_hda_codec_realtek hdaudioC1D0: Rear Mic=0x18 Jan 20 22:00:52 volumio kernel: snd_hda_codec_realtek hdaudioC1D0: Line=0x1a Jan 20 22:00:52 volumio kernel: usb 5-2: 1:3 : unsupported format bits 0x100000000 Jan 20 22:00:52 volumio kernel: input: HD-Audio Generic Front Mic as /devices/pci0000:00/0000:00:14.2/sound/card1/input5 Jan 20 22:00:52 volumio kernel: input: HD-Audio Generic Rear Mic as /devices/pci0000:00/0000:00:14.2/sound/card1/input6 Jan 20 22:00:52 volumio kernel: input: HD-Audio Generic Line as /devices/pci0000:00/0000:00:14.2/sound/card1/input7 Jan 20 22:00:52 volumio kernel: input: HD-Audio Generic Line Out as /devices/pci0000:00/0000:00:14.2/sound/card1/input8 Jan 20 22:00:52 volumio kernel: input: HD-Audio Generic Front Headphone as /devices/pci0000:00/0000:00:14.2/sound/card1/input9 Jan 20 22:00:52 volumio kernel: usbcore: registered new interface driver snd-usb-audio Jan 20 22:00:52 volumio systemd-udevd[565]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:00:52 volumio systemd-udevd[547]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:00:52 volumio systemd-udevd[548]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:00:52 volumio kernel: kvm_amd: TSC scaling supported Jan 20 22:00:52 volumio kernel: kvm_amd: Nested Virtualization enabled Jan 20 22:00:52 volumio kernel: kvm_amd: Nested Paging enabled Jan 20 22:00:52 volumio kernel: kvm_amd: LBR virtualization supported Jan 20 22:00:52 volumio systemd-udevd[553]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:00:52 volumio systemd-udevd[552]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:00:52 volumio kernel: alsactl[645]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Jan 20 22:00:52 volumio systemd-udevd[544]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:00:52 volumio systemd-udevd[569]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:00:52 volumio systemd-udevd[530]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:00:52 volumio systemd-udevd[543]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:00:52 volumio systemd-udevd[573]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:00:52 volumio systemd-udevd[564]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Jan 20 22:00:52 volumio systemd[1]: Found device KINGSTON_SH103S3240G boot. Jan 20 22:00:52 volumio systemd[1]: Found device KINGSTON_SH103S3240G issd. Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller (P8 series motherboard) being skipped. Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jan 20 22:00:52 volumio systemd[1]: Starting Show Plymouth Boot Screen... Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jan 20 22:00:52 volumio systemd[1]: Mounting /media/issd... Jan 20 22:00:52 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/6B5A-4D5C... Jan 20 22:00:52 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Jan 20 22:00:52 volumio systemd[1]: plymouth-start.service: Succeeded. Jan 20 22:00:52 volumio systemd[1]: Started Show Plymouth Boot Screen. Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jan 20 22:00:52 volumio systemd[1]: Started File System Check Daemon to report status. Jan 20 22:00:52 volumio ntfs-3g[681]: Version 2017.3.23AR.3 integrated FUSE 28 Jan 20 22:00:52 volumio ntfs-3g[681]: Mounted /dev/sda4 (Read-Write, label "", NTFS 3.1) Jan 20 22:00:52 volumio ntfs-3g[681]: Cmdline options: rw Jan 20 22:00:52 volumio ntfs-3g[681]: Mount options: allow_other,nonempty,relatime,rw,fsname=/dev/sda4,blkdev,blksize=4096 Jan 20 22:00:52 volumio ntfs-3g[681]: Ownership and permissions disabled, configuration type 7 Jan 20 22:00:52 volumio systemd[1]: Mounted /media/issd. Jan 20 22:00:52 volumio systemd-fsck[676]: fsck.fat 4.1 (2017-01-24) Jan 20 22:00:52 volumio systemd-fsck[676]: 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Jan 20 22:00:52 volumio systemd-fsck[676]: Automatically removing dirty bit. Jan 20 22:00:52 volumio systemd-fsck[676]: There are differences between boot sector and its backup. Jan 20 22:00:52 volumio systemd-fsck[676]: This is mostly harmless. Differences: (offset:original/backup) Jan 20 22:00:52 volumio systemd-fsck[676]: 3:53/6d, 4:59/6b, 5:53/66, 6:4c/73, 7:49/2e, 8:4e/66, 9:55/61, 10:58/74 Jan 20 22:00:52 volumio systemd-fsck[676]: , 90:fa/0e, 91:fc/1f, 92:31/be, 93:c9/77, 94:8e/7c, 95:d1/ac, 96:bc/22 Jan 20 22:00:52 volumio systemd-fsck[676]: , 97:76/c0, 98:7b/74, 99:52/0b, 100:06/56, 101:57/b4, 102:1e/0e, 103:56/bb Jan 20 22:00:52 volumio systemd-fsck[676]: , 104:8e/07, 105:c1/00, 106:b1/cd, 107:26/10, 108:bf/5e, 109:78/eb Jan 20 22:00:52 volumio systemd-fsck[676]: , 110:7b/f0, 111:f3/32, 112:a5/e4, 113:8e/cd, 114:d9/16, 115:bb/cd Jan 20 22:00:52 volumio systemd-fsck[676]: , 116:78/19, 117:00/eb, 118:0f/fe, 119:b4/54, 120:37/68, 121:0f/69 Jan 20 22:00:52 volumio systemd-fsck[676]: , 122:a0/73, 123:56/20, 124:20/69, 125:d2/73, 126:78/20, 127:1b/6e Jan 20 22:00:52 volumio systemd-fsck[676]: , 128:31/6f, 129:c0/74, 130:b1/20, 131:06/61, 132:89/20, 133:3f/62 Jan 20 22:00:52 volumio systemd-fsck[676]: , 134:89/6f, 135:47/6f, 136:02/74, 137:f3/61, 138:64/62, 139:a5/6c Jan 20 22:00:52 volumio systemd-fsck[676]: , 140:8a/65, 141:0e/20, 142:18/64, 143:7c/69, 144:88/73, 145:4d/6b Jan 20 22:00:52 volumio systemd-fsck[676]: , 146:f8/2e, 147:50/20, 148:50/20, 150:50/6c, 151:cd/65, 152:13/61 Jan 20 22:00:52 volumio systemd-fsck[676]: , 153:eb/73, 154:62/65, 155:8b/20, 156:55/69, 157:aa/6e, 158:8b/73 Jan 20 22:00:52 volumio systemd-fsck[676]: , 159:75/65, 160:a8/72, 161:c1/74, 162:ee/20, 163:04/61, 164:01/20 Jan 20 22:00:52 volumio systemd-fsck[676]: , 165:f2/62, 166:83/6f, 167:fa/6f, 168:4f/74, 169:76/61, 170:31/62 Jan 20 22:00:52 volumio systemd-fsck[676]: , 171:81/6c, 172:fa/65, 173:b2/20, 174:07/66, 175:73/6c, 176:2b/6f Jan 20 22:00:52 volumio systemd-fsck[676]: , 177:f6/70, 178:45/70, 179:b4/79, 180:7f/20, 181:75/61, 182:25/6e Jan 20 22:00:52 volumio systemd-fsck[676]: , 183:38/64, 184:4d/0d, 185:b8/0a, 186:74/70, 187:20/72, 188:66/65 Jan 20 22:00:52 volumio systemd-fsck[676]: , 189:3d/73, 190:21/73, 191:47/20, 192:50/61, 193:54/6e, 194:75/79 Jan 20 22:00:52 volumio systemd-fsck[676]: , 195:10/20, 196:80/6b, 197:7d/65, 198:b8/79, 199:ed/20, 200:75/74 Jan 20 22:00:52 volumio systemd-fsck[676]: , 201:0a/6f, 202:66/20, 203:ff/74, 204:75/72, 205:ec/79, 206:66/20 Jan 20 22:00:52 volumio systemd-fsck[676]: , 207:ff/61, 208:75/67, 209:e8/61, 210:eb/69, 211:0f/6e, 212:51/20 Jan 20 22:00:52 volumio systemd-fsck[676]: , 213:51/2e, 214:66/2e, 215:ff/2e, 216:75/20, 217:bc/0d, 218:eb/0a Jan 20 22:00:52 volumio systemd-fsck[676]: , 219:07/00, 220:51/00, 221:51/00, 222:66/00, 223:ff/00, 224:36/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 225:1c/00, 226:7c/00, 227:b4/00, 228:08/00, 229:e8/00, 230:e9/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 232:72/00, 233:13/00, 234:20/00, 235:e4/00, 236:75/00, 237:0f/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 238:c1/00, 239:ea/00, 240:08/00, 241:42/00, 242:89/00, 243:16/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 244:1a/00, 245:7c/00, 246:83/00, 247:e1/00, 248:3f/00, 249:89/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 250:0e/00, 251:18/00, 252:7c/00, 253:fb/00, 254:bb/00, 255:aa/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 256:55/00, 257:b4/00, 258:41/00, 259:e8/00, 260:cb/00, 262:72/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 263:10/00, 264:81/00, 265:fb/00, 266:55/00, 267:aa/00, 268:75/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 269:0a/00, 270:f6/00, 271:c1/00, 272:01/00, 273:74/00, 274:05/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 275:c6/00, 276:06/00, 277:46/00, 278:7d/00, 280:66/00, 281:b8/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 282:2d/00, 283:15/00, 286:66/00, 287:ba/00, 292:bb/00, 294:80/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 295:e8/00, 296:0e/00, 298:66/00, 299:81/00, 300:3e/00, 301:1c/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 302:80/00, 303:d5/00, 304:cf/00, 305:c7/00, 306:62/00, 307:75/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 308:74/00, 309:e9/00, 310:f8/00, 311:02/00, 312:66/00, 313:03/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 314:06/00, 315:60/00, 316:7b/00, 317:66/00, 318:13/00, 319:16/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 320:64/00, 321:7b/00, 322:b9/00, 323:10/00, 325:eb/00, 326:2b/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 327:66/00, 328:52/00, 329:66/00, 330:50/00, 331:06/00, 332:53/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 333:6a/00, 334:01/00, 335:6a/00, 336:10/00, 337:89/00, 338:e6/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 339:66/00, 340:60/00, 341:b4/00, 342:42/00, 343:e8/00, 344:77/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 346:66/00, 347:61/00, 348:8d/00, 349:64/00, 350:10/00, 351:72/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 352:01/00, 353:c3/00, 354:66/00, 355:60/00, 356:31/00, 357:c0/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 358:e8/00, 359:68/00, 361:66/00, 362:61/00, 363:e2/00, 364:da/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 365:c6/00, 366:06/00, 367:46/00, 368:7d/00, 369:2b/00, 370:66/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 371:60/00, 372:66/00, 373:0f/00, 374:b7/00, 375:36/00, 376:18/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 377:7c/00, 378:66/00, 379:0f/00, 380:b7/00, 381:3e/00, 382:1a/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 383:7c/00, 384:66/00, 385:f7/00, 386:f6/00, 387:31/00, 388:c9/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 389:87/00, 390:ca/00, 391:66/00, 392:f7/00, 393:f7/00, 394:66/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 395:3d/00, 396:ff/00, 397:03/00, 400:77/00, 401:17/00, 402:c0/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 403:e4/00, 404:06/00, 405:41/00, 406:08/00, 407:e1/00, 408:88/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 409:c5/00, 410:88/00, 411:d6/00, 412:b8/00, 413:01/00, 414:02/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 415:e8/00, 416:2f/00, 418:66/00, 419:61/00, 420:72/00, 421:01/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 422:c3/00, 423:e2/00, 424:c9/00, 425:31/00, 426:f6/00, 427:8e/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 428:d6/00, 429:bc/00, 430:68/00, 431:7b/00, 432:8e/00, 433:de/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 434:66/00, 435:8f/00, 436:06/00, 437:78/00, 439:be/00, 440:da/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 441:7d/00, 442:ac/00, 443:20/00, 444:c0/00, 445:74/00, 446:09/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 447:b4/00, 448:0e/00, 449:bb/00, 450:07/00, 452:cd/00, 453:10/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 454:eb/00, 455:f2/00, 456:31/00, 457:c0/00, 458:cd/00, 459:16/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 460:cd/00, 461:19/00, 462:f4/00, 463:eb/00, 464:fd/00, 465:8a/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 466:16/00, 467:74/00, 468:7b/00, 469:06/00, 470:cd/00, 471:13/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 472:07/00, 473:c3/00, 474:42/00, 475:6f/00, 476:6f/00, 477:74/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 478:20/00, 479:65/00, 480:72/00, 481:72/00, 482:6f/00, 483:72/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 484:0d/00, 485:0a/00, 504:fe/00, 505:02/00, 506:b2/00, 507:3e/00 Jan 20 22:00:52 volumio systemd-fsck[676]: , 508:18/00, 509:37/00 Jan 20 22:00:52 volumio systemd-fsck[676]: Not automatically fixing this. Jan 20 22:00:52 volumio systemd-fsck[676]: Performing changes. Jan 20 22:00:52 volumio systemd-fsck[676]: /dev/sda1: 18 files, 159614/344788 clusters Jan 20 22:00:52 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/6B5A-4D5C. Jan 20 22:00:52 volumio systemd[1]: Mounting /boot... Jan 20 22:00:52 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jan 20 22:00:52 volumio systemd[1]: Mounted /boot. Jan 20 22:00:52 volumio systemd[1]: Reached target Local File Systems. Jan 20 22:00:52 volumio systemd[1]: Started ifup for eth0. Jan 20 22:00:52 volumio systemd[1]: Starting Raise network interfaces... Jan 20 22:00:52 volumio systemd[1]: Starting Preprocess NFS configuration... Jan 20 22:00:52 volumio systemd[1]: Starting Create Volatile Files and Directories... Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Jan 20 22:00:52 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jan 20 22:00:52 volumio systemd[1]: nfs-config.service: Succeeded. Jan 20 22:00:52 volumio systemd[1]: Started Preprocess NFS configuration. Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jan 20 22:00:52 volumio systemd[1]: Reached target NFS client services. Jan 20 22:00:52 volumio systemd[1]: Received SIGRTMIN+20 from PID 379 (plymouthd). Jan 20 22:00:52 volumio systemd[1]: plymouth-read-write.service: Succeeded. Jan 20 22:00:52 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jan 20 22:00:52 volumio systemd[1]: Started Create Volatile Files and Directories. Jan 20 22:00:52 volumio systemd[1]: Starting RPC bind portmap service... Jan 20 22:00:52 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jan 20 22:00:52 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Jan 20 22:00:52 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Jan 20 22:00:52 volumio systemd[1]: Reached target System Initialization. Jan 20 22:00:52 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Jan 20 22:00:52 volumio systemd[1]: Listening on triggerhappy.socket. Jan 20 22:00:52 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jan 20 22:00:52 volumio systemd[1]: Reached target Sockets. Jan 20 22:00:52 volumio systemd[1]: Started Daily apt download activities. Jan 20 22:00:52 volumio systemd[1]: Reached target Basic System. Jan 20 22:00:52 volumio systemd[1]: Started volumio-remote-updater.service. Jan 20 22:00:52 volumio systemd[1]: Started Manage Sound Card State (restore and store). Jan 20 22:00:52 volumio alsactl[710]: alsactl 1.1.8 daemon started Jan 20 22:00:52 volumio systemd[1]: Starting Volumio Time Update Utility... Jan 20 22:00:52 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Jan 20 22:00:52 volumio volumio-time-update[711]: volumio-time-update-util: Fetching time from Volumio... Jan 20 22:00:52 volumio systemd[1]: Starting Login Service... Jan 20 22:00:52 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jan 20 22:00:52 volumio systemd[1]: Starting triggerhappy global hotkey daemon... Jan 20 22:00:52 volumio systemd[1]: Starting Save/Restore Sound Card State... Jan 20 22:00:52 volumio systemd[1]: Started Volumio Log Rotation Service. Jan 20 22:00:52 volumio systemd[1]: Starting Wireless Services... Jan 20 22:00:52 volumio systemd[1]: Started D-Bus System Message Bus. Jan 20 22:00:52 volumio systemd[1]: Starting WPA supplicant... Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Jan 20 22:00:52 volumio systemd[1]: Started Volumio Iptables Module. Jan 20 22:00:52 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jan 20 22:00:52 volumio systemd[1]: Started Daily man-db regeneration. Jan 20 22:00:52 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Jan 20 22:00:52 volumio systemd[1]: Reached target Timers. Jan 20 22:00:52 volumio systemd[1]: Started MPD Monitor Service. Jan 20 22:00:52 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Jan 20 22:00:52 volumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Jan 20 22:00:52 volumio systemd[1]: Starting DHCP Client Daemon... Jan 20 22:00:52 volumio systemd[1]: Started RPC bind portmap service. Jan 20 22:00:52 volumio systemd[1]: Reached target Remote File Systems (Pre). Jan 20 22:00:52 volumio systemd[1]: Reached target Remote File Systems. Jan 20 22:00:52 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Jan 20 22:00:52 volumio systemd[1]: Reached target RPC Port Mapper. Jan 20 22:00:52 volumio thd[719]: Unable to parse trigger line: Jan 20 22:00:52 volumio thd[719]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Jan 20 22:00:52 volumio thd[719]: Unable to parse trigger line: Jan 20 22:00:52 volumio thd[719]: Found socket passed from systemd Jan 20 22:00:52 volumio kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Jan 20 22:00:52 volumio kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Jan 20 22:00:52 volumio systemd-logind[713]: New seat seat0. Jan 20 22:00:52 volumio avahi-daemon[718]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Jan 20 22:00:52 volumio avahi-daemon[718]: Successfully dropped root privileges. Jan 20 22:00:52 volumio avahi-daemon[718]: avahi-daemon 0.7 starting up. Jan 20 22:00:52 volumio ifup[685]: command failed: No such device (-19) Jan 20 22:00:52 volumio systemd-logind[713]: Watching system buttons on /dev/input/event1 (Power Button) Jan 20 22:00:52 volumio systemd-logind[713]: Watching system buttons on /dev/input/event0 (Power Button) Jan 20 22:00:52 volumio sh[684]: command failed: No such device (-19) Jan 20 22:00:53 volumio mpd_monitor.sh[726]: MPD error: Cannot assign requested address Jan 20 22:00:53 volumio volumio-remote-updater[709]: Error: No active session Jan 20 22:00:53 volumio volumio-remote-updater[709]: [2025-01-20 22:00:53] [info] asio async_connect error: system:111 (Connection refused) Jan 20 22:00:53 volumio volumio-remote-updater[709]: [2025-01-20 22:00:53] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 20 22:00:53 volumio mpd_monitor.sh[726]: mpd: no process found Jan 20 22:00:53 volumio volumio-remote-updater[709]: [2025-01-20 22:00:53] [error] handle_connect error: Underlying Transport Error Jan 20 22:00:53 volumio kernel: 8021q: 802.1Q VLAN Support v1.8 Jan 20 22:00:53 volumio volumio-time-update[711]: volumio-time-update-util: Date not found in response Jan 20 22:00:53 volumio volumio-time-update[711]: volumio-time-update-util: Retrying in 5 seconds... Jan 20 22:00:53 volumio sh[684]: sending commands to master dhcpcd process Jan 20 22:00:53 volumio dhcpcd[782]: sending commands to master dhcpcd process Jan 20 22:00:53 volumio ifup[685]: command failed: No such device (-19) Jan 20 22:00:53 volumio systemd[1]: Started triggerhappy global hotkey daemon. Jan 20 22:00:53 volumio systemd[1]: Started Save/Restore Sound Card State. Jan 20 22:00:53 volumio avahi-daemon[718]: Successfully called chroot(). Jan 20 22:00:53 volumio avahi-daemon[718]: Successfully dropped remaining capabilities. Jan 20 22:00:53 volumio wpa_supplicant[724]: Successfully initialized wpa_supplicant Jan 20 22:00:53 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jan 20 22:00:53 volumio systemd[1]: Started WPA supplicant. Jan 20 22:00:53 volumio avahi-daemon[718]: No service file found in /etc/avahi/services. Jan 20 22:00:53 volumio avahi-daemon[718]: Network interface enumeration completed. Jan 20 22:00:53 volumio avahi-daemon[718]: Server startup complete. Host name is volumio.local. Local service cookie is 540541558. Jan 20 22:00:53 volumio systemd[1]: Listening on mpd.socket. Jan 20 22:00:53 volumio systemd[1]: Reached target Sound Card. Jan 20 22:00:53 volumio sh[684]: eth0=eth0 Jan 20 22:00:53 volumio volumio[712]: Could not open config: /tmp/upmpdcli.conf Jan 20 22:00:53 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 20 22:00:53 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 20 22:00:53 volumio systemd[1]: Started Login Service. Jan 20 22:00:53 volumio haveged[708]: haveged: ver: 1.9.1; arch: x86; vend: ; build: (gcc 8.3.0 ITV); collect: 128K Jan 20 22:00:53 volumio haveged[708]: haveged: cpu: (VC); data: 16K (D V); inst: 64K (V); idx: 39/40; sz: 52825/52825 Jan 20 22:00:53 volumio haveged[708]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00136 Jan 20 22:00:53 volumio haveged[708]: haveged: fills: 0, generated: 0 Jan 20 22:00:53 volumio dhcpcd[728]: no interfaces have a carrier Jan 20 22:00:53 volumio dhcpcd[728]: forked to background, child pid 873 Jan 20 22:00:53 volumio systemd[1]: Started Raise network interfaces. Jan 20 22:00:53 volumio dhcpcd[728]: no interfaces have a carrier Jan 20 22:00:53 volumio dhcpcd[728]: forked to background, child pid 873 Jan 20 22:00:53 volumio systemd[1]: Started DHCP Client Daemon. Jan 20 22:00:53 volumio systemd[1]: Reached target Network. Jan 20 22:00:53 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Jan 20 22:00:53 volumio kernel: RTL8211E Gigabit Ethernet r8169-0-300:00: attached PHY driver (mii_bus:phy_addr=r8169-0-300:00, irq=MAC) Jan 20 22:00:53 volumio loadcpufreq[729]: Loading cpufreq kernel modules...done (powernow-k8). Jan 20 22:00:53 volumio systemd[1]: Starting Permit User Sessions... Jan 20 22:00:53 volumio systemd[1]: Reached target Network is Online. Jan 20 22:00:53 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Jan 20 22:00:53 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 20 22:00:53 volumio systemd[1]: Starting OpenBSD Secure Shell server... Jan 20 22:00:53 volumio systemd[1]: Starting Network Time Service... Jan 20 22:00:53 volumio systemd[1]: Starting Samba NMB Daemon... Jan 20 22:00:53 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:00:53 volumio systemd[1]: Starting /etc/rc.local Compatibility... Jan 20 22:00:53 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Jan 20 22:00:53 volumio systemd[1]: Started Permit User Sessions. Jan 20 22:00:53 volumio systemd[1]: Started /etc/rc.local Compatibility. Jan 20 22:00:53 volumio systemd[1]: iptables.service: Succeeded. Jan 20 22:00:53 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Jan 20 22:00:53 volumio systemd[1]: Starting Hold until boot process finishes up... Jan 20 22:00:53 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Jan 20 22:00:53 volumio systemd[1]: Received SIGRTMIN+21 from PID 379 (plymouthd). Jan 20 22:00:53 volumio systemd[1]: plymouth-quit.service: Succeeded. Jan 20 22:00:53 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Jan 20 22:00:53 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Jan 20 22:00:53 volumio systemd[1]: Started Hold until boot process finishes up. Jan 20 22:00:53 volumio systemd[1]: Received SIGRTMIN+21 from PID 379 (n/a). Jan 20 22:00:53 volumio systemd[1]: Started Getty on tty1. Jan 20 22:00:53 volumio systemd[1]: Reached target Login Prompts. Jan 20 22:00:53 volumio ifplugd(eth0)[929]: ifplugd 0.28 initializing. Jan 20 22:00:53 volumio cpufrequtils[909]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Jan 20 22:00:53 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Jan 20 22:00:53 volumio ntpd[897]: ntpd 4.2.8p12@1.3728-o (1): Starting Jan 20 22:00:53 volumio ntpd[897]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jan 20 22:00:53 volumio systemd[1]: Started Network Time Service. Jan 20 22:00:53 volumio dhcpcd[873]: eth0: waiting for carrier Jan 20 22:00:53 volumio dhcpcd[873]: eth0: carrier acquired Jan 20 22:00:53 volumio kernel: r8169 0000:03:00.0 eth0: Link is Down Jan 20 22:00:53 volumio dhcpcd[873]: DUID 00:04:1d:86:c7:c0:15:7d:11:e0:83:8c:08:60:6e:6c:a0:50 Jan 20 22:00:53 volumio dhcpcd[873]: eth0: IAID 6e:6c:a0:50 Jan 20 22:00:53 volumio ifplugd(eth0)[929]: Using interface eth0/08:60:6E:6C:A0:50 with driver (version: 6.6.32-volumio) Jan 20 22:00:53 volumio ifplugd(eth0)[929]: Using detection mode: SIOCETHTOOL Jan 20 22:00:53 volumio ifplugd(eth0)[929]: Initialization complete, link beat not detected. Jan 20 22:00:53 volumio dhcpcd[873]: eth0: adding address fe80::55ac:e479:9b2e:df78 Jan 20 22:00:53 volumio dhcpcd[873]: ipv6_addaddr1: Permission denied Jan 20 22:00:53 volumio dhcpcd[873]: control command: /sbin/dhcpcd eth0 Jan 20 22:00:53 volumio dhcpcd[873]: eth0: carrier lost Jan 20 22:00:53 volumio ntpd[935]: proto: precision = 0.088 usec (-23) Jan 20 22:00:53 volumio ntpd[935]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jan 20 22:00:53 volumio ntpd[935]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jan 20 22:00:53 volumio ntpd[935]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 755 days ago Jan 20 22:00:53 volumio ntpd[935]: Listen and drop on 0 v6wildcard [::]:123 Jan 20 22:00:53 volumio ntpd[935]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jan 20 22:00:53 volumio ntpd[935]: Listen normally on 2 lo 127.0.0.1:123 Jan 20 22:00:53 volumio ntpd[935]: Listening on routing socket on fd #19 for interface updates Jan 20 22:00:53 volumio ntpd[935]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 20 22:00:53 volumio ntpd[935]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 20 22:00:53 volumio nmbd[904]: [2025/01/20 22:00:53.515937, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jan 20 22:00:53 volumio nmbd[904]: started asyncdns process 948 Jan 20 22:00:53 volumio nmbd[904]: [2025/01/20 22:00:53.516562, 0] ../lib/util/become_daemon.c:149(daemon_status) Jan 20 22:00:53 volumio nmbd[904]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jan 20 22:00:53 volumio nmbd[904]: [2025/01/20 22:00:53.516589, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jan 20 22:00:53 volumio nmbd[904]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jan 20 22:00:53 volumio sudo[900]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 20 22:00:53 volumio sudo[900]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:53 volumio sudo[900]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jan 20 22:00:53 volumio sudo[900]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:53 volumio sshd[946]: Server listening on 0.0.0.0 port 22. Jan 20 22:00:53 volumio sshd[946]: Server listening on :: port 22. Jan 20 22:00:53 volumio systemd[1]: Started OpenBSD Secure Shell server. Jan 20 22:00:53 volumio wireless.js[722]: WIRELESS: No wireless interface, exiting Jan 20 22:00:53 volumio iw[955]: command failed: No such device (-19) Jan 20 22:00:53 volumio iwconfig[958]: Error for wireless request "Set Power Management" (8B2C) : Jan 20 22:00:53 volumio iwconfig[958]: SET failed on device wlan0 ; No such device. Jan 20 22:00:53 volumio systemd[1]: wireless.service: Succeeded. Jan 20 22:00:53 volumio systemd[1]: Started Wireless Services. Jan 20 22:00:53 volumio systemd[1]: Started Volumio Backend Module. Jan 20 22:00:53 volumio systemd[1]: Started Volumio Cpu Tweaker. Jan 20 22:00:53 volumio systemd[1]: Started Intel SST and HDA soundcard init service. Jan 20 22:00:53 volumio ifplugd[891]: Network Interface Plugging Daemon...start eth0...done. Jan 20 22:00:53 volumio systemd[1]: Started LSB: Brings up/down network automatically. Jan 20 22:00:53 volumio volumio-cpu-tweak[962]: Setting RT Priority for mpd Jan 20 22:00:53 volumio volumio-cpu-tweak[962]: pid 35's current scheduling policy: SCHED_FIFO Jan 20 22:00:53 volumio volumio-cpu-tweak[962]: pid 35's current scheduling priority: 99 Jan 20 22:00:53 volumio volumio-cpu-tweak[962]: Setting MPD Affinity Jan 20 22:00:53 volumio volumio-cpu-tweak[962]: pid 3's current affinity mask: f Jan 20 22:00:53 volumio volumio-cpu-tweak[962]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jan 20 22:00:53 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Jan 20 22:00:53 volumio soundcard-init.sh[963]: Simple mixer control 'IEC958',0 Jan 20 22:00:53 volumio soundcard-init.sh[963]: Capabilities: pswitch pswitch-joined Jan 20 22:00:53 volumio soundcard-init.sh[963]: Playback channels: Mono Jan 20 22:00:53 volumio soundcard-init.sh[963]: Mono: Playback [on] Jan 20 22:00:53 volumio systemd[1]: soundcard-init.service: Succeeded. Jan 20 22:00:54 volumio ntpd[935]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jan 20 22:00:54 volumio mpd[950]: Jan 20 22:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 20 22:00:54 volumio systemd[1]: Started Music Player Daemon. Jan 20 22:00:54 volumio mpd_monitor.sh[726]: MPD restarted due to no mpc output. Jan 20 22:00:54 volumio volumio[961]: info: ------------------------------------------- Jan 20 22:00:54 volumio volumio[961]: info: ----- Volumio3 ---- Jan 20 22:00:54 volumio volumio[961]: info: ------------------------------------------- Jan 20 22:00:54 volumio volumio[961]: info: ----- System startup ---- Jan 20 22:00:54 volumio volumio[961]: info: ------------------------------------------- Jan 20 22:00:54 volumio volumio[961]: info: MYVOLUMIO Environment detected Jan 20 22:00:54 volumio volumio[961]: info: Plugin folders cleanup Jan 20 22:00:54 volumio volumio[961]: info: Scanning into folder /volumio/app/plugins/ Jan 20 22:00:54 volumio volumio[961]: info: Scanning category audio_interface Jan 20 22:00:54 volumio volumio[961]: info: Scanning category miscellanea Jan 20 22:00:54 volumio volumio[961]: info: Scanning category music_service Jan 20 22:00:54 volumio volumio[961]: info: Scanning category plugins.json Jan 20 22:00:54 volumio volumio[961]: info: Scanning category system_controller Jan 20 22:00:54 volumio volumio[961]: info: Scanning category user_interface Jan 20 22:00:54 volumio volumio[961]: info: Scanning into folder /data/plugins/ Jan 20 22:00:54 volumio volumio[961]: info: Scanning category music_service Jan 20 22:00:54 volumio volumio[961]: info: Plugin folders cleanup completed Jan 20 22:00:54 volumio volumio[961]: info: ------------------------------------------- Jan 20 22:00:54 volumio volumio[961]: info: ----- Core plugins startup ---- Jan 20 22:00:54 volumio volumio[961]: info: ------------------------------------------- Jan 20 22:00:54 volumio volumio[961]: info: Loading plugins from folder /volumio/app/plugins/ Jan 20 22:00:54 volumio volumio[961]: info: Adding plugin upnp to MyMusic Plugins Jan 20 22:00:54 volumio volumio[961]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 20 22:00:54 volumio volumio[961]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 20 22:00:54 volumio volumio[961]: info: Loading plugins from folder /data/plugins/ Jan 20 22:00:54 volumio volumio[961]: info: Loading plugin "system"... Jan 20 22:00:54 volumio volumio[961]: info: Loading plugin "appearance"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "network"... Jan 20 22:00:55 volumio volumio[961]: info: Refreshing Cached IP Addresses Jan 20 22:00:55 volumio sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 22:00:55 volumio sudo[1107]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:55 volumio sudo[1107]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:55 volumio sudo[1109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 22:00:55 volumio sudo[1109]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:55 volumio sudo[1109]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "services"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "alsa_controller"... Jan 20 22:00:55 volumio sudo[1124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 20 22:00:55 volumio sudo[1124]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:55 volumio sudo[1124]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:55 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "wizard"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "networkfs"... Jan 20 22:00:55 volumio volumio[961]: info: Starting Udev Watcher for removable devices Jan 20 22:00:55 volumio sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Tor,password=Tor,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.88.45/share/music HI-RES /mnt/NAS/NAS Jan 20 22:00:55 volumio sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:55 volumio volumio[961]: info: Ignoring mount for partition: boot Jan 20 22:00:55 volumio volumio[961]: info: Ignoring mount for partition: volumio Jan 20 22:00:55 volumio volumio[961]: info: Ignoring mount for partition: volumio_data Jan 20 22:00:55 volumio volumio[961]: info: Ignoring mount for partition: 31053A8908D2D207 Jan 20 22:00:55 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "volumio_command_line_client"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "upnp"... Jan 20 22:00:55 volumio kernel: FS-Cache: Loaded Jan 20 22:00:55 volumio kernel: Key type dns_resolver registered Jan 20 22:00:55 volumio volumio[961]: info: [1737385255159] Starting Upmpd Daemon Jan 20 22:00:55 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "my_music"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "mpd"... Jan 20 22:00:55 volumio kernel: Key type cifs.spnego registered Jan 20 22:00:55 volumio kernel: Key type cifs.idmap registered Jan 20 22:00: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. Jan 20 22:00:55 volumio kernel: CIFS: Attempting to mount //192.168.88.45/share/music HI-RES Jan 20 22:00:55 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 20 22:00:55 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jan 20 22:00:55 volumio sudo[1139]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "upnp_browser"... Jan 20 22:00:55 volumio ntpd[935]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "alarm-clock"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "airplay_emulation"... Jan 20 22:00:55 volumio volumio[961]: info: Starting Shairport Sync Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "last_100"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "webradio"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "i2s_dacs"... Jan 20 22:00:55 volumio volumio[961]: info: I2S DAC not set, start Auto-detection Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "volumiodiscovery"... Jan 20 22:00:55 volumio volumio[961]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:00:55 volumio volumio[961]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:00:55 volumio volumio[961]: *** WARNING *** For more information see Jan 20 22:00:55 volumio volumio[961]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:00:55 volumio node[961]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:00:55 volumio volumio[961]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:00:55 volumio volumio[961]: *** WARNING *** For more information see Jan 20 22:00:55 volumio node[961]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:00:55 volumio node[961]: *** WARNING *** For more information see Jan 20 22:00:55 volumio node[961]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:00:55 volumio node[961]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:00:55 volumio node[961]: *** WARNING *** For more information see Jan 20 22:00:55 volumio volumio[961]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 20 22:00:55 volumio volumio[961]: info: Discovery: Started advertising with name: Volumio Jan 20 22:00:55 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "squeezelite_mc"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "outputs"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "albumart"... Jan 20 22:00:55 volumio volumio[961]: info: Plugin example_plugin is not enabled Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "inputs"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "updater_comm"... Jan 20 22:00:55 volumio volumio[961]: Forking 3 albumart workers Jan 20 22:00:55 volumio volumio[961]: info: Plugin mpdemulation is not enabled Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "rest_api"... Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "websocket"... Jan 20 22:00:55 volumio volumio[961]: info: Starting Socket.io Server version 2.3.0 Jan 20 22:00:55 volumio volumio[961]: info: Loading plugin "RoonBridge"... Jan 20 22:00:55 volumio volumio[961]: info: Applying required configuration parameters for plugin RoonBridge Jan 20 22:00:55 volumio volumio[961]: info: Loading i18n strings for locale ru Jan 20 22:00:55 volumio volumio[961]: Updating browse sources language Jan 20 22:00:55 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:00:55 volumio volumio[961]: Starting albumart workers Jan 20 22:00:55 volumio volumio[961]: Starting albumart workers Jan 20 22:00:55 volumio volumio[961]: Starting albumart workers Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::initPlayerControls Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:00:56 volumio volumio[961]: Express server listening on port 3000 Jan 20 22:00:56 volumio volumio[961]: [Metrics] WebUI: 1s 895.83ms Jan 20 22:00:56 volumio volumio[961]: info: Setting Device type: x86 Jan 20 22:00:56 volumio volumio[961]: info: CoreStateMachine::resetVolumioState Jan 20 22:00:56 volumio volumio[961]: info: CoreStateMachine::getcurrentVolume Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:56 volumio volumio[961]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 20 22:00:56 volumio volumio[961]: info: Completed loading Core Plugins Jan 20 22:00:56 volumio volumio[961]: info: Preparing to generate the ALSA configuration file Jan 20 22:00:56 volumio volumio[961]: info: Volumio Network Manager: Network status updated: 0 Jan 20 22:00:56 volumio volumio[961]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Jan 20 22:00:56 volumio volumio[961]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jan 20 22:00:56 volumio volumio[961]: wlan0 Interface doesn't support scanning. Jan 20 22:00:56 volumio volumio[961]: info: Cannot use regular scanning, forcing with ap-force Jan 20 22:00:56 volumio sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jan 20 22:00:56 volumio sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:56 volumio sudo[1202]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:56 volumio volumio[961]: command failed: No such device (-19) Jan 20 22:00:56 volumio volumio[961]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jan 20 22:00:56 volumio volumio[961]: command failed: No such device (-19) Jan 20 22:00:56 volumio volumio[961]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 20 22:00:56 volumio volumio[961]: info: Reloading queue from file Jan 20 22:00:56 volumio volumio[961]: info: CoreStateMachine::setRepeat null single undefined Jan 20 22:00:56 volumio volumio[961]: info: CoreStateMachine::pushState Jan 20 22:00:56 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Jan 20 22:00:56 volumio volumio[961]: info: CoreStateMachine::setRandom null Jan 20 22:00:56 volumio volumio[961]: info: CoreStateMachine::pushState Jan 20 22:00:56 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Jan 20 22:00:56 volumio volumio[961]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:00:56 volumio volumio[961]: info: CoreStateMachine::pushState Jan 20 22:00:56 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Jan 20 22:00:56 volumio volumio[961]: info: CoreStateMachine::updateTrackBlock Jan 20 22:00:56 volumio volumio[961]: info: CorePlayQueue::getTrackBlock Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:00:56 volumio volumio[961]: info: Asound.conf file unchanged, so no further update is needed Jan 20 22:00:56 volumio volumio[961]: info: Output device has changed, restarting MPD Jan 20 22:00:56 volumio sudo[1221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:00:56 volumio sudo[1221]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:56 volumio sudo[1221]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:56 volumio volumio[961]: info: Output device has changed, restarting Shairport Sync Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:56 volumio sudo[1224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:00:56 volumio sudo[1224]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:56 volumio systemd[1]: Stopping Music Player Daemon... Jan 20 22:00:56 volumio volumio[961]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:00:56 volumio volumio[961]: info: ___________ START PLUGINS ___________ Jan 20 22:00:56 volumio volumio[961]: info: ControllerMpd::onStart: Initializing MPD Jan 20 22:00:56 volumio volumio[961]: info: Creating MPD Configuration file Jan 20 22:00:56 volumio sudo[1230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:00:56 volumio sudo[1230]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:56 volumio sudo[1230]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:00:56 volumio volumio[961]: info: [1737385256207] CoreMusicLibrary::Adding element Медиа-серверы Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:00:56 volumio sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:00:56 volumio sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:56 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:00:56 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:00:56 volumio volumio[961]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:00:56 volumio volumio[961]: info: [1737385256242] CoreMusicLibrary::Adding element Last_100 Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:00:56 volumio volumio[961]: info: [1737385256243] CoreMusicLibrary::Adding element Webradio Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:00:56 volumio volumio[961]: info: Initializing BBC Radios Jan 20 22:00:56 volumio dhcpcd[873]: eth0: carrier acquired Jan 20 22:00:56 volumio kernel: r8169 0000:03:00.0 eth0: Link is Up - 1Gbps/Full - flow control off Jan 20 22:00:56 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:00:56 volumio dhcpcd[873]: eth0: IAID 6e:6c:a0:50 Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: [squeezelite_mc] Starting proxy server... Jan 20 22:00:56 volumio sudo[1241]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 20 22:00:56 volumio volumio[961]: info: Volumio Calling Home Jan 20 22:00:56 volumio sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:56 volumio sudo[1241]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:56 volumio sudo[1254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Jan 20 22:00:56 volumio sudo[1254]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:56 volumio volumio[961]: info: [squeezelite_mc] Proxy server started on port 33341 Jan 20 22:00:56 volumio systemd[1]: Started RoonBridge. Jan 20 22:00:56 volumio sudo[1254]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:56 volumio ntpd[935]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:00:56 volumio volumio[961]: Unhandled rejection Error: No sockets available, cannot start. Jan 20 22:00:56 volumio volumio[961]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Jan 20 22:00:56 volumio volumio[961]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Jan 20 22:00:56 volumio volumio[961]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Jan 20 22:00:56 volumio volumio[961]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Jan 20 22:00:56 volumio volumio[961]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Jan 20 22:00:56 volumio volumio[961]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Jan 20 22:00:56 volumio volumio[961]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Jan 20 22:00:56 volumio volumio[961]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Jan 20 22:00:56 volumio volumio[961]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Jan 20 22:00:56 volumio volumio[961]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Jan 20 22:00:56 volumio volumio[961]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Jan 20 22:00:56 volumio volumio[961]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Jan 20 22:00:56 volumio volumio[961]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Jan 20 22:00:56 volumio volumio[961]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Jan 20 22:00:56 volumio volumio[961]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Jan 20 22:00:56 volumio volumio[961]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 20 22:00:56 volumio dhcpcd[873]: eth0: soliciting a DHCP lease Jan 20 22:00:56 volumio volumio[961]: info: MPD Permissions set Jan 20 22:00:56 volumio volumio[961]: info: MPD Permissions set Jan 20 22:00:56 volumio volumio[961]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jan 20 22:00:56 volumio volumio[961]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:00:56 volumio volumio[961]: info: CoreStateMachine::pushState Jan 20 22:00:56 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:00:56 volumio volumio[961]: info: CoreStateMachine::pushState Jan 20 22:00:56 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Jan 20 22:00:56 volumio volumio[961]: info: [squeezelite_mc] Server discovery started Jan 20 22:00:56 volumio volumio[961]: info: [squeezelite_mc] Player finder started Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:56 volumio volumio[961]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 20 22:00:56 volumio volumio[961]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:00:56 volumio volumio[961]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 20 22:00:56 volumio volumio[961]: at doSend (dgram.js:714:16) Jan 20 22:00:56 volumio volumio[961]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Jan 20 22:00:56 volumio volumio[961]: at afterDns (dgram.js:660:5) Jan 20 22:00:56 volumio volumio[961]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Jan 20 22:00:56 volumio volumio[961]: errno: -101, Jan 20 22:00:56 volumio volumio[961]: code: 'ENETUNREACH', Jan 20 22:00:56 volumio volumio[961]: syscall: 'send', Jan 20 22:00:56 volumio volumio[961]: address: '255.255.255.255', Jan 20 22:00:56 volumio volumio[961]: port: 3483 Jan 20 22:00:56 volumio volumio[961]: } Jan 20 22:00:56 volumio volumio[961]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:00:56 volumio dhcpcd[873]: eth0: soliciting an IPv6 router Jan 20 22:00:56 volumio RoonBridge[1261]: 00:00:00.003 Warn: get lock file path: /tmp/.rnbgem0- Jan 20 22:00:56 volumio sudo[1297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 21:59 Jan 20 22:00:56 volumio sudo[1297]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:56 volumio mpd[1256]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 20 22:00:56 volumio mpd[1256]: output: No 'audio_output' defined in config file Jan 20 22:00:56 volumio ifplugd(eth0)[929]: Link beat detected. Jan 20 22:00:56 volumio mpd[1256]: couldn't open play stream: No such file or directory Jan 20 22:00:56 volumio mpd[1256]: sndio_output: Error opening default sndio device Jan 20 22:00:56 volumio mpd[1256]: output: Successfully detected a alsa audio device Jan 20 22:00:56 volumio mpd[1256]: zeroconf: No global port, disabling zeroconf Jan 20 22:00:56 volumio systemd[1]: Started Music Player Daemon. Jan 20 22:00:56 volumio sudo[1233]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:56 volumio sudo[1224]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:56 volumio sudo[1297]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:56 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 20 22:00:56 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 20 22:00:56 volumio RoonBridge[1261]: 00:00:00.123 Trace: [childprocess] using unix child process Jan 20 22:00:56 volumio systemd[1]: Started dynamicswap service. Jan 20 22:00:56 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:00:56 volumio RoonBridge[1261]: 00:00:00.140 Debug: PathForResource, filename: ../.update Jan 20 22:00:56 volumio RoonBridge[1261]: 00:00:00.149 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Jan 20 22:00:56 volumio RoonBridge[1261]: 00:00:00.150 Debug: PathForResource, filename: RAATServer Jan 20 22:00:56 volumio RoonBridge[1261]: 00:00:00.150 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Jan 20 22:00:56 volumio RoonBridge[1261]: 00:00:00.150 Debug: PathForResource, filename: RoonBridgeHelper Jan 20 22:00:56 volumio RoonBridge[1261]: 00:00:00.150 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Jan 20 22:00:56 volumio RoonBridge[1261]: Initializing Jan 20 22:00:56 volumio ifplugd(eth0)[929]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jan 20 22:00:56 volumio ifplugd(eth0)[929]: client: ifup: interface eth0 already configured Jan 20 22:00:56 volumio RoonBridge[1261]: 00:00:00.161 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Jan 20 22:00:56 volumio RoonBridge[1261]: 00:00:00.169 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Jan 20 22:00:56 volumio RoonBridge[1261]: Not Running (.o) Jan 20 22:00:56 volumio RoonBridge[1261]: Running Jan 20 22:00:56 volumio ifplugd(eth0)[929]: Program executed successfully. Jan 20 22:00:56 volumio RoonBridge[1261]: 00:00:00.006 Warn: get lock file path: /tmp/.rnbhgem0- Jan 20 22:00:57 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 20 22:00:57 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jan 20 22:00:57 volumio systemd[1]: Stopped Volumio Backend Module. Jan 20 22:00:57 volumio systemd[1]: Started Volumio Backend Module. Jan 20 22:00:57 volumio systemd[1]: Started dynamicswap service. Jan 20 22:00:57 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:00:57 volumio ntpd[935]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jan 20 22:00:57 volumio volumio[1344]: info: ------------------------------------------- Jan 20 22:00:57 volumio volumio[1344]: info: ----- Volumio3 ---- Jan 20 22:00:57 volumio volumio[1344]: info: ------------------------------------------- Jan 20 22:00:57 volumio volumio[1344]: info: ----- System startup ---- Jan 20 22:00:57 volumio volumio[1344]: info: ------------------------------------------- Jan 20 22:00:57 volumio volumio[1344]: info: MYVOLUMIO Environment detected Jan 20 22:00:57 volumio volumio[1344]: info: Plugin folders cleanup Jan 20 22:00:57 volumio volumio[1344]: info: Scanning into folder /volumio/app/plugins/ Jan 20 22:00:57 volumio volumio[1344]: info: Scanning category audio_interface Jan 20 22:00:57 volumio volumio[1344]: info: Scanning category miscellanea Jan 20 22:00:57 volumio volumio[1344]: info: Scanning category music_service Jan 20 22:00:57 volumio volumio[1344]: info: Scanning category plugins.json Jan 20 22:00:57 volumio volumio[1344]: info: Scanning category system_controller Jan 20 22:00:57 volumio volumio[1344]: info: Scanning category user_interface Jan 20 22:00:57 volumio volumio[1344]: info: Scanning into folder /data/plugins/ Jan 20 22:00:57 volumio volumio[1344]: info: Scanning category music_service Jan 20 22:00:57 volumio volumio[1344]: info: Plugin folders cleanup completed Jan 20 22:00:57 volumio volumio[1344]: info: ------------------------------------------- Jan 20 22:00:57 volumio volumio[1344]: info: ----- Core plugins startup ---- Jan 20 22:00:57 volumio volumio[1344]: info: ------------------------------------------- Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugins from folder /volumio/app/plugins/ Jan 20 22:00:57 volumio volumio[1344]: info: Adding plugin upnp to MyMusic Plugins Jan 20 22:00:57 volumio volumio[1344]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 20 22:00:57 volumio volumio[1344]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugins from folder /data/plugins/ Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "system"... Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "appearance"... Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "network"... Jan 20 22:00:57 volumio volumio[1344]: info: Refreshing Cached IP Addresses Jan 20 22:00:57 volumio sudo[1389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 22:00:57 volumio sudo[1389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:57 volumio sudo[1389]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:57 volumio sudo[1391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 22:00:57 volumio sudo[1391]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "services"... Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "alsa_controller"... Jan 20 22:00:57 volumio sudo[1391]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:57 volumio sudo[1404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 20 22:00:57 volumio sudo[1404]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:57 volumio sudo[1404]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:57 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "wizard"... Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "networkfs"... Jan 20 22:00:57 volumio volumio[1344]: info: Starting Udev Watcher for removable devices Jan 20 22:00:57 volumio sudo[1421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Tor,password=Tor,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.88.45/share/music HI-RES /mnt/NAS/NAS Jan 20 22:00:57 volumio sudo[1421]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:57 volumio volumio[1344]: info: Ignoring mount for partition: boot Jan 20 22:00:57 volumio volumio[1344]: info: Ignoring mount for partition: volumio Jan 20 22:00:57 volumio volumio[1344]: info: Ignoring mount for partition: volumio_data Jan 20 22:00:57 volumio sudo[1421]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:57 volumio kernel: CIFS: Attempting to mount //192.168.88.45/share/music HI-RES Jan 20 22:00:57 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 20 22:00:57 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jan 20 22:00:57 volumio volumio[1344]: info: Ignoring mount for partition: 31053A8908D2D207 Jan 20 22:00:57 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "volumio_command_line_client"... Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "upnp"... Jan 20 22:00:57 volumio volumio[1344]: info: [1737385257931] Starting Upmpd Daemon Jan 20 22:00:57 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "my_music"... Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "mpd"... Jan 20 22:00:57 volumio volumio[1344]: info: Loading plugin "upnp_browser"... Jan 20 22:00:58 volumio volumio-remote-updater[709]: [2025-01-20 22:00:58] [connect] Successful connection Jan 20 22:00:58 volumio volumio-time-update[711]: volumio-time-update-util: Fetching time from Volumio... Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "alarm-clock"... Jan 20 22:00:58 volumio volumio-time-update[711]: volumio-time-update-util: Date not found in response Jan 20 22:00:58 volumio volumio-time-update[711]: volumio-time-update-util: Retrying in 5 seconds... Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "airplay_emulation"... Jan 20 22:00:58 volumio volumio[1344]: info: Starting Shairport Sync Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "last_100"... Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "webradio"... Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "i2s_dacs"... Jan 20 22:00:58 volumio volumio[1344]: info: I2S DAC not set, start Auto-detection Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "volumiodiscovery"... Jan 20 22:00:58 volumio volumio[1344]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:00:58 volumio volumio[1344]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:00:58 volumio volumio[1344]: *** WARNING *** For more information see Jan 20 22:00:58 volumio volumio[1344]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:00:58 volumio volumio[1344]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:00:58 volumio volumio[1344]: *** WARNING *** For more information see Jan 20 22:00:58 volumio node[1344]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:00:58 volumio node[1344]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:00:58 volumio node[1344]: *** WARNING *** For more information see Jan 20 22:00:58 volumio node[1344]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:00:58 volumio node[1344]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:00:58 volumio node[1344]: *** WARNING *** For more information see Jan 20 22:00:58 volumio volumio[1344]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 20 22:00:58 volumio volumio[1344]: info: Discovery: Started advertising with name: Volumio Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "squeezelite_mc"... Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "outputs"... Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "albumart"... Jan 20 22:00:58 volumio volumio[1344]: info: Plugin example_plugin is not enabled Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "inputs"... Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "updater_comm"... Jan 20 22:00:58 volumio volumio[1344]: info: Plugin mpdemulation is not enabled Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "rest_api"... Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "websocket"... Jan 20 22:00:58 volumio volumio[1344]: info: Starting Socket.io Server version 2.3.0 Jan 20 22:00:58 volumio volumio[1344]: info: Loading plugin "RoonBridge"... Jan 20 22:00:58 volumio volumio[1344]: Forking 3 albumart workers Jan 20 22:00:58 volumio volumio[1344]: info: Applying required configuration parameters for plugin RoonBridge Jan 20 22:00:58 volumio volumio[1344]: info: Loading i18n strings for locale ru Jan 20 22:00:58 volumio volumio[1344]: Updating browse sources language Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::initPlayerControls Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: Express server listening on port 3000 Jan 20 22:00:58 volumio volumio[1344]: [Metrics] WebUI: 1s 171.42ms Jan 20 22:00:58 volumio volumio[1344]: info: Setting Device type: x86 Jan 20 22:00:58 volumio volumio[1344]: info: CoreStateMachine::resetVolumioState Jan 20 22:00:58 volumio volumio[1344]: info: CoreStateMachine::getcurrentVolume Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 20 22:00:58 volumio volumio[1344]: info: Completed loading Core Plugins Jan 20 22:00:58 volumio volumio[1344]: info: Preparing to generate the ALSA configuration file Jan 20 22:00:58 volumio volumio[1344]: Starting albumart workers Jan 20 22:00:58 volumio volumio[1344]: Starting albumart workers Jan 20 22:00:58 volumio volumio[1344]: info: Volumio Network Manager: Network status updated: 0 Jan 20 22:00:58 volumio volumio[1344]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Jan 20 22:00:58 volumio volumio[1344]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jan 20 22:00:58 volumio volumio[1344]: wlan0 Interface doesn't support scanning. Jan 20 22:00:58 volumio volumio[1344]: info: Cannot use regular scanning, forcing with ap-force Jan 20 22:00:58 volumio volumio[1344]: Starting albumart workers Jan 20 22:00:58 volumio sudo[1467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jan 20 22:00:58 volumio sudo[1467]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:58 volumio sudo[1467]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:58 volumio volumio[1344]: command failed: No such device (-19) Jan 20 22:00:58 volumio volumio[1344]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jan 20 22:00:58 volumio volumio[1344]: command failed: No such device (-19) Jan 20 22:00:58 volumio volumio[1344]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 20 22:00:58 volumio volumio-remote-updater[709]: [2025-01-20 22:00:58] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737385258 101 Jan 20 22:00:58 volumio volumio[1344]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Jan 20 22:00:58 volumio volumio[1344]: info: Reloading queue from file Jan 20 22:00:58 volumio volumio[1344]: info: CoreStateMachine::setRepeat null single undefined Jan 20 22:00:58 volumio volumio[1344]: info: CoreStateMachine::pushState Jan 20 22:00:58 volumio volumio[1344]: info: CorePlayQueue::getTrack 0 Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::volumioPushState Jan 20 22:00:58 volumio volumio[1344]: info: CoreStateMachine::setRandom null Jan 20 22:00:58 volumio volumio[1344]: info: CoreStateMachine::pushState Jan 20 22:00:58 volumio volumio[1344]: info: CorePlayQueue::getTrack 0 Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::volumioPushState Jan 20 22:00:58 volumio volumio[1344]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:00:58 volumio volumio[1344]: info: CoreStateMachine::pushState Jan 20 22:00:58 volumio volumio[1344]: info: CorePlayQueue::getTrack 0 Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::volumioPushState Jan 20 22:00:58 volumio volumio[1344]: info: CoreStateMachine::updateTrackBlock Jan 20 22:00:58 volumio volumio[1344]: info: CorePlayQueue::getTrackBlock Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:00:58 volumio volumio[1344]: info: Asound.conf file unchanged, so no further update is needed Jan 20 22:00:58 volumio volumio[1344]: info: Output device has changed, restarting MPD Jan 20 22:00:58 volumio sudo[1494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:00:58 volumio sudo[1494]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:58 volumio sudo[1494]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:58 volumio volumio[1344]: info: Output device has changed, restarting Shairport Sync Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:58 volumio sudo[1502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:00:58 volumio sudo[1502]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:58 volumio systemd[1]: Stopping Music Player Daemon... Jan 20 22:00:58 volumio volumio[1344]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:00:58 volumio volumio[1344]: info: ___________ START PLUGINS ___________ Jan 20 22:00:58 volumio volumio[1344]: info: ControllerMpd::onStart: Initializing MPD Jan 20 22:00:58 volumio volumio[1344]: info: Creating MPD Configuration file Jan 20 22:00:58 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:00:58 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:00:58 volumio sudo[1512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:00:58 volumio sudo[1512]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:00:58 volumio volumio[1344]: info: [1737385258708] CoreMusicLibrary::Adding element Медиа-серверы Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:58 volumio sudo[1512]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:58 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:00:58 volumio sudo[1515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:00:58 volumio sudo[1515]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:58 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 20 22:00:58 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:00:58 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:00:58 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:00:58 volumio volumio[1344]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:00:58 volumio volumio[1344]: info: [1737385258744] CoreMusicLibrary::Adding element Last_100 Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:00:58 volumio volumio[1344]: info: [1737385258745] CoreMusicLibrary::Adding element Webradio Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:00:58 volumio volumio[1344]: info: Initializing BBC Radios Jan 20 22:00:58 volumio sudo[1520]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 20 22:00:58 volumio sudo[1520]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:58 volumio sudo[1520]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: [squeezelite_mc] Starting proxy server... Jan 20 22:00:58 volumio volumio[1344]: info: Volumio Calling Home Jan 20 22:00:58 volumio sudo[1537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Jan 20 22:00:58 volumio sudo[1537]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:58 volumio sudo[1537]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:58 volumio volumio[1344]: info: [squeezelite_mc] Proxy server started on port 38595 Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:00:58 volumio volumio[1344]: Unhandled rejection Error: No sockets available, cannot start. Jan 20 22:00:58 volumio volumio[1344]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Jan 20 22:00:58 volumio volumio[1344]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Jan 20 22:00:58 volumio volumio[1344]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Jan 20 22:00:58 volumio volumio[1344]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Jan 20 22:00:58 volumio volumio[1344]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Jan 20 22:00:58 volumio volumio[1344]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Jan 20 22:00:58 volumio volumio[1344]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Jan 20 22:00:58 volumio volumio[1344]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Jan 20 22:00:58 volumio volumio[1344]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Jan 20 22:00:58 volumio volumio[1344]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Jan 20 22:00:58 volumio volumio[1344]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Jan 20 22:00:58 volumio volumio[1344]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Jan 20 22:00:58 volumio volumio[1344]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Jan 20 22:00:58 volumio volumio[1344]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Jan 20 22:00:58 volumio volumio[1344]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Jan 20 22:00:58 volumio volumio[1344]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 20 22:00:58 volumio volumio[1344]: info: MPD Permissions set Jan 20 22:00:58 volumio volumio[1344]: info: MPD Permissions set Jan 20 22:00:58 volumio volumio[1344]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jan 20 22:00:58 volumio volumio[1344]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:00:58 volumio volumio[1344]: info: CoreStateMachine::pushState Jan 20 22:00:58 volumio volumio[1344]: info: CorePlayQueue::getTrack 0 Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::volumioPushState Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:00:58 volumio volumio[1344]: info: CoreStateMachine::pushState Jan 20 22:00:58 volumio volumio[1344]: info: CorePlayQueue::getTrack 0 Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::volumioPushState Jan 20 22:00:58 volumio volumio[1344]: info: [squeezelite_mc] Server discovery started Jan 20 22:00:58 volumio volumio[1344]: info: [squeezelite_mc] Player finder started Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:00:58 volumio volumio[1344]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 20 22:00:58 volumio volumio[1344]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:00:58 volumio volumio[1344]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 20 22:00:58 volumio volumio[1344]: at doSend (dgram.js:714:16) Jan 20 22:00:58 volumio volumio[1344]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Jan 20 22:00:58 volumio volumio[1344]: at afterDns (dgram.js:660:5) Jan 20 22:00:58 volumio volumio[1344]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Jan 20 22:00:58 volumio volumio[1344]: errno: -101, Jan 20 22:00:58 volumio volumio[1344]: code: 'ENETUNREACH', Jan 20 22:00:58 volumio volumio[1344]: syscall: 'send', Jan 20 22:00:58 volumio volumio[1344]: address: '255.255.255.255', Jan 20 22:00:58 volumio volumio[1344]: port: 3483 Jan 20 22:00:58 volumio volumio[1344]: } Jan 20 22:00:58 volumio volumio[1344]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:00:59 volumio sudo[1568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 21:59 Jan 20 22:00:59 volumio sudo[1568]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:00:59 volumio mpd[1526]: Jan 20 22:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 20 22:00:59 volumio systemd[1]: Started Music Player Daemon. Jan 20 22:00:59 volumio sudo[1502]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:59 volumio sudo[1515]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:59 volumio sudo[1568]: pam_unix(sudo:session): session closed for user root Jan 20 22:00:59 volumio volumio-remote-updater[709]: [2025-01-20 22:00:59] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jan 20 22:00:59 volumio volumio-remote-updater[709]: [2025-01-20 22:00:59] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jan 20 22:00:59 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 20 22:00:59 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 20 22:00:59 volumio systemd[1]: Started dynamicswap service. Jan 20 22:00:59 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:00:59 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 20 22:00:59 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jan 20 22:00:59 volumio systemd[1]: Stopped Volumio Backend Module. Jan 20 22:00:59 volumio systemd[1]: Started Volumio Backend Module. Jan 20 22:00:59 volumio systemd[1]: Started dynamicswap service. Jan 20 22:00:59 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:00:59 volumio volumio[1583]: info: ------------------------------------------- Jan 20 22:00:59 volumio volumio[1583]: info: ----- Volumio3 ---- Jan 20 22:00:59 volumio volumio[1583]: info: ------------------------------------------- Jan 20 22:00:59 volumio volumio[1583]: info: ----- System startup ---- Jan 20 22:00:59 volumio volumio[1583]: info: ------------------------------------------- Jan 20 22:00:59 volumio volumio[1583]: info: MYVOLUMIO Environment detected Jan 20 22:00:59 volumio volumio[1583]: info: Plugin folders cleanup Jan 20 22:00:59 volumio volumio[1583]: info: Scanning into folder /volumio/app/plugins/ Jan 20 22:00:59 volumio volumio[1583]: info: Scanning category audio_interface Jan 20 22:00:59 volumio volumio[1583]: info: Scanning category miscellanea Jan 20 22:00:59 volumio volumio[1583]: info: Scanning category music_service Jan 20 22:00:59 volumio volumio[1583]: info: Scanning category plugins.json Jan 20 22:00:59 volumio volumio[1583]: info: Scanning category system_controller Jan 20 22:00:59 volumio volumio[1583]: info: Scanning category user_interface Jan 20 22:00:59 volumio volumio[1583]: info: Scanning into folder /data/plugins/ Jan 20 22:00:59 volumio volumio[1583]: info: Scanning category music_service Jan 20 22:00:59 volumio volumio[1583]: info: Plugin folders cleanup completed Jan 20 22:00:59 volumio volumio[1583]: info: ------------------------------------------- Jan 20 22:00:59 volumio volumio[1583]: info: ----- Core plugins startup ---- Jan 20 22:00:59 volumio volumio[1583]: info: ------------------------------------------- Jan 20 22:00:59 volumio volumio[1583]: info: Loading plugins from folder /volumio/app/plugins/ Jan 20 22:00:59 volumio volumio[1583]: info: Adding plugin upnp to MyMusic Plugins Jan 20 22:00:59 volumio volumio[1583]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 20 22:00:59 volumio volumio[1583]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 20 22:00:59 volumio volumio[1583]: info: Loading plugins from folder /data/plugins/ Jan 20 22:00:59 volumio volumio[1583]: info: Loading plugin "system"... Jan 20 22:00:59 volumio volumio[1583]: info: Loading plugin "appearance"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "network"... Jan 20 22:01:00 volumio volumio[1583]: info: Refreshing Cached IP Addresses Jan 20 22:01:00 volumio sudo[1610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 22:01:00 volumio sudo[1610]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:00 volumio sudo[1610]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:00 volumio sudo[1612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 22:01:00 volumio sudo[1612]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "services"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "alsa_controller"... Jan 20 22:01:00 volumio sudo[1612]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:00 volumio sudo[1625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 20 22:01:00 volumio sudo[1625]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:00 volumio sudo[1625]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "wizard"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "networkfs"... Jan 20 22:01:00 volumio volumio[1583]: info: Starting Udev Watcher for removable devices Jan 20 22:01:00 volumio sudo[1642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Tor,password=Tor,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.88.45/share/music HI-RES /mnt/NAS/NAS Jan 20 22:01:00 volumio volumio[1583]: info: Ignoring mount for partition: boot Jan 20 22:01:00 volumio volumio[1583]: info: Ignoring mount for partition: volumio Jan 20 22:01:00 volumio volumio[1583]: info: Ignoring mount for partition: volumio_data Jan 20 22:01:00 volumio sudo[1642]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:00 volumio sudo[1642]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:00 volumio kernel: CIFS: Attempting to mount //192.168.88.45/share/music HI-RES Jan 20 22:01:00 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 20 22:01:00 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jan 20 22:01:00 volumio volumio[1583]: info: Ignoring mount for partition: 31053A8908D2D207 Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "volumio_command_line_client"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "upnp"... Jan 20 22:01:00 volumio volumio[1583]: info: [1737385260236] Starting Upmpd Daemon Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "my_music"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "mpd"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "upnp_browser"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "alarm-clock"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "airplay_emulation"... Jan 20 22:01:00 volumio volumio[1583]: info: Starting Shairport Sync Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "last_100"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "webradio"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "i2s_dacs"... Jan 20 22:01:00 volumio volumio[1583]: info: I2S DAC not set, start Auto-detection Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "volumiodiscovery"... Jan 20 22:01:00 volumio volumio[1583]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:00 volumio volumio[1583]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:00 volumio volumio[1583]: *** WARNING *** For more information see Jan 20 22:01:00 volumio volumio[1583]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:00 volumio node[1583]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:00 volumio volumio[1583]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:00 volumio volumio[1583]: *** WARNING *** For more information see Jan 20 22:01:00 volumio node[1583]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:00 volumio node[1583]: *** WARNING *** For more information see Jan 20 22:01:00 volumio node[1583]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:00 volumio node[1583]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:00 volumio node[1583]: *** WARNING *** For more information see Jan 20 22:01:00 volumio volumio[1583]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 20 22:01:00 volumio volumio[1583]: info: Discovery: Started advertising with name: Volumio Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "squeezelite_mc"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "outputs"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "albumart"... Jan 20 22:01:00 volumio volumio[1583]: info: Plugin example_plugin is not enabled Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "inputs"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "updater_comm"... Jan 20 22:01:00 volumio volumio[1583]: info: Plugin mpdemulation is not enabled Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "rest_api"... Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "websocket"... Jan 20 22:01:00 volumio volumio[1583]: info: Starting Socket.io Server version 2.3.0 Jan 20 22:01:00 volumio volumio[1583]: info: Loading plugin "RoonBridge"... Jan 20 22:01:00 volumio volumio[1583]: Forking 3 albumart workers Jan 20 22:01:00 volumio volumio[1583]: info: Applying required configuration parameters for plugin RoonBridge Jan 20 22:01:00 volumio volumio[1583]: info: Loading i18n strings for locale ru Jan 20 22:01:00 volumio volumio[1583]: Updating browse sources language Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::initPlayerControls Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: Express server listening on port 3000 Jan 20 22:01:00 volumio volumio[1583]: [Metrics] WebUI: 1s 108.64ms Jan 20 22:01:00 volumio volumio[1583]: info: Setting Device type: x86 Jan 20 22:01:00 volumio volumio[1583]: info: CoreStateMachine::resetVolumioState Jan 20 22:01:00 volumio volumio[1583]: info: CoreStateMachine::getcurrentVolume Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 20 22:01:00 volumio volumio[1583]: info: Completed loading Core Plugins Jan 20 22:01:00 volumio volumio[1583]: info: Preparing to generate the ALSA configuration file Jan 20 22:01:00 volumio volumio[1583]: Starting albumart workers Jan 20 22:01:00 volumio volumio[1583]: Starting albumart workers Jan 20 22:01:00 volumio volumio[1583]: Starting albumart workers Jan 20 22:01:00 volumio volumio[1583]: info: Volumio Network Manager: Network status updated: 0 Jan 20 22:01:00 volumio volumio[1583]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Jan 20 22:01:00 volumio volumio[1583]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jan 20 22:01:00 volumio volumio[1583]: wlan0 Interface doesn't support scanning. Jan 20 22:01:00 volumio volumio[1583]: info: Cannot use regular scanning, forcing with ap-force Jan 20 22:01:00 volumio sudo[1681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jan 20 22:01:00 volumio sudo[1681]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:00 volumio sudo[1681]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:00 volumio volumio[1583]: command failed: No such device (-19) Jan 20 22:01:00 volumio volumio[1583]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jan 20 22:01:00 volumio volumio[1583]: command failed: No such device (-19) Jan 20 22:01:00 volumio volumio[1583]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 20 22:01:00 volumio volumio[1583]: info: Reloading queue from file Jan 20 22:01:00 volumio volumio[1583]: info: CoreStateMachine::setRepeat null single undefined Jan 20 22:01:00 volumio volumio[1583]: info: CoreStateMachine::pushState Jan 20 22:01:00 volumio volumio[1583]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:00 volumio volumio[1583]: info: CoreStateMachine::setRandom null Jan 20 22:01:00 volumio volumio[1583]: info: CoreStateMachine::pushState Jan 20 22:01:00 volumio volumio[1583]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:00 volumio volumio[1583]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:01:00 volumio volumio[1583]: info: CoreStateMachine::pushState Jan 20 22:01:00 volumio volumio[1583]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:00 volumio volumio[1583]: info: CoreStateMachine::updateTrackBlock Jan 20 22:01:00 volumio volumio[1583]: info: CorePlayQueue::getTrackBlock Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:01:00 volumio volumio[1583]: info: Asound.conf file unchanged, so no further update is needed Jan 20 22:01:00 volumio volumio[1583]: info: Output device has changed, restarting MPD Jan 20 22:01:00 volumio sudo[1700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:01:00 volumio sudo[1700]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:00 volumio sudo[1700]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:00 volumio volumio[1583]: info: Output device has changed, restarting Shairport Sync Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:00 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:00 volumio sudo[1712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:01:00 volumio sudo[1712]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:00 volumio systemd[1]: Stopping Music Player Daemon... Jan 20 22:01:00 volumio volumio[1583]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:01:00 volumio volumio[1583]: info: ___________ START PLUGINS ___________ Jan 20 22:01:00 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:01:00 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:01:00 volumio volumio[1583]: info: ControllerMpd::onStart: Initializing MPD Jan 20 22:01:00 volumio volumio[1583]: info: Creating MPD Configuration file Jan 20 22:01:00 volumio sudo[1726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:01:00 volumio sudo[1726]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:01:01 volumio volumio[1583]: info: [1737385261003] CoreMusicLibrary::Adding element Медиа-серверы Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:01 volumio sudo[1726]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:01 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:01:01 volumio sudo[1729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:01 volumio sudo[1729]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:01 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 20 22:01:01 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:01:01 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:01:01 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:01:01 volumio volumio[1583]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:01 volumio sudo[1734]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 20 22:01:01 volumio volumio[1583]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:01:01 volumio sudo[1734]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:01:01 volumio volumio[1583]: info: [1737385261040] CoreMusicLibrary::Adding element Last_100 Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:01:01 volumio volumio[1583]: info: [1737385261040] CoreMusicLibrary::Adding element Webradio Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:01:01 volumio sudo[1734]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:01 volumio volumio[1583]: info: Initializing BBC Radios Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: [squeezelite_mc] Starting proxy server... Jan 20 22:01:01 volumio volumio[1583]: info: Volumio Calling Home Jan 20 22:01:01 volumio sudo[1751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Jan 20 22:01:01 volumio sudo[1751]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:01 volumio sudo[1751]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:01 volumio volumio[1583]: info: [squeezelite_mc] Proxy server started on port 32921 Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:01:01 volumio volumio[1583]: Unhandled rejection Error: No sockets available, cannot start. Jan 20 22:01:01 volumio volumio[1583]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Jan 20 22:01:01 volumio volumio[1583]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Jan 20 22:01:01 volumio volumio[1583]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Jan 20 22:01:01 volumio volumio[1583]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Jan 20 22:01:01 volumio volumio[1583]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Jan 20 22:01:01 volumio volumio[1583]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Jan 20 22:01:01 volumio volumio[1583]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Jan 20 22:01:01 volumio volumio[1583]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Jan 20 22:01:01 volumio volumio[1583]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Jan 20 22:01:01 volumio volumio[1583]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Jan 20 22:01:01 volumio volumio[1583]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Jan 20 22:01:01 volumio volumio[1583]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Jan 20 22:01:01 volumio volumio[1583]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Jan 20 22:01:01 volumio volumio[1583]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Jan 20 22:01:01 volumio volumio[1583]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Jan 20 22:01:01 volumio volumio[1583]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 20 22:01:01 volumio volumio[1583]: info: MPD Permissions set Jan 20 22:01:01 volumio volumio[1583]: info: MPD Permissions set Jan 20 22:01:01 volumio volumio[1583]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jan 20 22:01:01 volumio volumio[1583]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:01:01 volumio volumio[1583]: info: CoreStateMachine::pushState Jan 20 22:01:01 volumio volumio[1583]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:01:01 volumio volumio[1583]: info: CoreStateMachine::pushState Jan 20 22:01:01 volumio volumio[1583]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:01 volumio volumio[1583]: info: [squeezelite_mc] Server discovery started Jan 20 22:01:01 volumio volumio[1583]: info: [squeezelite_mc] Player finder started Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:01 volumio volumio[1583]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 20 22:01:01 volumio volumio[1583]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:01:01 volumio volumio[1583]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 20 22:01:01 volumio volumio[1583]: at doSend (dgram.js:714:16) Jan 20 22:01:01 volumio volumio[1583]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Jan 20 22:01:01 volumio volumio[1583]: at afterDns (dgram.js:660:5) Jan 20 22:01:01 volumio volumio[1583]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Jan 20 22:01:01 volumio volumio[1583]: errno: -101, Jan 20 22:01:01 volumio volumio[1583]: code: 'ENETUNREACH', Jan 20 22:01:01 volumio volumio[1583]: syscall: 'send', Jan 20 22:01:01 volumio volumio[1583]: address: '255.255.255.255', Jan 20 22:01:01 volumio volumio[1583]: port: 3483 Jan 20 22:01:01 volumio volumio[1583]: } Jan 20 22:01:01 volumio volumio[1583]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:01:01 volumio mpd[1739]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 20 22:01:01 volumio mpd[1739]: output: No 'audio_output' defined in config file Jan 20 22:01:01 volumio mpd[1739]: couldn't open play stream: No such file or directory Jan 20 22:01:01 volumio mpd[1739]: sndio_output: Error opening default sndio device Jan 20 22:01:01 volumio mpd[1739]: output: Successfully detected a alsa audio device Jan 20 22:01:01 volumio mpd[1739]: zeroconf: No global port, disabling zeroconf Jan 20 22:01:01 volumio systemd[1]: Started Music Player Daemon. Jan 20 22:01:01 volumio sudo[1712]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:01 volumio sudo[1729]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:01 volumio sudo[1784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 22:00 Jan 20 22:01:01 volumio sudo[1784]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:01 volumio dhcpcd[873]: eth0: probing for an IPv4LL address Jan 20 22:01:01 volumio sudo[1784]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:01 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 20 22:01:01 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 20 22:01:01 volumio systemd[1]: dynamicswap.service: Start request repeated too quickly. Jan 20 22:01:01 volumio systemd[1]: dynamicswap.service: Failed with result 'start-limit-hit'. Jan 20 22:01:01 volumio systemd[1]: Failed to start dynamicswap service. Jan 20 22:01:01 volumio dhcpcd[873]: eth0: offered 192.168.88.22 from 192.168.88.1 Jan 20 22:01:01 volumio dhcpcd[873]: eth0: probing address 192.168.88.22/24 Jan 20 22:01:01 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 20 22:01:01 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Jan 20 22:01:01 volumio systemd[1]: Stopped Volumio Backend Module. Jan 20 22:01:01 volumio systemd[1]: Started Volumio Backend Module. Jan 20 22:01:01 volumio systemd[1]: dynamicswap.service: Start request repeated too quickly. Jan 20 22:01:01 volumio systemd[1]: dynamicswap.service: Failed with result 'start-limit-hit'. Jan 20 22:01:01 volumio systemd[1]: Failed to start dynamicswap service. Jan 20 22:01:02 volumio volumio[1791]: info: ------------------------------------------- Jan 20 22:01:02 volumio volumio[1791]: info: ----- Volumio3 ---- Jan 20 22:01:02 volumio volumio[1791]: info: ------------------------------------------- Jan 20 22:01:02 volumio volumio[1791]: info: ----- System startup ---- Jan 20 22:01:02 volumio volumio[1791]: info: ------------------------------------------- Jan 20 22:01:02 volumio volumio[1791]: info: MYVOLUMIO Environment detected Jan 20 22:01:02 volumio volumio[1791]: info: Plugin folders cleanup Jan 20 22:01:02 volumio volumio[1791]: info: Scanning into folder /volumio/app/plugins/ Jan 20 22:01:02 volumio volumio[1791]: info: Scanning category audio_interface Jan 20 22:01:02 volumio volumio[1791]: info: Scanning category miscellanea Jan 20 22:01:02 volumio volumio[1791]: info: Scanning category music_service Jan 20 22:01:02 volumio volumio[1791]: info: Scanning category plugins.json Jan 20 22:01:02 volumio volumio[1791]: info: Scanning category system_controller Jan 20 22:01:02 volumio volumio[1791]: info: Scanning category user_interface Jan 20 22:01:02 volumio volumio[1791]: info: Scanning into folder /data/plugins/ Jan 20 22:01:02 volumio volumio[1791]: info: Scanning category music_service Jan 20 22:01:02 volumio volumio[1791]: info: Plugin folders cleanup completed Jan 20 22:01:02 volumio volumio[1791]: info: ------------------------------------------- Jan 20 22:01:02 volumio volumio[1791]: info: ----- Core plugins startup ---- Jan 20 22:01:02 volumio volumio[1791]: info: ------------------------------------------- Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugins from folder /volumio/app/plugins/ Jan 20 22:01:02 volumio volumio[1791]: info: Adding plugin upnp to MyMusic Plugins Jan 20 22:01:02 volumio volumio[1791]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 20 22:01:02 volumio volumio[1791]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugins from folder /data/plugins/ Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "system"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "appearance"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "network"... Jan 20 22:01:02 volumio volumio[1791]: info: Refreshing Cached IP Addresses Jan 20 22:01:02 volumio sudo[1814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 22:01:02 volumio sudo[1814]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:02 volumio sudo[1812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 22:01:02 volumio sudo[1812]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:02 volumio sudo[1812]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "services"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "alsa_controller"... Jan 20 22:01:02 volumio sudo[1824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 20 22:01:02 volumio sudo[1824]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:02 volumio sudo[1814]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:02 volumio sudo[1824]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:02 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "wizard"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "networkfs"... Jan 20 22:01:02 volumio volumio[1791]: info: Starting Udev Watcher for removable devices Jan 20 22:01:02 volumio volumio[1791]: info: Ignoring mount for partition: boot Jan 20 22:01:02 volumio volumio[1791]: info: Ignoring mount for partition: volumio Jan 20 22:01:02 volumio volumio[1791]: info: Ignoring mount for partition: volumio_data Jan 20 22:01:02 volumio sudo[1844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Tor,password=Tor,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.88.45/share/music HI-RES /mnt/NAS/NAS Jan 20 22:01:02 volumio sudo[1844]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:02 volumio sudo[1844]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:02 volumio kernel: CIFS: Attempting to mount //192.168.88.45/share/music HI-RES Jan 20 22:01:02 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 20 22:01:02 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jan 20 22:01:02 volumio volumio[1791]: info: Ignoring mount for partition: 31053A8908D2D207 Jan 20 22:01:02 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "volumio_command_line_client"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "upnp"... Jan 20 22:01:02 volumio volumio[1791]: info: [1737385262577] Starting Upmpd Daemon Jan 20 22:01:02 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "my_music"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "mpd"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "upnp_browser"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "alarm-clock"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "airplay_emulation"... Jan 20 22:01:02 volumio volumio[1791]: info: Starting Shairport Sync Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "last_100"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "webradio"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "i2s_dacs"... Jan 20 22:01:02 volumio volumio[1791]: info: I2S DAC not set, start Auto-detection Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "volumiodiscovery"... Jan 20 22:01:02 volumio volumio[1791]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:02 volumio volumio[1791]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:02 volumio volumio[1791]: *** WARNING *** For more information see Jan 20 22:01:02 volumio volumio[1791]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:02 volumio volumio[1791]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:02 volumio volumio[1791]: *** WARNING *** For more information see Jan 20 22:01:02 volumio node[1791]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:02 volumio node[1791]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:02 volumio node[1791]: *** WARNING *** For more information see Jan 20 22:01:02 volumio node[1791]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:02 volumio node[1791]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:02 volumio volumio[1791]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 20 22:01:02 volumio node[1791]: *** WARNING *** For more information see Jan 20 22:01:02 volumio volumio[1791]: info: Discovery: Started advertising with name: Volumio Jan 20 22:01:02 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "squeezelite_mc"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "outputs"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "albumart"... Jan 20 22:01:02 volumio volumio[1791]: info: Plugin example_plugin is not enabled Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "inputs"... Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "updater_comm"... Jan 20 22:01:02 volumio volumio[1791]: info: Plugin mpdemulation is not enabled Jan 20 22:01:02 volumio volumio[1791]: info: Loading plugin "rest_api"... Jan 20 22:01:03 volumio volumio[1791]: info: Loading plugin "websocket"... Jan 20 22:01:03 volumio volumio[1791]: info: Starting Socket.io Server version 2.3.0 Jan 20 22:01:03 volumio volumio[1791]: info: Loading plugin "RoonBridge"... Jan 20 22:01:03 volumio volumio[1791]: Forking 3 albumart workers Jan 20 22:01:03 volumio volumio-time-update[711]: volumio-time-update-util: Fetching time from Volumio... Jan 20 22:01:03 volumio volumio[1791]: info: Applying required configuration parameters for plugin RoonBridge Jan 20 22:01:03 volumio volumio-time-update[711]: volumio-time-update-util: Date not found in response Jan 20 22:01:03 volumio volumio-time-update[711]: volumio-time-update-util: Retrying in 5 seconds... Jan 20 22:01:03 volumio volumio[1791]: info: Loading i18n strings for locale ru Jan 20 22:01:03 volumio volumio[1791]: Updating browse sources language Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::initPlayerControls Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: Express server listening on port 3000 Jan 20 22:01:03 volumio volumio[1791]: [Metrics] WebUI: 1s 127.23ms Jan 20 22:01:03 volumio volumio[1791]: info: Setting Device type: x86 Jan 20 22:01:03 volumio volumio[1791]: info: CoreStateMachine::resetVolumioState Jan 20 22:01:03 volumio volumio[1791]: info: CoreStateMachine::getcurrentVolume Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 20 22:01:03 volumio volumio[1791]: info: Completed loading Core Plugins Jan 20 22:01:03 volumio volumio[1791]: info: Preparing to generate the ALSA configuration file Jan 20 22:01:03 volumio volumio[1791]: info: Volumio Network Manager: Network status updated: 0 Jan 20 22:01:03 volumio volumio[1791]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Jan 20 22:01:03 volumio volumio[1791]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jan 20 22:01:03 volumio volumio[1791]: wlan0 Interface doesn't support scanning. Jan 20 22:01:03 volumio volumio[1791]: info: Cannot use regular scanning, forcing with ap-force Jan 20 22:01:03 volumio sudo[1889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jan 20 22:01:03 volumio sudo[1889]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:03 volumio volumio[1791]: Starting albumart workers Jan 20 22:01:03 volumio sudo[1889]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:03 volumio volumio[1791]: command failed: No such device (-19) Jan 20 22:01:03 volumio volumio[1791]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jan 20 22:01:03 volumio volumio[1791]: command failed: No such device (-19) Jan 20 22:01:03 volumio volumio[1791]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 20 22:01:03 volumio volumio[1791]: Starting albumart workers Jan 20 22:01:03 volumio volumio[1791]: Starting albumart workers Jan 20 22:01:03 volumio volumio[1791]: info: Reloading queue from file Jan 20 22:01:03 volumio volumio[1791]: info: CoreStateMachine::setRepeat null single undefined Jan 20 22:01:03 volumio volumio[1791]: info: CoreStateMachine::pushState Jan 20 22:01:03 volumio volumio[1791]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:03 volumio volumio[1791]: info: CoreStateMachine::setRandom null Jan 20 22:01:03 volumio volumio[1791]: info: CoreStateMachine::pushState Jan 20 22:01:03 volumio volumio[1791]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:03 volumio volumio[1791]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:01:03 volumio volumio[1791]: info: CoreStateMachine::pushState Jan 20 22:01:03 volumio volumio[1791]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:03 volumio volumio[1791]: info: CoreStateMachine::updateTrackBlock Jan 20 22:01:03 volumio volumio[1791]: info: CorePlayQueue::getTrackBlock Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:01:03 volumio volumio[1791]: info: Asound.conf file unchanged, so no further update is needed Jan 20 22:01:03 volumio volumio[1791]: info: Output device has changed, restarting MPD Jan 20 22:01:03 volumio sudo[1901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:01:03 volumio volumio[1791]: info: Output device has changed, restarting Shairport Sync Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:03 volumio sudo[1901]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:03 volumio sudo[1901]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:03 volumio sudo[1903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:01:03 volumio sudo[1903]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:03 volumio systemd[1]: Stopping Music Player Daemon... Jan 20 22:01:03 volumio volumio[1791]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:01:03 volumio volumio[1791]: info: ___________ START PLUGINS ___________ Jan 20 22:01:03 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:01:03 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:01:03 volumio volumio[1791]: info: ControllerMpd::onStart: Initializing MPD Jan 20 22:01:03 volumio volumio[1791]: info: Creating MPD Configuration file Jan 20 22:01:03 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:01:03 volumio sudo[1927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:01:03 volumio sudo[1927]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:01:03 volumio volumio[1791]: info: [1737385263428] CoreMusicLibrary::Adding element Медиа-серверы Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:03 volumio sudo[1927]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:03 volumio sudo[1930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:01:03 volumio sudo[1930]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:03 volumio sudo[1921]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 20 22:01:03 volumio sudo[1921]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:03 volumio sudo[1921]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:03 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 20 22:01:03 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:01:03 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:01:03 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:01:03 volumio volumio[1791]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:01:03 volumio volumio[1791]: info: [1737385263471] CoreMusicLibrary::Adding element Last_100 Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:01:03 volumio volumio[1791]: info: [1737385263472] CoreMusicLibrary::Adding element Webradio Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:01:03 volumio volumio[1791]: info: Initializing BBC Radios Jan 20 22:01:03 volumio sudo[1943]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 20 22:01:03 volumio sudo[1943]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:03 volumio sudo[1943]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: [squeezelite_mc] Starting proxy server... Jan 20 22:01:03 volumio volumio[1791]: info: Volumio Calling Home Jan 20 22:01:03 volumio sudo[1960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Jan 20 22:01:03 volumio sudo[1960]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:03 volumio sudo[1960]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:03 volumio volumio[1791]: info: [squeezelite_mc] Proxy server started on port 40091 Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:01:03 volumio volumio[1791]: Unhandled rejection Error: No sockets available, cannot start. Jan 20 22:01:03 volumio volumio[1791]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Jan 20 22:01:03 volumio volumio[1791]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Jan 20 22:01:03 volumio volumio[1791]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Jan 20 22:01:03 volumio volumio[1791]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Jan 20 22:01:03 volumio volumio[1791]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Jan 20 22:01:03 volumio volumio[1791]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Jan 20 22:01:03 volumio volumio[1791]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Jan 20 22:01:03 volumio volumio[1791]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Jan 20 22:01:03 volumio volumio[1791]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Jan 20 22:01:03 volumio volumio[1791]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Jan 20 22:01:03 volumio volumio[1791]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Jan 20 22:01:03 volumio volumio[1791]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Jan 20 22:01:03 volumio volumio[1791]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Jan 20 22:01:03 volumio volumio[1791]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Jan 20 22:01:03 volumio volumio[1791]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Jan 20 22:01:03 volumio volumio[1791]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 20 22:01:03 volumio volumio[1791]: info: MPD Permissions set Jan 20 22:01:03 volumio volumio[1791]: info: MPD Permissions set Jan 20 22:01:03 volumio volumio[1791]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jan 20 22:01:03 volumio volumio[1791]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:01:03 volumio volumio[1791]: info: CoreStateMachine::pushState Jan 20 22:01:03 volumio volumio[1791]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:01:03 volumio volumio[1791]: info: CoreStateMachine::pushState Jan 20 22:01:03 volumio volumio[1791]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:03 volumio volumio[1791]: info: [squeezelite_mc] Server discovery started Jan 20 22:01:03 volumio volumio[1791]: info: [squeezelite_mc] Player finder started Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:03 volumio volumio[1791]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 20 22:01:03 volumio volumio[1791]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:01:03 volumio volumio[1791]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 20 22:01:03 volumio volumio[1791]: at doSend (dgram.js:714:16) Jan 20 22:01:03 volumio volumio[1791]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Jan 20 22:01:03 volumio volumio[1791]: at afterDns (dgram.js:660:5) Jan 20 22:01:03 volumio volumio[1791]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Jan 20 22:01:03 volumio volumio[1791]: errno: -101, Jan 20 22:01:03 volumio volumio[1791]: code: 'ENETUNREACH', Jan 20 22:01:03 volumio volumio[1791]: syscall: 'send', Jan 20 22:01:03 volumio volumio[1791]: address: '255.255.255.255', Jan 20 22:01:03 volumio volumio[1791]: port: 3483 Jan 20 22:01:03 volumio volumio[1791]: } Jan 20 22:01:03 volumio volumio[1791]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:01:03 volumio sudo[1991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 22:00 Jan 20 22:01:03 volumio sudo[1991]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:03 volumio mpd[1950]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 20 22:01:03 volumio mpd[1950]: output: No 'audio_output' defined in config file Jan 20 22:01:03 volumio mpd[1950]: couldn't open play stream: No such file or directory Jan 20 22:01:03 volumio mpd[1950]: sndio_output: Error opening default sndio device Jan 20 22:01:03 volumio mpd[1950]: output: Successfully detected a alsa audio device Jan 20 22:01:03 volumio mpd[1950]: zeroconf: No global port, disabling zeroconf Jan 20 22:01:03 volumio systemd[1]: Started Music Player Daemon. Jan 20 22:01:03 volumio sudo[1903]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:03 volumio sudo[1930]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:03 volumio sudo[1991]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:03 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 20 22:01:03 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 20 22:01:03 volumio systemd[1]: Started dynamicswap service. Jan 20 22:01:03 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:01:04 volumio volumio-remote-updater[709]: [2025-01-20 22:01:04] [info] asio async_connect error: system:111 (Connection refused) Jan 20 22:01:04 volumio volumio-remote-updater[709]: [2025-01-20 22:01:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 20 22:01:04 volumio volumio-remote-updater[709]: [2025-01-20 22:01:04] [error] handle_connect error: Underlying Transport Error Jan 20 22:01:04 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 20 22:01:04 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. Jan 20 22:01:04 volumio systemd[1]: Started dynamicswap service. Jan 20 22:01:04 volumio systemd[1]: Stopped Volumio Backend Module. Jan 20 22:01:04 volumio systemd[1]: Started Volumio Backend Module. Jan 20 22:01:04 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:01:04 volumio mpd[1950]: mixer: Failed to read mixer for 'default detected output': no such mixer control: PCM Jan 20 22:01:04 volumio volumio[2007]: info: ------------------------------------------- Jan 20 22:01:04 volumio volumio[2007]: info: ----- Volumio3 ---- Jan 20 22:01:04 volumio volumio[2007]: info: ------------------------------------------- Jan 20 22:01:04 volumio volumio[2007]: info: ----- System startup ---- Jan 20 22:01:04 volumio volumio[2007]: info: ------------------------------------------- Jan 20 22:01:04 volumio volumio[2007]: info: MYVOLUMIO Environment detected Jan 20 22:01:04 volumio volumio[2007]: info: Plugin folders cleanup Jan 20 22:01:04 volumio volumio[2007]: info: Scanning into folder /volumio/app/plugins/ Jan 20 22:01:04 volumio volumio[2007]: info: Scanning category audio_interface Jan 20 22:01:04 volumio volumio[2007]: info: Scanning category miscellanea Jan 20 22:01:04 volumio volumio[2007]: info: Scanning category music_service Jan 20 22:01:04 volumio volumio[2007]: info: Scanning category plugins.json Jan 20 22:01:04 volumio volumio[2007]: info: Scanning category system_controller Jan 20 22:01:04 volumio volumio[2007]: info: Scanning category user_interface Jan 20 22:01:04 volumio volumio[2007]: info: Scanning into folder /data/plugins/ Jan 20 22:01:04 volumio volumio[2007]: info: Scanning category music_service Jan 20 22:01:04 volumio volumio[2007]: info: Plugin folders cleanup completed Jan 20 22:01:04 volumio volumio[2007]: info: ------------------------------------------- Jan 20 22:01:04 volumio volumio[2007]: info: ----- Core plugins startup ---- Jan 20 22:01:04 volumio volumio[2007]: info: ------------------------------------------- Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugins from folder /volumio/app/plugins/ Jan 20 22:01:04 volumio volumio[2007]: info: Adding plugin upnp to MyMusic Plugins Jan 20 22:01:04 volumio volumio[2007]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 20 22:01:04 volumio volumio[2007]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugins from folder /data/plugins/ Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugin "system"... Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugin "appearance"... Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugin "network"... Jan 20 22:01:04 volumio volumio[2007]: info: Refreshing Cached IP Addresses Jan 20 22:01:04 volumio sudo[2036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 22:01:04 volumio sudo[2036]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:04 volumio sudo[2036]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:04 volumio sudo[2038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 22:01:04 volumio sudo[2038]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugin "services"... Jan 20 22:01:04 volumio sudo[2038]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugin "alsa_controller"... Jan 20 22:01:04 volumio sudo[2053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 20 22:01:04 volumio sudo[2053]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:04 volumio sudo[2053]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:04 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugin "wizard"... Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugin "networkfs"... Jan 20 22:01:04 volumio volumio[2007]: info: Starting Udev Watcher for removable devices Jan 20 22:01:04 volumio sudo[2068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Tor,password=Tor,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.88.45/share/music HI-RES /mnt/NAS/NAS Jan 20 22:01:04 volumio sudo[2068]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:04 volumio volumio[2007]: info: Ignoring mount for partition: boot Jan 20 22:01:04 volumio volumio[2007]: info: Ignoring mount for partition: volumio Jan 20 22:01:04 volumio volumio[2007]: info: Ignoring mount for partition: volumio_data Jan 20 22:01:04 volumio sudo[2068]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:04 volumio kernel: CIFS: Attempting to mount //192.168.88.45/share/music HI-RES Jan 20 22:01:04 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 20 22:01:04 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jan 20 22:01:04 volumio volumio[2007]: info: Ignoring mount for partition: 31053A8908D2D207 Jan 20 22:01:04 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugin "volumio_command_line_client"... Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugin "upnp"... Jan 20 22:01:04 volumio volumio[2007]: info: [1737385264985] Starting Upmpd Daemon Jan 20 22:01:04 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugin "my_music"... Jan 20 22:01:04 volumio volumio[2007]: info: Loading plugin "mpd"... Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "upnp_browser"... Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "alarm-clock"... Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "airplay_emulation"... Jan 20 22:01:05 volumio volumio[2007]: info: Starting Shairport Sync Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "last_100"... Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "webradio"... Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "i2s_dacs"... Jan 20 22:01:05 volumio volumio[2007]: info: I2S DAC not set, start Auto-detection Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "volumiodiscovery"... Jan 20 22:01:05 volumio volumio[2007]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:05 volumio volumio[2007]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:05 volumio volumio[2007]: *** WARNING *** For more information see Jan 20 22:01:05 volumio volumio[2007]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:05 volumio node[2007]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:05 volumio volumio[2007]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:05 volumio volumio[2007]: *** WARNING *** For more information see Jan 20 22:01:05 volumio node[2007]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:05 volumio node[2007]: *** WARNING *** For more information see Jan 20 22:01:05 volumio node[2007]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:01:05 volumio node[2007]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:01:05 volumio node[2007]: *** WARNING *** For more information see Jan 20 22:01:05 volumio volumio[2007]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 20 22:01:05 volumio volumio[2007]: info: Discovery: Started advertising with name: Volumio Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "squeezelite_mc"... Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "outputs"... Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "albumart"... Jan 20 22:01:05 volumio volumio[2007]: info: Plugin example_plugin is not enabled Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "inputs"... Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "updater_comm"... Jan 20 22:01:05 volumio volumio[2007]: info: Plugin mpdemulation is not enabled Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "rest_api"... Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "websocket"... Jan 20 22:01:05 volumio volumio[2007]: info: Starting Socket.io Server version 2.3.0 Jan 20 22:01:05 volumio volumio[2007]: info: Loading plugin "RoonBridge"... Jan 20 22:01:05 volumio volumio[2007]: Forking 3 albumart workers Jan 20 22:01:05 volumio volumio[2007]: info: Applying required configuration parameters for plugin RoonBridge Jan 20 22:01:05 volumio volumio[2007]: info: Loading i18n strings for locale ru Jan 20 22:01:05 volumio volumio[2007]: Updating browse sources language Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::initPlayerControls Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: Express server listening on port 3000 Jan 20 22:01:05 volumio volumio[2007]: [Metrics] WebUI: 1s 122.99ms Jan 20 22:01:05 volumio volumio[2007]: info: Setting Device type: x86 Jan 20 22:01:05 volumio volumio[2007]: info: CoreStateMachine::resetVolumioState Jan 20 22:01:05 volumio volumio[2007]: info: CoreStateMachine::getcurrentVolume Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 20 22:01:05 volumio volumio[2007]: info: Completed loading Core Plugins Jan 20 22:01:05 volumio volumio[2007]: Starting albumart workers Jan 20 22:01:05 volumio volumio[2007]: info: Preparing to generate the ALSA configuration file Jan 20 22:01:05 volumio volumio[2007]: Starting albumart workers Jan 20 22:01:05 volumio volumio[2007]: Starting albumart workers Jan 20 22:01:05 volumio volumio[2007]: info: Volumio Network Manager: Network status updated: 0 Jan 20 22:01:05 volumio volumio[2007]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Jan 20 22:01:05 volumio volumio[2007]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jan 20 22:01:05 volumio volumio[2007]: wlan0 Interface doesn't support scanning. Jan 20 22:01:05 volumio volumio[2007]: info: Cannot use regular scanning, forcing with ap-force Jan 20 22:01:05 volumio sudo[2107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jan 20 22:01:05 volumio sudo[2107]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:05 volumio sudo[2107]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:05 volumio volumio[2007]: command failed: No such device (-19) Jan 20 22:01:05 volumio volumio[2007]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jan 20 22:01:05 volumio volumio[2007]: command failed: No such device (-19) Jan 20 22:01:05 volumio volumio[2007]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 20 22:01:05 volumio volumio[2007]: info: Reloading queue from file Jan 20 22:01:05 volumio volumio[2007]: info: CoreStateMachine::setRepeat null single undefined Jan 20 22:01:05 volumio volumio[2007]: info: CoreStateMachine::pushState Jan 20 22:01:05 volumio volumio[2007]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:05 volumio volumio[2007]: info: CoreStateMachine::setRandom null Jan 20 22:01:05 volumio volumio[2007]: info: CoreStateMachine::pushState Jan 20 22:01:05 volumio volumio[2007]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:05 volumio volumio[2007]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:01:05 volumio volumio[2007]: info: CoreStateMachine::pushState Jan 20 22:01:05 volumio volumio[2007]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:05 volumio volumio[2007]: info: CoreStateMachine::updateTrackBlock Jan 20 22:01:05 volumio volumio[2007]: info: CorePlayQueue::getTrackBlock Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:01:05 volumio volumio[2007]: info: Asound.conf file unchanged, so no further update is needed Jan 20 22:01:05 volumio volumio[2007]: info: Output device has changed, restarting MPD Jan 20 22:01:05 volumio volumio[2007]: info: Output device has changed, restarting Shairport Sync Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:05 volumio sudo[2134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:01:05 volumio sudo[2134]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:05 volumio sudo[2140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:01:05 volumio sudo[2140]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:05 volumio sudo[2134]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:05 volumio systemd[1]: Stopping Music Player Daemon... Jan 20 22:01:05 volumio volumio[2007]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:01:05 volumio volumio[2007]: info: ___________ START PLUGINS ___________ Jan 20 22:01:05 volumio volumio[2007]: info: ControllerMpd::onStart: Initializing MPD Jan 20 22:01:05 volumio volumio[2007]: info: Creating MPD Configuration file Jan 20 22:01:05 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:01:05 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:01:05 volumio sudo[2152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:01:05 volumio sudo[2152]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:05 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:01:05 volumio volumio[2007]: info: [1737385265753] CoreMusicLibrary::Adding element Медиа-серверы Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:05 volumio sudo[2152]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:05 volumio sudo[2155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:01:05 volumio sudo[2155]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:05 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 20 22:01:05 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:01:05 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:01:05 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:01:05 volumio volumio[2007]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:05 volumio sudo[2158]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 20 22:01:05 volumio volumio[2007]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:01:05 volumio sudo[2158]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:01:05 volumio volumio[2007]: info: [1737385265793] CoreMusicLibrary::Adding element Last_100 Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:01:05 volumio volumio[2007]: info: [1737385265794] CoreMusicLibrary::Adding element Webradio Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:01:05 volumio sudo[2158]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:05 volumio volumio[2007]: info: Initializing BBC Radios Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: [squeezelite_mc] Starting proxy server... Jan 20 22:01:05 volumio volumio[2007]: info: Volumio Calling Home Jan 20 22:01:05 volumio sudo[2177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Jan 20 22:01:05 volumio sudo[2177]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:05 volumio sudo[2177]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:05 volumio volumio[2007]: info: [squeezelite_mc] Proxy server started on port 41197 Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:01:05 volumio volumio[2007]: Unhandled rejection Error: No sockets available, cannot start. Jan 20 22:01:05 volumio volumio[2007]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Jan 20 22:01:05 volumio volumio[2007]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Jan 20 22:01:05 volumio volumio[2007]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Jan 20 22:01:05 volumio volumio[2007]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Jan 20 22:01:05 volumio volumio[2007]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Jan 20 22:01:05 volumio volumio[2007]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Jan 20 22:01:05 volumio volumio[2007]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Jan 20 22:01:05 volumio volumio[2007]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Jan 20 22:01:05 volumio volumio[2007]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Jan 20 22:01:05 volumio volumio[2007]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Jan 20 22:01:05 volumio volumio[2007]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Jan 20 22:01:05 volumio volumio[2007]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Jan 20 22:01:05 volumio volumio[2007]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Jan 20 22:01:05 volumio volumio[2007]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Jan 20 22:01:05 volumio volumio[2007]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Jan 20 22:01:05 volumio volumio[2007]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 20 22:01:05 volumio volumio[2007]: info: MPD Permissions set Jan 20 22:01:05 volumio volumio[2007]: info: MPD Permissions set Jan 20 22:01:05 volumio volumio[2007]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jan 20 22:01:05 volumio volumio[2007]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:01:05 volumio volumio[2007]: info: CoreStateMachine::pushState Jan 20 22:01:05 volumio volumio[2007]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: VolumeController:: Volume=18 Mute =false Jan 20 22:01:05 volumio volumio[2007]: info: CoreStateMachine::pushState Jan 20 22:01:05 volumio volumio[2007]: info: CorePlayQueue::getTrack 0 Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::volumioPushState Jan 20 22:01:05 volumio volumio[2007]: info: [squeezelite_mc] Server discovery started Jan 20 22:01:05 volumio volumio[2007]: info: [squeezelite_mc] Player finder started Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:01:05 volumio volumio[2007]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 20 22:01:05 volumio volumio[2007]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:01:05 volumio volumio[2007]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 20 22:01:05 volumio volumio[2007]: at doSend (dgram.js:714:16) Jan 20 22:01:05 volumio volumio[2007]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Jan 20 22:01:05 volumio volumio[2007]: at afterDns (dgram.js:660:5) Jan 20 22:01:05 volumio volumio[2007]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Jan 20 22:01:05 volumio volumio[2007]: errno: -101, Jan 20 22:01:05 volumio volumio[2007]: code: 'ENETUNREACH', Jan 20 22:01:05 volumio volumio[2007]: syscall: 'send', Jan 20 22:01:05 volumio volumio[2007]: address: '255.255.255.255', Jan 20 22:01:05 volumio volumio[2007]: port: 3483 Jan 20 22:01:05 volumio volumio[2007]: } Jan 20 22:01:05 volumio volumio[2007]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:01:06 volumio mpd[2165]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 20 22:01:06 volumio mpd[2165]: output: No 'audio_output' defined in config file Jan 20 22:01:06 volumio mpd[2165]: couldn't open play stream: No such file or directory Jan 20 22:01:06 volumio mpd[2165]: sndio_output: Error opening default sndio device Jan 20 22:01:06 volumio mpd[2165]: output: Successfully detected a alsa audio device Jan 20 22:01:06 volumio mpd[2165]: zeroconf: No global port, disabling zeroconf Jan 20 22:01:06 volumio systemd[1]: Started Music Player Daemon. Jan 20 22:01:06 volumio sudo[2140]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:06 volumio sudo[2155]: pam_unix(sudo:session): session closed for user root Jan 20 22:01:06 volumio sudo[2210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 22:00 Jan 20 22:01:06 volumio sudo[2210]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:01:06 volumio dhcpcd[873]: eth0: leased 192.168.88.22 for 1800 seconds Jan 20 22:01:06 volumio dhcpcd[873]: eth0: adding route to 192.168.88.0/24 Jan 20 22:01:06 volumio dhcpcd[873]: eth0: adding default route via 192.168.88.1 Jan 20 22:01:06 volumio avahi-daemon[718]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.88.22. Jan 20 22:01:06 volumio avahi-daemon[718]: New relevant interface eth0.IPv4 for mDNS. Jan 20 22:01:06 volumio avahi-daemon[718]: Registering new address record for 192.168.88.22 on eth0.IPv4. PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"