-- Logs begin at Tue 2024-10-29 17:31:28 UTC, end at Tue 2024-10-29 17:31:52 UTC. -- Oct 29 17:31:28 volumio-x86 kernel: Linux version 5.10.165-volumio (x86@busteros) (gcc (Debian 8.3.0-6) 8.3.0, GNU ld (GNU Binutils for Debian) 2.31.1) #1 SMP Tue Jan 31 19:07:10 CET 2023 Oct 29 17:31:28 volumio-x86 kernel: Command line: BOOT_IMAGE=vmlinuz biosdevname=0 splash plymouth.ignore-serial-consoles quiet ro rootwait imgpart=UUID=991616eb-1b6c-4a8c-a9f4-cc1f6af606da bootpart=UUID=5579-66E1 datapart=UUID=89f714e8-341f-4374-b4c6-7f751323a8c5 imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor use_kmsg=yes net.ifnames=0 loglevel=0 initrd=volumio.initrd Oct 29 17:31:28 volumio-x86 kernel: KERNEL supported cpus: Oct 29 17:31:28 volumio-x86 kernel: Intel GenuineIntel Oct 29 17:31:28 volumio-x86 kernel: AMD AuthenticAMD Oct 29 17:31:28 volumio-x86 kernel: Hygon HygonGenuine Oct 29 17:31:28 volumio-x86 kernel: Centaur CentaurHauls Oct 29 17:31:28 volumio-x86 kernel: zhaoxin Shanghai Oct 29 17:31:28 volumio-x86 kernel: x86/fpu: x87 FPU will use FXSAVE Oct 29 17:31:28 volumio-x86 kernel: BIOS-provided physical RAM map: Oct 29 17:31:28 volumio-x86 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Oct 29 17:31:28 volumio-x86 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Oct 29 17:31:28 volumio-x86 kernel: BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved Oct 29 17:31:28 volumio-x86 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000007f7affff] usable Oct 29 17:31:28 volumio-x86 kernel: BIOS-e820: [mem 0x000000007f7b0000-0x000000007f7bffff] ACPI data Oct 29 17:31:28 volumio-x86 kernel: BIOS-e820: [mem 0x000000007f7c0000-0x000000007f7effff] ACPI NVS Oct 29 17:31:28 volumio-x86 kernel: BIOS-e820: [mem 0x000000007f7f0000-0x000000007f7fffff] reserved Oct 29 17:31:28 volumio-x86 kernel: BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved Oct 29 17:31:28 volumio-x86 kernel: BIOS-e820: [mem 0x00000000ffb00000-0x00000000ffffffff] reserved Oct 29 17:31:28 volumio-x86 kernel: NX (Execute Disable) protection: active Oct 29 17:31:28 volumio-x86 kernel: SMBIOS 2.4 present. Oct 29 17:31:28 volumio-x86 kernel: DMI: System manufacturer N4L-VM-ASUS-DH/N4L-VM DH, BIOS 0905 02/27/2007 Oct 29 17:31:28 volumio-x86 kernel: tsc: Fast TSC calibration using PIT Oct 29 17:31:28 volumio-x86 kernel: tsc: Detected 1666.524 MHz processor Oct 29 17:31:28 volumio-x86 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 29 17:31:28 volumio-x86 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 29 17:31:28 volumio-x86 kernel: last_pfn = 0x7f7b0 max_arch_pfn = 0x400000000 Oct 29 17:31:28 volumio-x86 kernel: MTRR default type: uncachable Oct 29 17:31:28 volumio-x86 kernel: MTRR fixed ranges enabled: Oct 29 17:31:28 volumio-x86 kernel: 00000-9FFFF write-back Oct 29 17:31:28 volumio-x86 kernel: A0000-DFFFF uncachable Oct 29 17:31:28 volumio-x86 kernel: E0000-EFFFF write-through Oct 29 17:31:28 volumio-x86 kernel: F0000-FFFFF write-protect Oct 29 17:31:28 volumio-x86 kernel: MTRR variable ranges enabled: Oct 29 17:31:28 volumio-x86 kernel: 0 base 000000000 mask F80000000 write-back Oct 29 17:31:28 volumio-x86 kernel: 1 base 07F800000 mask FFF800000 uncachable Oct 29 17:31:28 volumio-x86 kernel: 2 disabled Oct 29 17:31:28 volumio-x86 kernel: 3 disabled Oct 29 17:31:28 volumio-x86 kernel: 4 disabled Oct 29 17:31:28 volumio-x86 kernel: 5 disabled Oct 29 17:31:28 volumio-x86 kernel: 6 disabled Oct 29 17:31:28 volumio-x86 kernel: 7 disabled Oct 29 17:31:28 volumio-x86 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 29 17:31:28 volumio-x86 kernel: found SMP MP-table at [mem 0x000ff780-0x000ff78f] Oct 29 17:31:28 volumio-x86 kernel: RAMDISK: [mem 0x7c48a000-0x7f7affff] Oct 29 17:31:28 volumio-x86 kernel: ACPI: Early table checksum verification disabled Oct 29 17:31:28 volumio-x86 kernel: ACPI: RSDP 0x00000000000FA550 000014 (v00 ACPIAM) Oct 29 17:31:28 volumio-x86 kernel: ACPI: RSDT 0x000000007F7B0000 000040 (v01 A_M_I OEMRSDT 02000727 MSFT 00000097) Oct 29 17:31:28 volumio-x86 kernel: ACPI: FACP 0x000000007F7B0200 000084 (v02 A_M_I OEMFACP 02000727 MSFT 00000097) Oct 29 17:31:28 volumio-x86 kernel: ACPI: DSDT 0x000000007F7B0430 0099C3 (v01 A0465 A0465000 00000000 INTL 20060113) Oct 29 17:31:28 volumio-x86 kernel: ACPI: FACS 0x000000007F7C0000 000040 Oct 29 17:31:28 volumio-x86 kernel: ACPI: APIC 0x000000007F7B0390 00005C (v01 A_M_I OEMAPIC 02000727 MSFT 00000097) Oct 29 17:31:28 volumio-x86 kernel: ACPI: MCFG 0x000000007F7B03F0 00003C (v01 A_M_I OEMMCFG 02000727 MSFT 00000097) Oct 29 17:31:28 volumio-x86 kernel: ACPI: OEMB 0x000000007F7C0040 000060 (v01 A_M_I AMI_OEM 02000727 MSFT 00000097) Oct 29 17:31:28 volumio-x86 kernel: ACPI: HPET 0x000000007F7B9E00 000038 (v01 A_M_I OEMHPET 02000727 MSFT 00000097) Oct 29 17:31:28 volumio-x86 kernel: ACPI: SSDT 0x000000007F7C00A0 000688 (v01 AMI CPU1PM 00000001 INTL 20060113) Oct 29 17:31:28 volumio-x86 kernel: ACPI: SSDT 0x000000007F7C0730 000120 (v01 AMI CPU2PM 00000001 INTL 20060113) Oct 29 17:31:28 volumio-x86 kernel: ACPI: Reserving FACP table memory at [mem 0x7f7b0200-0x7f7b0283] Oct 29 17:31:28 volumio-x86 kernel: ACPI: Reserving DSDT table memory at [mem 0x7f7b0430-0x7f7b9df2] Oct 29 17:31:28 volumio-x86 kernel: ACPI: Reserving FACS table memory at [mem 0x7f7c0000-0x7f7c003f] Oct 29 17:31:28 volumio-x86 kernel: ACPI: Reserving APIC table memory at [mem 0x7f7b0390-0x7f7b03eb] Oct 29 17:31:28 volumio-x86 kernel: ACPI: Reserving MCFG table memory at [mem 0x7f7b03f0-0x7f7b042b] Oct 29 17:31:28 volumio-x86 kernel: ACPI: Reserving OEMB table memory at [mem 0x7f7c0040-0x7f7c009f] Oct 29 17:31:28 volumio-x86 kernel: ACPI: Reserving HPET table memory at [mem 0x7f7b9e00-0x7f7b9e37] Oct 29 17:31:28 volumio-x86 kernel: ACPI: Reserving SSDT table memory at [mem 0x7f7c00a0-0x7f7c0727] Oct 29 17:31:28 volumio-x86 kernel: ACPI: Reserving SSDT table memory at [mem 0x7f7c0730-0x7f7c084f] Oct 29 17:31:28 volumio-x86 kernel: ACPI: Local APIC address 0xfee00000 Oct 29 17:31:28 volumio-x86 kernel: Zone ranges: Oct 29 17:31:28 volumio-x86 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 29 17:31:28 volumio-x86 kernel: DMA32 [mem 0x0000000001000000-0x000000007f7affff] Oct 29 17:31:28 volumio-x86 kernel: Normal empty Oct 29 17:31:28 volumio-x86 kernel: Movable zone start for each node Oct 29 17:31:28 volumio-x86 kernel: Early memory node ranges Oct 29 17:31:28 volumio-x86 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Oct 29 17:31:28 volumio-x86 kernel: node 0: [mem 0x0000000000100000-0x000000007f7affff] Oct 29 17:31:28 volumio-x86 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007f7affff] Oct 29 17:31:28 volumio-x86 kernel: On node 0 totalpages: 522062 Oct 29 17:31:28 volumio-x86 kernel: DMA zone: 64 pages used for memmap Oct 29 17:31:28 volumio-x86 kernel: DMA zone: 21 pages reserved Oct 29 17:31:28 volumio-x86 kernel: DMA zone: 3998 pages, LIFO batch:0 Oct 29 17:31:28 volumio-x86 kernel: DMA32 zone: 8095 pages used for memmap Oct 29 17:31:28 volumio-x86 kernel: DMA32 zone: 518064 pages, LIFO batch:63 Oct 29 17:31:28 volumio-x86 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 29 17:31:28 volumio-x86 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Oct 29 17:31:28 volumio-x86 kernel: On node 0, zone DMA32: 2128 pages in unavailable ranges Oct 29 17:31:28 volumio-x86 kernel: Reserving Intel graphics memory at [mem 0x7f800000-0x7fffffff] Oct 29 17:31:28 volumio-x86 kernel: ACPI: PM-Timer IO Port: 0x808 Oct 29 17:31:28 volumio-x86 kernel: ACPI: Local APIC address 0xfee00000 Oct 29 17:31:28 volumio-x86 kernel: IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23 Oct 29 17:31:28 volumio-x86 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Oct 29 17:31:28 volumio-x86 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 29 17:31:28 volumio-x86 kernel: ACPI: IRQ0 used by override. Oct 29 17:31:28 volumio-x86 kernel: ACPI: IRQ9 used by override. Oct 29 17:31:28 volumio-x86 kernel: Using ACPI (MADT) for SMP configuration information Oct 29 17:31:28 volumio-x86 kernel: ACPI: HPET id: 0x8086a202 base: 0xfed00000 Oct 29 17:31:28 volumio-x86 kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs Oct 29 17:31:28 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] Oct 29 17:31:28 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x0009ffff] Oct 29 17:31:28 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000dffff] Oct 29 17:31:28 volumio-x86 kernel: PM: hibernation: Registered nosave memory: [mem 0x000e0000-0x000fffff] Oct 29 17:31:28 volumio-x86 kernel: [mem 0x80000000-0xfedfffff] available for PCI devices Oct 29 17:31:28 volumio-x86 kernel: Booting paravirtualized kernel on bare hardware Oct 29 17:31:28 volumio-x86 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Oct 29 17:31:28 volumio-x86 kernel: setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:2 nr_node_ids:1 Oct 29 17:31:28 volumio-x86 kernel: percpu: Embedded 57 pages/cpu s194328 r8192 d30952 u1048576 Oct 29 17:31:28 volumio-x86 kernel: pcpu-alloc: s194328 r8192 d30952 u1048576 alloc=1*2097152 Oct 29 17:31:28 volumio-x86 kernel: pcpu-alloc: [0] 0 1 Oct 29 17:31:28 volumio-x86 kernel: Built 1 zonelists, mobility grouping on. Total pages: 513882 Oct 29 17:31:28 volumio-x86 kernel: Kernel command line: BOOT_IMAGE=vmlinuz biosdevname=0 splash plymouth.ignore-serial-consoles quiet ro rootwait imgpart=UUID=991616eb-1b6c-4a8c-a9f4-cc1f6af606da bootpart=UUID=5579-66E1 datapart=UUID=89f714e8-341f-4374-b4c6-7f751323a8c5 imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor use_kmsg=yes net.ifnames=0 loglevel=0 initrd=volumio.initrd Oct 29 17:31:28 volumio-x86 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 29 17:31:28 volumio-x86 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Oct 29 17:31:28 volumio-x86 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 29 17:31:28 volumio-x86 kernel: Memory: 1974580K/2088248K available (12296K kernel code, 1777K rwdata, 3092K rodata, 1816K init, 2440K bss, 113412K reserved, 0K cma-reserved) Oct 29 17:31:28 volumio-x86 kernel: Kernel/User page tables isolation: enabled Oct 29 17:31:28 volumio-x86 kernel: ftrace: allocating 37299 entries in 146 pages Oct 29 17:31:28 volumio-x86 kernel: ftrace: allocated 146 pages with 3 groups Oct 29 17:31:28 volumio-x86 kernel: rcu: Hierarchical RCU implementation. Oct 29 17:31:28 volumio-x86 kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2. Oct 29 17:31:28 volumio-x86 kernel: Rude variant of Tasks RCU enabled. Oct 29 17:31:28 volumio-x86 kernel: Tracing variant of Tasks RCU enabled. Oct 29 17:31:28 volumio-x86 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Oct 29 17:31:28 volumio-x86 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 29 17:31:28 volumio-x86 kernel: NR_IRQS: 4352, nr_irqs: 440, preallocated irqs: 16 Oct 29 17:31:28 volumio-x86 kernel: Console: colour VGA+ 80x25 Oct 29 17:31:28 volumio-x86 kernel: printk: console [tty0] enabled Oct 29 17:31:28 volumio-x86 kernel: ACPI: Core revision 20200925 Oct 29 17:31:28 volumio-x86 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 133484882848 ns Oct 29 17:31:28 volumio-x86 kernel: APIC: Switch to symmetric I/O mode setup Oct 29 17:31:28 volumio-x86 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Oct 29 17:31:28 volumio-x86 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x18059fb90fc, max_idle_ns: 440795203012 ns Oct 29 17:31:28 volumio-x86 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 3333.04 BogoMIPS (lpj=6666096) Oct 29 17:31:28 volumio-x86 kernel: pid_max: default: 32768 minimum: 301 Oct 29 17:31:28 volumio-x86 kernel: LSM: Security Framework initializing Oct 29 17:31:28 volumio-x86 kernel: Yama: becoming mindful. Oct 29 17:31:28 volumio-x86 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Oct 29 17:31:28 volumio-x86 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Oct 29 17:31:28 volumio-x86 kernel: mce: CPU0: Thermal monitoring enabled (TM2) Oct 29 17:31:28 volumio-x86 kernel: process: using mwait in idle threads Oct 29 17:31:28 volumio-x86 kernel: Last level iTLB entries: 4KB 128, 2MB 4, 4MB 4 Oct 29 17:31:28 volumio-x86 kernel: Last level dTLB entries: 4KB 256, 2MB 0, 4MB 32, 1GB 0 Oct 29 17:31:28 volumio-x86 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 29 17:31:28 volumio-x86 kernel: Spectre V2 : Mitigation: Retpolines Oct 29 17:31:28 volumio-x86 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Oct 29 17:31:28 volumio-x86 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Oct 29 17:31:28 volumio-x86 kernel: Speculative Store Bypass: Vulnerable Oct 29 17:31:28 volumio-x86 kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Oct 29 17:31:28 volumio-x86 kernel: MMIO Stale Data: Unknown: No mitigations Oct 29 17:31:28 volumio-x86 kernel: Freeing SMP alternatives memory: 32K Oct 29 17:31:28 volumio-x86 kernel: smpboot: CPU0: Intel(R) Core(TM)2 CPU T5500 @ 1.66GHz (family: 0x6, model: 0xf, stepping: 0x6) Oct 29 17:31:28 volumio-x86 kernel: Performance Events: PEBS fmt0-, Core2 events, 4-deep LBR, Intel PMU driver. Oct 29 17:31:28 volumio-x86 kernel: core: PEBS disabled due to CPU errata Oct 29 17:31:28 volumio-x86 kernel: ... version: 2 Oct 29 17:31:28 volumio-x86 kernel: ... bit width: 40 Oct 29 17:31:28 volumio-x86 kernel: ... generic registers: 2 Oct 29 17:31:28 volumio-x86 kernel: ... value mask: 000000ffffffffff Oct 29 17:31:28 volumio-x86 kernel: ... max period: 000000007fffffff Oct 29 17:31:28 volumio-x86 kernel: ... fixed-purpose events: 3 Oct 29 17:31:28 volumio-x86 kernel: ... event mask: 0000000700000003 Oct 29 17:31:28 volumio-x86 kernel: rcu: Hierarchical SRCU implementation. Oct 29 17:31:28 volumio-x86 kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. Oct 29 17:31:28 volumio-x86 kernel: smp: Bringing up secondary CPUs ... Oct 29 17:31:28 volumio-x86 kernel: x86: Booting SMP configuration: Oct 29 17:31:28 volumio-x86 kernel: .... node #0, CPUs: #1 Oct 29 17:31:28 volumio-x86 kernel: smp: Brought up 1 node, 2 CPUs Oct 29 17:31:28 volumio-x86 kernel: smpboot: Max logical packages: 1 Oct 29 17:31:28 volumio-x86 kernel: smpboot: Total of 2 processors activated (6666.09 BogoMIPS) Oct 29 17:31:28 volumio-x86 kernel: devtmpfs: initialized Oct 29 17:31:28 volumio-x86 kernel: x86/mm: Memory block size: 128MB Oct 29 17:31:28 volumio-x86 kernel: PM: Registering ACPI NVS region [mem 0x7f7c0000-0x7f7effff] (196608 bytes) Oct 29 17:31:28 volumio-x86 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Oct 29 17:31:28 volumio-x86 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 29 17:31:28 volumio-x86 kernel: pinctrl core: initialized pinctrl subsystem Oct 29 17:31:28 volumio-x86 kernel: NET: Registered protocol family 16 Oct 29 17:31:28 volumio-x86 kernel: audit: initializing netlink subsys (disabled) Oct 29 17:31:28 volumio-x86 kernel: audit: type=2000 audit(1730223067.160:1): state=initialized audit_enabled=0 res=1 Oct 29 17:31:28 volumio-x86 kernel: thermal_sys: Registered thermal governor 'fair_share' Oct 29 17:31:28 volumio-x86 kernel: thermal_sys: Registered thermal governor 'bang_bang' Oct 29 17:31:28 volumio-x86 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 29 17:31:28 volumio-x86 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 29 17:31:28 volumio-x86 kernel: EISA bus registered Oct 29 17:31:28 volumio-x86 kernel: cpuidle: using governor ladder Oct 29 17:31:28 volumio-x86 kernel: cpuidle: using governor menu Oct 29 17:31:28 volumio-x86 kernel: ACPI: bus type PCI registered Oct 29 17:31:28 volumio-x86 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 29 17:31:28 volumio-x86 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Oct 29 17:31:28 volumio-x86 kernel: PCI: not using MMCONFIG Oct 29 17:31:28 volumio-x86 kernel: PCI: Using configuration type 1 for base access Oct 29 17:31:28 volumio-x86 kernel: Kprobes globally optimized Oct 29 17:31:28 volumio-x86 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 29 17:31:28 volumio-x86 kernel: ACPI: Added _OSI(Module Device) Oct 29 17:31:28 volumio-x86 kernel: ACPI: Added _OSI(Processor Device) Oct 29 17:31:28 volumio-x86 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 29 17:31:28 volumio-x86 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 29 17:31:28 volumio-x86 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 29 17:31:28 volumio-x86 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 29 17:31:28 volumio-x86 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 29 17:31:28 volumio-x86 kernel: ACPI: 3 ACPI AML tables successfully acquired and loaded Oct 29 17:31:28 volumio-x86 kernel: ACPI: Dynamic OEM Table Load: Oct 29 17:31:28 volumio-x86 kernel: ACPI Error: AE_ALREADY_EXISTS, SSDT 0xFFFF888003644000 Table is already loaded (20200925/tbdata-529) Oct 29 17:31:28 volumio-x86 kernel: ACPI Error: Aborting method \_PR.CPU1._OSC due to previous error (AE_ALREADY_EXISTS) (20200925/psparse-531) Oct 29 17:31:28 volumio-x86 kernel: ACPI Error: Aborting method \_PR.CPU1._PDC due to previous error (AE_ALREADY_EXISTS) (20200925/psparse-531) Oct 29 17:31:28 volumio-x86 kernel: ACPI: Dynamic OEM Table Load: Oct 29 17:31:28 volumio-x86 kernel: ACPI Error: AE_ALREADY_EXISTS, SSDT 0xFFFF888002F91E00 Table is already loaded (20200925/tbdata-529) Oct 29 17:31:28 volumio-x86 kernel: ACPI Error: Aborting method \_PR.CPU2._OSC due to previous error (AE_ALREADY_EXISTS) (20200925/psparse-531) Oct 29 17:31:28 volumio-x86 kernel: ACPI Error: Aborting method \_PR.CPU2._PDC due to previous error (AE_ALREADY_EXISTS) (20200925/psparse-531) Oct 29 17:31:28 volumio-x86 kernel: ACPI: Interpreter enabled Oct 29 17:31:28 volumio-x86 kernel: ACPI: (supports S0 S1 S3 S4 S5) Oct 29 17:31:28 volumio-x86 kernel: ACPI: Using IOAPIC for interrupt routing Oct 29 17:31:28 volumio-x86 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Oct 29 17:31:28 volumio-x86 kernel: PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved in ACPI motherboard resources Oct 29 17:31:28 volumio-x86 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 29 17:31:28 volumio-x86 kernel: ACPI: Enabled 11 GPEs in block 00 to 1F Oct 29 17:31:28 volumio-x86 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 29 17:31:28 volumio-x86 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 29 17:31:28 volumio-x86 kernel: acpi PNP0A08:00: _OSC failed (AE_NOT_FOUND); disabling ASPM Oct 29 17:31:28 volumio-x86 kernel: PCI host bridge to bus 0000:00 Oct 29 17:31:28 volumio-x86 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Oct 29 17:31:28 volumio-x86 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Oct 29 17:31:28 volumio-x86 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Oct 29 17:31:28 volumio-x86 kernel: pci_bus 0000:00: root bus resource [mem 0x000d0000-0x000dffff window] Oct 29 17:31:28 volumio-x86 kernel: pci_bus 0000:00: root bus resource [mem 0x7f800000-0xffffffff window] Oct 29 17:31:28 volumio-x86 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:00.0: [8086:27a0] type 00 class 0x060000 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:02.0: [8086:27a2] type 00 class 0x030000 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xffa80000-0xffafffff] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:02.0: reg 0x14: [io 0xec00-0xec07] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xd0000000-0xdfffffff pref] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:02.0: reg 0x1c: [mem 0xffa40000-0xffa7ffff] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1b.0: [8086:27d8] type 00 class 0x040300 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1b.0: reg 0x10: [mem 0xffa34000-0xffa37fff 64bit] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1c.0: [8086:27d0] type 01 class 0x060400 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1c.3: [8086:27d6] type 01 class 0x060400 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1d.0: [8086:27c8] type 00 class 0x0c0300 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1d.0: reg 0x20: [io 0xd800-0xd81f] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1d.1: [8086:27c9] type 00 class 0x0c0300 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1d.1: reg 0x20: [io 0xd880-0xd89f] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1d.2: [8086:27ca] type 00 class 0x0c0300 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1d.2: reg 0x20: [io 0xdc00-0xdc1f] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1d.3: [8086:27cb] type 00 class 0x0c0300 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1d.3: reg 0x20: [io 0xe000-0xe01f] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1d.7: [8086:27cc] type 00 class 0x0c0320 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1d.7: reg 0x10: [mem 0xffa3b800-0xffa3bbff] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1e.0: [8086:2448] type 01 class 0x060401 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.0: [8086:27bd] type 00 class 0x060100 Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.0: quirk: [io 0x0800-0x087f] claimed by ICH6 ACPI/GPIO/TCO Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.0: quirk: [io 0x0480-0x04bf] claimed by ICH6 GPIO Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.0: ICH7 LPC Generic IO decode 2 PIO at 0290 (mask 0007) Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.1: [8086:27df] type 00 class 0x01018a Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.1: reg 0x10: [io 0x0000-0x0007] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.1: reg 0x14: [io 0x0000-0x0003] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.1: reg 0x18: [io 0x08f0-0x08f7] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.1: reg 0x1c: [io 0x08f8-0x08fb] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.1: reg 0x20: [io 0xffa0-0xffaf] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Oct 29 17:31:28 volumio-x86 kernel: pci 0000:00:1f.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1f.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1f.2: [8086:27c4] type 00 class 0x01018f Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1f.2: reg 0x10: [io 0xe880-0xe887] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1f.2: reg 0x14: [io 0xe800-0xe803] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1f.2: reg 0x18: [io 0xe480-0xe487] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1f.2: reg 0x1c: [io 0xe400-0xe403] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xe080-0xe08f] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xffa3bc00-0xffa3bfff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1f.2: PME# supported from D3hot Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1f.3: [8086:27da] type 00 class 0x0c0500 Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0400-0x041f] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.0: PCI bridge to [bus 02] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [mem 0xbfe00000-0xbfefffff 64bit pref] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:01:00.0: [8086:109a] type 00 class 0x020000 Oct 29 17:31:29 volumio-x86 kernel: pci 0000:01:00.0: reg 0x10: [mem 0xff7e0000-0xff7fffff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:01:00.0: reg 0x18: [io 0xcc00-0xcc1f] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:01:00.0: PME# supported from D0 D3hot D3cold Oct 29 17:31:29 volumio-x86 kernel: pci 0000:01:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force' Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.3: PCI bridge to [bus 01] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [io 0xc000-0xcfff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [mem 0xff700000-0xff7fffff] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:03: extended config space not accessible Oct 29 17:31:29 volumio-x86 kernel: pci 0000:03:03.0: [104c:8023] type 00 class 0x0c0010 Oct 29 17:31:29 volumio-x86 kernel: pci 0000:03:03.0: reg 0x10: [mem 0xff8ff800-0xff8fffff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:03:03.0: reg 0x14: [mem 0xff8f8000-0xff8fbfff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:03:03.0: supports D1 D2 Oct 29 17:31:29 volumio-x86 kernel: pci 0000:03:03.0: PME# supported from D0 D1 D2 D3hot Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1e.0: PCI bridge to [bus 03] (subtractive decode) Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1e.0: bridge window [mem 0xff800000-0xff8fffff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1e.0: bridge window [io 0x0000-0x0cf7 window] (subtractive decode) Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1e.0: bridge window [io 0x0d00-0xffff window] (subtractive decode) Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1e.0: bridge window [mem 0x000a0000-0x000bffff window] (subtractive decode) Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1e.0: bridge window [mem 0x000d0000-0x000dffff window] (subtractive decode) Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1e.0: bridge window [mem 0x7f800000-0xffffffff window] (subtractive decode) Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:00: on NUMA node 0 Oct 29 17:31:29 volumio-x86 kernel: ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 10 *11 12 14 15) Oct 29 17:31:29 volumio-x86 kernel: ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled. Oct 29 17:31:29 volumio-x86 kernel: ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 7 10 11 12 14 *15) Oct 29 17:31:29 volumio-x86 kernel: ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 *10 11 12 14 15) Oct 29 17:31:29 volumio-x86 kernel: ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled. Oct 29 17:31:29 volumio-x86 kernel: ACPI: PCI Interrupt Link [LNKF] (IRQs *3 4 5 6 7 10 11 12 14 15) Oct 29 17:31:29 volumio-x86 kernel: ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled. Oct 29 17:31:29 volumio-x86 kernel: ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 *5 6 7 10 11 12 14 15) Oct 29 17:31:29 volumio-x86 kernel: iommu: Default domain type: Translated Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Oct 29 17:31:29 volumio-x86 kernel: vgaarb: loaded Oct 29 17:31:29 volumio-x86 kernel: SCSI subsystem initialized Oct 29 17:31:29 volumio-x86 kernel: libata version 3.00 loaded. Oct 29 17:31:29 volumio-x86 kernel: ACPI: bus type USB registered Oct 29 17:31:29 volumio-x86 kernel: usbcore: registered new interface driver usbfs Oct 29 17:31:29 volumio-x86 kernel: usbcore: registered new interface driver hub Oct 29 17:31:29 volumio-x86 kernel: usbcore: registered new device driver usb Oct 29 17:31:29 volumio-x86 kernel: PCI: Using ACPI for IRQ routing Oct 29 17:31:29 volumio-x86 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 29 17:31:29 volumio-x86 kernel: Expanded resource Reserved due to conflict with PCI Bus 0000:00 Oct 29 17:31:29 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Oct 29 17:31:29 volumio-x86 kernel: e820: reserve RAM buffer [mem 0x7f7b0000-0x7fffffff] Oct 29 17:31:29 volumio-x86 kernel: hpet: 3 channels of 0 reserved for per-cpu timers Oct 29 17:31:29 volumio-x86 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Oct 29 17:31:29 volumio-x86 kernel: hpet0: 3 comparators, 64-bit 14.318180 MHz counter Oct 29 17:31:29 volumio-x86 kernel: clocksource: Switched to clocksource tsc-early Oct 29 17:31:29 volumio-x86 kernel: VFS: Disk quotas dquot_6.6.0 Oct 29 17:31:29 volumio-x86 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 29 17:31:29 volumio-x86 kernel: pnp: PnP ACPI init Oct 29 17:31:29 volumio-x86 kernel: system 00:00: [mem 0xfed13000-0xfed19fff] has been reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c01 (active) Oct 29 17:31:29 volumio-x86 kernel: pnp 00:01: Plug and Play ACPI device, IDs PNP0b00 (active) Oct 29 17:31:29 volumio-x86 kernel: system 00:02: [io 0x0290-0x0297] has been reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:02: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 29 17:31:29 volumio-x86 kernel: system 00:03: [io 0x04d0-0x04d1] has been reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:03: [io 0x0800-0x087f] has been reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:03: [io 0x0480-0x04bf] has been reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:03: [mem 0xfed1c000-0xfed1ffff] has been reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:03: [mem 0xfed20000-0xfed8ffff] has been reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:03: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 29 17:31:29 volumio-x86 kernel: system 00:04: [mem 0xffc00000-0xffefffff] has been reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:04: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 29 17:31:29 volumio-x86 kernel: system 00:05: [mem 0xfec00000-0xfec00fff] could not be reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:05: [mem 0xfee00000-0xfee00fff] has been reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:05: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 29 17:31:29 volumio-x86 kernel: pnp 00:06: Plug and Play ACPI device, IDs PNP0303 PNP030b (active) Oct 29 17:31:29 volumio-x86 kernel: system 00:07: [mem 0xe0000000-0xefffffff] has been reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:07: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 29 17:31:29 volumio-x86 kernel: system 00:08: [mem 0x00000000-0x0009ffff] could not be reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:08: [mem 0x000c0000-0x000cffff] could not be reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:08: [mem 0x000e0000-0x000fffff] could not be reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:08: [mem 0x00100000-0x7f7fffff] could not be reserved Oct 29 17:31:29 volumio-x86 kernel: system 00:08: Plug and Play ACPI device, IDs PNP0c01 (active) Oct 29 17:31:29 volumio-x86 kernel: pnp: PnP ACPI: found 9 devices Oct 29 17:31:29 volumio-x86 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 29 17:31:29 volumio-x86 kernel: NET: Registered protocol family 2 Oct 29 17:31:29 volumio-x86 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 29 17:31:29 volumio-x86 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Oct 29 17:31:29 volumio-x86 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 29 17:31:29 volumio-x86 kernel: TCP bind hash table entries: 16384 (order: 6, 262144 bytes, linear) Oct 29 17:31:29 volumio-x86 kernel: TCP: Hash tables configured (established 16384 bind 16384) Oct 29 17:31:29 volumio-x86 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Oct 29 17:31:29 volumio-x86 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Oct 29 17:31:29 volumio-x86 kernel: NET: Registered protocol family 1 Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [io 0x1000-0x0fff] to [bus 02] add_size 1000 Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [mem 0x00100000-0x000fffff] to [bus 02] add_size 200000 add_align 100000 Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 01] add_size 200000 add_align 100000 Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.0: BAR 14: assigned [mem 0x80000000-0x801fffff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.3: BAR 15: assigned [mem 0x80200000-0x803fffff 64bit pref] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.0: BAR 13: assigned [io 0x1000-0x1fff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.0: PCI bridge to [bus 02] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [io 0x1000-0x1fff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [mem 0x80000000-0x801fffff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.0: bridge window [mem 0xbfe00000-0xbfefffff 64bit pref] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.3: PCI bridge to [bus 01] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [io 0xc000-0xcfff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [mem 0xff700000-0xff7fffff] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1c.3: bridge window [mem 0x80200000-0x803fffff 64bit pref] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1e.0: PCI bridge to [bus 03] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:1e.0: bridge window [mem 0xff800000-0xff8fffff] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:00: resource 7 [mem 0x000d0000-0x000dffff window] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:00: resource 8 [mem 0x7f800000-0xffffffff window] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:02: resource 0 [io 0x1000-0x1fff] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:02: resource 1 [mem 0x80000000-0x801fffff] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:02: resource 2 [mem 0xbfe00000-0xbfefffff 64bit pref] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:01: resource 0 [io 0xc000-0xcfff] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:01: resource 1 [mem 0xff700000-0xff7fffff] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:01: resource 2 [mem 0x80200000-0x803fffff 64bit pref] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:03: resource 1 [mem 0xff800000-0xff8fffff] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:03: resource 4 [io 0x0000-0x0cf7 window] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:03: resource 5 [io 0x0d00-0xffff window] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:03: resource 6 [mem 0x000a0000-0x000bffff window] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:03: resource 7 [mem 0x000d0000-0x000dffff window] Oct 29 17:31:29 volumio-x86 kernel: pci_bus 0000:03: resource 8 [mem 0x7f800000-0xffffffff window] Oct 29 17:31:29 volumio-x86 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Oct 29 17:31:29 volumio-x86 kernel: PCI: CLS 32 bytes, default 64 Oct 29 17:31:29 volumio-x86 kernel: Trying to unpack rootfs image as initramfs... Oct 29 17:31:29 volumio-x86 kernel: Freeing initrd memory: 52376K Oct 29 17:31:29 volumio-x86 kernel: Initialise system trusted keyrings Oct 29 17:31:29 volumio-x86 kernel: workingset: timestamp_bits=46 max_order=19 bucket_order=0 Oct 29 17:31:29 volumio-x86 kernel: zbud: loaded Oct 29 17:31:29 volumio-x86 kernel: Key type asymmetric registered Oct 29 17:31:29 volumio-x86 kernel: Asymmetric key parser 'x509' registered Oct 29 17:31:29 volumio-x86 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) Oct 29 17:31:29 volumio-x86 kernel: io scheduler mq-deadline registered Oct 29 17:31:29 volumio-x86 kernel: io scheduler kyber registered Oct 29 17:31:29 volumio-x86 kernel: pcieport 0000:00:1c.0: enabling device (0106 -> 0107) Oct 29 17:31:29 volumio-x86 kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Oct 29 17:31:29 volumio-x86 kernel: intel_idle: MWAIT substates: 0x22220 Oct 29 17:31:29 volumio-x86 kernel: ACPI: \_PR_.CPU1: Found 1 idle states Oct 29 17:31:29 volumio-x86 kernel: ACPI: \_PR_.CPU2: Found 1 idle states Oct 29 17:31:29 volumio-x86 kernel: intel_idle: ACPI _CST not found or not usable Oct 29 17:31:29 volumio-x86 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 29 17:31:29 volumio-x86 kernel: ACPI: Power Button [PWRB] Oct 29 17:31:29 volumio-x86 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1 Oct 29 17:31:29 volumio-x86 kernel: ACPI: Power Button [PWRF] Oct 29 17:31:29 volumio-x86 kernel: ACPI: \_PR_.CPU1: Found 1 idle states Oct 29 17:31:29 volumio-x86 kernel: ACPI: \_PR_.CPU2: Found 1 idle states Oct 29 17:31:29 volumio-x86 kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Oct 29 17:31:29 volumio-x86 kernel: Linux agpgart interface v0.103 Oct 29 17:31:29 volumio-x86 kernel: Uniform Multi-Platform E-IDE driver Oct 29 17:31:29 volumio-x86 kernel: ide-gd driver 1.18 Oct 29 17:31:29 volumio-x86 kernel: ata_piix 0000:00:1f.1: version 2.13 Oct 29 17:31:29 volumio-x86 kernel: scsi host0: ata_piix Oct 29 17:31:29 volumio-x86 kernel: scsi host1: ata_piix Oct 29 17:31:29 volumio-x86 kernel: ata1: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0xffa0 irq 14 Oct 29 17:31:29 volumio-x86 kernel: ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0xffa8 irq 15 Oct 29 17:31:29 volumio-x86 kernel: ata_piix 0000:00:1f.2: MAP [ P0 P2 -- -- ] Oct 29 17:31:29 volumio-x86 kernel: ata2: port disabled--ignoring Oct 29 17:31:29 volumio-x86 kernel: scsi host2: ata_piix Oct 29 17:31:29 volumio-x86 kernel: scsi host3: ata_piix Oct 29 17:31:29 volumio-x86 kernel: ata3: SATA max UDMA/133 cmd 0xe880 ctl 0xe800 bmdma 0xe080 irq 19 Oct 29 17:31:29 volumio-x86 kernel: ata4: SATA max UDMA/133 cmd 0xe480 ctl 0xe400 bmdma 0xe088 irq 19 Oct 29 17:31:29 volumio-x86 kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Oct 29 17:31:29 volumio-x86 kernel: ehci-pci: EHCI PCI platform driver Oct 29 17:31:29 volumio-x86 kernel: ehci-pci 0000:00:1d.7: EHCI Host Controller Oct 29 17:31:29 volumio-x86 kernel: ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 Oct 29 17:31:29 volumio-x86 kernel: ehci-pci 0000:00:1d.7: debug port 1 Oct 29 17:31:29 volumio-x86 kernel: ehci-pci 0000:00:1d.7: cache line size of 32 is not supported Oct 29 17:31:29 volumio-x86 kernel: ehci-pci 0000:00:1d.7: irq 23, io mem 0xffa3b800 Oct 29 17:31:29 volumio-x86 kernel: ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 Oct 29 17:31:29 volumio-x86 kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10 Oct 29 17:31:29 volumio-x86 kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Oct 29 17:31:29 volumio-x86 kernel: usb usb1: Product: EHCI Host Controller Oct 29 17:31:29 volumio-x86 kernel: usb usb1: Manufacturer: Linux 5.10.165-volumio ehci_hcd Oct 29 17:31:29 volumio-x86 kernel: usb usb1: SerialNumber: 0000:00:1d.7 Oct 29 17:31:29 volumio-x86 kernel: hub 1-0:1.0: USB hub found Oct 29 17:31:29 volumio-x86 kernel: hub 1-0:1.0: 8 ports detected Oct 29 17:31:29 volumio-x86 kernel: ehci-platform: EHCI generic platform driver Oct 29 17:31:29 volumio-x86 kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Oct 29 17:31:29 volumio-x86 kernel: ohci-pci: OHCI PCI platform driver Oct 29 17:31:29 volumio-x86 kernel: ohci-platform: OHCI generic platform driver Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd: USB Universal Host Controller Interface driver Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.0: UHCI Host Controller Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.0: detected 2 ports Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.0: irq 23, io base 0x0000d800 Oct 29 17:31:29 volumio-x86 kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.10 Oct 29 17:31:29 volumio-x86 kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Oct 29 17:31:29 volumio-x86 kernel: usb usb2: Product: UHCI Host Controller Oct 29 17:31:29 volumio-x86 kernel: usb usb2: Manufacturer: Linux 5.10.165-volumio uhci_hcd Oct 29 17:31:29 volumio-x86 kernel: usb usb2: SerialNumber: 0000:00:1d.0 Oct 29 17:31:29 volumio-x86 kernel: hub 2-0:1.0: USB hub found Oct 29 17:31:29 volumio-x86 kernel: hub 2-0:1.0: 2 ports detected Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.1: UHCI Host Controller Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.1: detected 2 ports Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000d880 Oct 29 17:31:29 volumio-x86 kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.10 Oct 29 17:31:29 volumio-x86 kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Oct 29 17:31:29 volumio-x86 kernel: usb usb3: Product: UHCI Host Controller Oct 29 17:31:29 volumio-x86 kernel: usb usb3: Manufacturer: Linux 5.10.165-volumio uhci_hcd Oct 29 17:31:29 volumio-x86 kernel: usb usb3: SerialNumber: 0000:00:1d.1 Oct 29 17:31:29 volumio-x86 kernel: hub 3-0:1.0: USB hub found Oct 29 17:31:29 volumio-x86 kernel: hub 3-0:1.0: 2 ports detected Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.2: UHCI Host Controller Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.2: detected 2 ports Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000dc00 Oct 29 17:31:29 volumio-x86 kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.10 Oct 29 17:31:29 volumio-x86 kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Oct 29 17:31:29 volumio-x86 kernel: usb usb4: Product: UHCI Host Controller Oct 29 17:31:29 volumio-x86 kernel: usb usb4: Manufacturer: Linux 5.10.165-volumio uhci_hcd Oct 29 17:31:29 volumio-x86 kernel: usb usb4: SerialNumber: 0000:00:1d.2 Oct 29 17:31:29 volumio-x86 kernel: hub 4-0:1.0: USB hub found Oct 29 17:31:29 volumio-x86 kernel: hub 4-0:1.0: 2 ports detected Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.3: UHCI Host Controller Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5 Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.3: detected 2 ports Oct 29 17:31:29 volumio-x86 kernel: uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000e000 Oct 29 17:31:29 volumio-x86 kernel: usb usb5: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.10 Oct 29 17:31:29 volumio-x86 kernel: usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Oct 29 17:31:29 volumio-x86 kernel: usb usb5: Product: UHCI Host Controller Oct 29 17:31:29 volumio-x86 kernel: usb usb5: Manufacturer: Linux 5.10.165-volumio uhci_hcd Oct 29 17:31:29 volumio-x86 kernel: usb usb5: SerialNumber: 0000:00:1d.3 Oct 29 17:31:29 volumio-x86 kernel: hub 5-0:1.0: USB hub found Oct 29 17:31:29 volumio-x86 kernel: hub 5-0:1.0: 2 ports detected Oct 29 17:31:29 volumio-x86 kernel: i8042: PNP: PS/2 Controller [PNP0303:PS2K] at 0x60,0x64 irq 1 Oct 29 17:31:29 volumio-x86 kernel: i8042: PNP: PS/2 appears to have AUX port disabled, if this is incorrect please boot with i8042.nopnp Oct 29 17:31:29 volumio-x86 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Oct 29 17:31:29 volumio-x86 kernel: mousedev: PS/2 mouse device common for all mice Oct 29 17:31:29 volumio-x86 kernel: rtc_cmos 00:01: RTC can wake from S4 Oct 29 17:31:29 volumio-x86 kernel: rtc_cmos 00:01: registered as rtc0 Oct 29 17:31:29 volumio-x86 kernel: rtc_cmos 00:01: setting system clock to 2024-10-29T17:31:09 UTC (1730223069) Oct 29 17:31:29 volumio-x86 kernel: rtc_cmos 00:01: alarms up to one month, 114 bytes nvram, hpet irqs Oct 29 17:31:29 volumio-x86 kernel: i2c /dev entries driver Oct 29 17:31:29 volumio-x86 kernel: platform eisa.0: Probing EISA bus 0 Oct 29 17:31:29 volumio-x86 kernel: platform eisa.0: EISA: Cannot allocate resource for mainboard Oct 29 17:31:29 volumio-x86 kernel: intel_pstate: CPU model not supported Oct 29 17:31:29 volumio-x86 kernel: ledtrig-cpu: registered to indicate activity on CPUs Oct 29 17:31:29 volumio-x86 kernel: NET: Registered protocol family 10 Oct 29 17:31:29 volumio-x86 kernel: Segment Routing with IPv6 Oct 29 17:31:29 volumio-x86 kernel: mip6: Mobile IPv6 Oct 29 17:31:29 volumio-x86 kernel: NET: Registered protocol family 17 Oct 29 17:31:29 volumio-x86 kernel: mpls_gso: MPLS GSO support Oct 29 17:31:29 volumio-x86 kernel: microcode: sig=0x6f6, pf=0x20, revision=0x48 Oct 29 17:31:29 volumio-x86 kernel: microcode: Microcode Update Driver: v2.2. Oct 29 17:31:29 volumio-x86 kernel: IPI shorthand broadcast: enabled Oct 29 17:31:29 volumio-x86 kernel: sched_clock: Marking stable (2443958475, 2275911)->(2457706904, -11472518) Oct 29 17:31:29 volumio-x86 kernel: registered taskstats version 1 Oct 29 17:31:29 volumio-x86 kernel: Loading compiled-in X.509 certificates Oct 29 17:31:29 volumio-x86 kernel: zswap: loaded using pool lzo/zbud Oct 29 17:31:29 volumio-x86 kernel: ata3.01: HPA detected: current 125043311, native 125045424 Oct 29 17:31:29 volumio-x86 kernel: ata3.01: ATA-8: CRUCIAL_CT64M225, 2030, max UDMA/133 Oct 29 17:31:29 volumio-x86 kernel: ata3.01: 125043311 sectors, multi 1: LBA48 NCQ (depth 0/32) Oct 29 17:31:29 volumio-x86 kernel: scsi 2:0:1:0: Direct-Access ATA CRUCIAL_CT64M225 2030 PQ: 0 ANSI: 5 Oct 29 17:31:29 volumio-x86 kernel: sd 2:0:1:0: [sda] 125043311 512-byte logical blocks: (64.0 GB/59.6 GiB) Oct 29 17:31:29 volumio-x86 kernel: sd 2:0:1:0: [sda] Write Protect is off Oct 29 17:31:29 volumio-x86 kernel: sd 2:0:1:0: [sda] Mode Sense: 00 3a 00 00 Oct 29 17:31:29 volumio-x86 kernel: sd 2:0:1:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Oct 29 17:31:29 volumio-x86 kernel: sda: sda1 sda2 sda3 Oct 29 17:31:29 volumio-x86 kernel: sd 2:0:1:0: [sda] Attached SCSI disk Oct 29 17:31:29 volumio-x86 kernel: Freeing unused kernel image (initmem) memory: 1816K Oct 29 17:31:29 volumio-x86 kernel: Write protecting the kernel read-only data: 18432k Oct 29 17:31:29 volumio-x86 kernel: Freeing unused kernel image (text/rodata gap) memory: 2036K Oct 29 17:31:29 volumio-x86 kernel: Freeing unused kernel image (rodata/data gap) memory: 1004K Oct 29 17:31:29 volumio-x86 kernel: Run /init as init process Oct 29 17:31:29 volumio-x86 kernel: with arguments: Oct 29 17:31:29 volumio-x86 kernel: /init Oct 29 17:31:29 volumio-x86 kernel: splash Oct 29 17:31:29 volumio-x86 kernel: with environment: Oct 29 17:31:29 volumio-x86 kernel: HOME=/ Oct 29 17:31:29 volumio-x86 kernel: TERM=linux Oct 29 17:31:29 volumio-x86 kernel: BOOT_IMAGE=vmlinuz Oct 29 17:31:29 volumio-x86 kernel: biosdevname=0 Oct 29 17:31:29 volumio-x86 kernel: imgpart=UUID=991616eb-1b6c-4a8c-a9f4-cc1f6af606da Oct 29 17:31:29 volumio-x86 kernel: bootpart=UUID=5579-66E1 Oct 29 17:31:29 volumio-x86 kernel: datapart=UUID=89f714e8-341f-4374-b4c6-7f751323a8c5 Oct 29 17:31:29 volumio-x86 kernel: imgfile=/volumio_current.sqsh Oct 29 17:31:29 volumio-x86 kernel: use_kmsg=yes Oct 29 17:31:29 volumio-x86 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 29 17:31:29 volumio-x86 kernel: fuse: init (API version 7.32) Oct 29 17:31:29 volumio-x86 kernel: sdhci: Secure Digital Host Controller Interface driver Oct 29 17:31:29 volumio-x86 kernel: sdhci: Copyright(c) Pierre Ossman Oct 29 17:31:29 volumio-x86 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 29 17:31:29 volumio-x86 kernel: usbcore: registered new interface driver usbhid Oct 29 17:31:29 volumio-x86 kernel: usbhid: USB HID core driver Oct 29 17:31:29 volumio-x86 kernel: loop: module loaded Oct 29 17:31:29 volumio-x86 kernel: usbcore: registered new interface driver usb-storage Oct 29 17:31:29 volumio-x86 kernel: tsc: Refined TSC clocksource calibration: 1666.666 MHz Oct 29 17:31:29 volumio-x86 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x180625dac1e, max_idle_ns: 440795267727 ns Oct 29 17:31:29 volumio-x86 kernel: clocksource: Switched to clocksource tsc Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: IMGPART=/dev/sda2 Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: IMGFILE=/volumio_current.sqsh Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: BOOTPART=/dev/sda1 Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: DATAPART=/dev/sda3 Oct 29 17:31:29 volumio-x86 kernel: EXT4-fs (sda2): recovery complete Oct 29 17:31:29 volumio-x86 kernel: EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null) Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: GPTSIZEMISMATCH: Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: Doing a 5 second delay here to give kernel load a headstart Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: Checking for a volumio rootfs update on a USB device Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: Checking for factory reset on a USB device Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: Checking for factory or user-data reset on boot device Oct 29 17:31:29 volumio-x86 kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Oct 29 17:31:29 volumio-x86 kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: Volumio version 3.449 Oct 29 17:31:29 volumio-x86 kernel: EXT4-fs (sda3): recovery complete Oct 29 17:31:29 volumio-x86 kernel: EXT4-fs (sda3): mounted filesystem with ordered data mode. Opts: (null) Oct 29 17:31:29 volumio-x86 kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038 (0x7fffffff) Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: Checking if fstab needs to be updated.. Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: Current /dev/sda1 - UUID=5579-66E1 Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: Current fstb \boot Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: Volumio: 3.449 Oct 29 17:31:29 volumio-x86 unknown: [i] initramfs: Finishing initramfs, switching rootfs and starting the boot process... Oct 29 17:31:29 volumio-x86 systemd[1]: Inserted module 'autofs4' Oct 29 17:31:29 volumio-x86 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) Oct 29 17:31:29 volumio-x86 systemd[1]: Detected architecture x86-64. Oct 29 17:31:29 volumio-x86 systemd[1]: Set hostname to . Oct 29 17:31:29 volumio-x86 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. Oct 29 17:31:29 volumio-x86 systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Oct 29 17:31:29 volumio-x86 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. Oct 29 17:31:29 volumio-x86 kernel: random: systemd: uninitialized urandom read (16 bytes read) Oct 29 17:31:29 volumio-x86 kernel: random: systemd: uninitialized urandom read (16 bytes read) Oct 29 17:31:29 volumio-x86 kernel: random: systemd: uninitialized urandom read (16 bytes read) Oct 29 17:31:29 volumio-x86 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 29 17:31:29 volumio-x86 systemd[1]: Listening on RPCbind Server Activation Socket. Oct 29 17:31:29 volumio-x86 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 29 17:31:29 volumio-x86 systemd[1]: Listening on Journal Socket (/dev/log). Oct 29 17:31:29 volumio-x86 kernel: RPC: Registered named UNIX socket transport module. Oct 29 17:31:29 volumio-x86 kernel: RPC: Registered udp transport module. Oct 29 17:31:29 volumio-x86 kernel: RPC: Registered tcp transport module. Oct 29 17:31:29 volumio-x86 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Oct 29 17:31:29 volumio-x86 systemd-journald[223]: Journal started Oct 29 17:31:29 volumio-x86 systemd-journald[223]: Runtime journal (/run/log/journal/0b2930d493c36928490994506425b530) is 3.7M, max 30.0M, 26.2M free. Oct 29 17:31:29 volumio-x86 systemd-udevd[241]: Network interface NamePolicy= disabled on kernel command line, ignoring. Oct 29 17:31:29 volumio-x86 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 29 17:31:29 volumio-x86 fake-hwclock[210]: Current system time: 2024-10-29 17:31:28 Oct 29 17:31:29 volumio-x86 fake-hwclock[210]: fake-hwclock saved clock information is in the past: 2024-10-28 18:58:34 Oct 29 17:31:29 volumio-x86 fake-hwclock[210]: To set system time to this saved clock anyway, use "force" Oct 29 17:31:29 volumio-x86 systemd-journald[223]: Runtime journal (/run/log/journal/0b2930d493c36928490994506425b530) is 3.7M, max 30.0M, 26.2M free. Oct 29 17:31:29 volumio-x86 systemd[1]: Started Flush Journal to Persistent Storage. Oct 29 17:31:29 volumio-x86 kernel: intel_rng: FWH not detected Oct 29 17:31:29 volumio-x86 kernel: ACPI Warning: SystemIO range 0x0000000000000828-0x000000000000082F conflicts with OpRegion 0x0000000000000800-0x000000000000087F (\_SB.PCI0.SBRG.PMS0) (20200925/utaddress-213) Oct 29 17:31:29 volumio-x86 kernel: ACPI Warning: SystemIO range 0x0000000000000828-0x000000000000082F conflicts with OpRegion 0x0000000000000828-0x000000000000082F (\_SB.PCI0.SBRG.IELK.GPSE) (20200925/utaddress-213) Oct 29 17:31:29 volumio-x86 kernel: ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver Oct 29 17:31:29 volumio-x86 kernel: ACPI Warning: SystemIO range 0x00000000000004B0-0x00000000000004BF conflicts with OpRegion 0x0000000000000480-0x00000000000004BF (\_SB.PCI0.SBRG.GPBX) (20200925/utaddress-213) Oct 29 17:31:29 volumio-x86 kernel: ACPI Warning: SystemIO range 0x00000000000004B0-0x00000000000004BF conflicts with OpRegion 0x0000000000000480-0x00000000000004BF (\_SB.PCI0.SBRG.GPIO) (20200925/utaddress-213) Oct 29 17:31:29 volumio-x86 kernel: ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver Oct 29 17:31:29 volumio-x86 kernel: ACPI Warning: SystemIO range 0x0000000000000480-0x00000000000004AF conflicts with OpRegion 0x0000000000000480-0x00000000000004BF (\_SB.PCI0.SBRG.GPBX) (20200925/utaddress-213) Oct 29 17:31:29 volumio-x86 kernel: ACPI Warning: SystemIO range 0x0000000000000480-0x00000000000004AF conflicts with OpRegion 0x0000000000000480-0x00000000000004BF (\_SB.PCI0.SBRG.GPIO) (20200925/utaddress-213) Oct 29 17:31:29 volumio-x86 kernel: ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver Oct 29 17:31:29 volumio-x86 kernel: lpc_ich: Resource conflict(s) found affecting gpio_ich Oct 29 17:31:29 volumio-x86 kernel: sd 2:0:1:0: Attached scsi generic sg0 type 0 Oct 29 17:31:29 volumio-x86 kernel: random: systemd: uninitialized urandom read (16 bytes read) Oct 29 17:31:29 volumio-x86 kernel: random: systemd: uninitialized urandom read (16 bytes read) Oct 29 17:31:29 volumio-x86 kernel: random: systemd: uninitialized urandom read (16 bytes read) Oct 29 17:31:29 volumio-x86 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Oct 29 17:31:29 volumio-x86 kernel: i2c i2c-0: 2/2 memory slots populated (from DMI) Oct 29 17:31:29 volumio-x86 kernel: i2c i2c-0: Memory type 0x0f not supported yet, not instantiating SPD Oct 29 17:31:29 volumio-x86 kernel: intel_powerclamp: No package C-state available Oct 29 17:31:29 volumio-x86 kernel: intel_powerclamp: No package C-state available Oct 29 17:31:29 volumio-x86 kernel: e1000e: Intel(R) PRO/1000 Network Driver Oct 29 17:31:29 volumio-x86 kernel: e1000e: Copyright(c) 1999 - 2015 Intel Corporation. Oct 29 17:31:29 volumio-x86 kernel: e1000e 0000:01:00.0: Interrupt Throttling Rate (ints/sec) set to dynamic conservative mode Oct 29 17:31:29 volumio-x86 systemd-udevd[250]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 29 17:31:29 volumio-x86 kernel: firewire_ohci 0000:03:03.0: added OHCI v1.10 device as card 0, 4 IR + 8 IT contexts, quirks 0x2 Oct 29 17:31:29 volumio-x86 kernel: e1000e 0000:01:00.0 eth0: (PCI Express:2.5GT/s:Width x1) 00:17:31:a7:02:1b Oct 29 17:31:30 volumio-x86 kernel: e1000e 0000:01:00.0 eth0: Intel(R) PRO/1000 Network Connection Oct 29 17:31:30 volumio-x86 kernel: e1000e 0000:01:00.0 eth0: MAC: 2, PHY: 2, PBA No: FFFFFF-0FF Oct 29 17:31:30 volumio-x86 systemd-udevd[255]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 29 17:31:30 volumio-x86 systemd-udevd[253]: Using default interface naming scheme 'v240'. Oct 29 17:31:30 volumio-x86 systemd-udevd[254]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 29 17:31:30 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC882: line_outs=4 (0x14/0x15/0x16/0x17/0x0) type:line Oct 29 17:31:30 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Oct 29 17:31:30 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: hp_outs=1 (0x1b/0x0/0x0/0x0/0x0) Oct 29 17:31:30 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0 Oct 29 17:31:30 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: dig-out=0x1e/0x0 Oct 29 17:31:30 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: inputs: Oct 29 17:31:30 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: Front Mic=0x19 Oct 29 17:31:30 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: Rear Mic=0x18 Oct 29 17:31:30 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: Line=0x1a Oct 29 17:31:30 volumio-x86 kernel: snd_hda_codec_realtek hdaudioC0D0: dig-in=0x1f Oct 29 17:31:30 volumio-x86 systemd[1]: Found device CRUCIAL_CT64M225 boot. Oct 29 17:31:30 volumio-x86 systemd-udevd[253]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 29 17:31:30 volumio-x86 systemd[1]: Starting File System Check on /dev/disk/by-uuid/5579-66E1... Oct 29 17:31:30 volumio-x86 systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Oct 29 17:31:30 volumio-x86 systemd[1]: Started File System Check Daemon to report status. Oct 29 17:31:30 volumio-x86 kernel: input: HDA Intel Rear Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input3 Oct 29 17:31:30 volumio-x86 kernel: input: HDA Intel Line as /devices/pci0000:00/0000:00:1b.0/sound/card0/input4 Oct 29 17:31:30 volumio-x86 kernel: input: HDA Intel Line Out Front as /devices/pci0000:00/0000:00:1b.0/sound/card0/input5 Oct 29 17:31:30 volumio-x86 kernel: input: HDA Intel Line Out Surround as /devices/pci0000:00/0000:00:1b.0/sound/card0/input6 Oct 29 17:31:30 volumio-x86 kernel: input: HDA Intel Line Out CLFE as /devices/pci0000:00/0000:00:1b.0/sound/card0/input7 Oct 29 17:31:30 volumio-x86 kernel: input: HDA Intel Line Out Side as /devices/pci0000:00/0000:00:1b.0/sound/card0/input8 Oct 29 17:31:30 volumio-x86 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Oct 29 17:31:30 volumio-x86 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 29 17:31:30 volumio-x86 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 29 17:31:30 volumio-x86 systemd-fsck[286]: fsck.fat 4.1 (2017-01-24) Oct 29 17:31:30 volumio-x86 systemd-fsck[286]: /dev/sda1: 20 files, 15674/43727 clusters Oct 29 17:31:30 volumio-x86 systemd[1]: Started File System Check on /dev/disk/by-uuid/5579-66E1. Oct 29 17:31:30 volumio-x86 systemd[1]: Mounting /boot... Oct 29 17:31:30 volumio-x86 kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Oct 29 17:31:30 volumio-x86 systemd[1]: Mounted /boot. Oct 29 17:31:30 volumio-x86 systemd[1]: Reached target Local File Systems. Oct 29 17:31:30 volumio-x86 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 29 17:31:30 volumio-x86 systemd[1]: Starting Create Volatile Files and Directories... Oct 29 17:31:30 volumio-x86 systemd[1]: Starting Preprocess NFS configuration... Oct 29 17:31:30 volumio-x86 systemd[1]: Starting Raise network interfaces... Oct 29 17:31:30 volumio-x86 systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Oct 29 17:31:30 volumio-x86 systemd[1]: nfs-config.service: Succeeded. Oct 29 17:31:30 volumio-x86 systemd[1]: Started Preprocess NFS configuration. Oct 29 17:31:30 volumio-x86 systemd[1]: Received SIGRTMIN+20 from PID 258 (plymouthd). Oct 29 17:31:30 volumio-x86 systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Oct 29 17:31:30 volumio-x86 systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Oct 29 17:31:30 volumio-x86 systemd[1]: Reached target NFS client services. Oct 29 17:31:30 volumio-x86 systemd[1]: plymouth-read-write.service: Succeeded. Oct 29 17:31:30 volumio-x86 systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Oct 29 17:31:30 volumio-x86 systemd[1]: Started Create Volatile Files and Directories. Oct 29 17:31:30 volumio-x86 systemd[1]: Starting RPC bind portmap service... Oct 29 17:31:30 volumio-x86 systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Oct 29 17:31:30 volumio-x86 systemd[1]: Starting Update UTMP about System Boot/Shutdown... Oct 29 17:31:30 volumio-x86 systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Oct 29 17:31:30 volumio-x86 systemd[1]: Started Update UTMP about System Boot/Shutdown. Oct 29 17:31:30 volumio-x86 systemd[1]: Reached target System Initialization. Oct 29 17:31:30 volumio-x86 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 29 17:31:30 volumio-x86 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 29 17:31:30 volumio-x86 systemd[1]: Started Daily man-db regeneration. Oct 29 17:31:30 volumio-x86 systemd[1]: Started Daily apt download activities. Oct 29 17:31:30 volumio-x86 systemd[1]: Started Daily apt upgrade and clean activities. Oct 29 17:31:30 volumio-x86 systemd[1]: Reached target Timers. Oct 29 17:31:30 volumio-x86 systemd[1]: Listening on triggerhappy.socket. Oct 29 17:31:30 volumio-x86 systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Oct 29 17:31:30 volumio-x86 systemd[1]: Listening on mpd.socket. Oct 29 17:31:30 volumio-x86 systemd[1]: Reached target Sockets. Oct 29 17:31:30 volumio-x86 systemd[1]: Reached target Basic System. Oct 29 17:31:30 volumio-x86 kernel: firewire_core 0000:03:03.0: created device fw0: GUID 0011d80000b08615, S400 Oct 29 17:31:30 volumio-x86 systemd[1]: Starting Wireless Services... Oct 29 17:31:30 volumio-x86 systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Oct 29 17:31:30 volumio-x86 systemd[1]: Starting DHCP Client Daemon... Oct 29 17:31:30 volumio-x86 systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Oct 29 17:31:30 volumio-x86 systemd[1]: Started volumio-remote-updater.service. Oct 29 17:31:30 volumio-x86 systemd[1]: Started D-Bus System Message Bus. Oct 29 17:31:30 volumio-x86 systemd[1]: Started Volumio Iptables Module. Oct 29 17:31:30 volumio-x86 systemd[1]: Started UPnP Renderer front-end to MPD. Oct 29 17:31:30 volumio-x86 systemd[1]: Starting WPA supplicant... Oct 29 17:31:30 volumio-x86 systemd[1]: Starting triggerhappy global hotkey daemon... Oct 29 17:31:30 volumio-x86 systemd[1]: Started Manage Sound Card State (restore and store). Oct 29 17:31:30 volumio-x86 kernel: random: systemd: uninitialized urandom read (16 bytes read) Oct 29 17:31:30 volumio-x86 kernel: random: systemd-journal: uninitialized urandom read (16 bytes read) Oct 29 17:31:30 volumio-x86 kernel: random: systemd-journal: uninitialized urandom read (16 bytes read) Oct 29 17:31:30 volumio-x86 systemd[1]: Starting Save/Restore Sound Card State... Oct 29 17:31:30 volumio-x86 systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Oct 29 17:31:30 volumio-x86 systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Oct 29 17:31:30 volumio-x86 thd[332]: Unable to parse trigger line: Oct 29 17:31:30 volumio-x86 thd[332]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Oct 29 17:31:30 volumio-x86 thd[332]: Unable to parse trigger line: Oct 29 17:31:30 volumio-x86 systemd[1]: Starting Login Service... Oct 29 17:31:30 volumio-x86 systemd[1]: Starting Daily man-db regeneration... Oct 29 17:31:30 volumio-x86 systemd-udevd[257]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 29 17:31:30 volumio-x86 kernel: 8021q: 802.1Q VLAN Support v1.8 Oct 29 17:31:30 volumio-x86 systemd-udevd[251]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 29 17:31:30 volumio-x86 systemd-udevd[254]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 29 17:31:30 volumio-x86 systemd-udevd[261]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 29 17:31:30 volumio-x86 thd[332]: Found socket passed from systemd Oct 29 17:31:30 volumio-x86 systemd-udevd[264]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 29 17:31:30 volumio-x86 avahi-daemon[335]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Oct 29 17:31:30 volumio-x86 avahi-daemon[335]: Successfully dropped root privileges. Oct 29 17:31:30 volumio-x86 avahi-daemon[335]: avahi-daemon 0.7 starting up. Oct 29 17:31:30 volumio-x86 systemd-logind[337]: Watching system buttons on /dev/input/event1 (Power Button) Oct 29 17:31:30 volumio-x86 systemd-logind[337]: Watching system buttons on /dev/input/event0 (Power Button) Oct 29 17:31:30 volumio-x86 systemd-udevd[265]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 29 17:31:31 volumio-x86 avahi-daemon[335]: WARNING: No NSS support for mDNS detected, consider installing nss-mdns! Oct 29 17:31:31 volumio-x86 systemd-logind[337]: New seat seat0. Oct 29 17:31:31 volumio-x86 kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Oct 29 17:31:31 volumio-x86 systemd[1]: Started Login Service. Oct 29 17:31:31 volumio-x86 systemd[1]: Started triggerhappy global hotkey daemon. Oct 29 17:31:31 volumio-x86 systemd[1]: Started RPC bind portmap service. Oct 29 17:31:31 volumio-x86 systemd[1]: Started Avahi mDNS/DNS-SD Stack. Oct 29 17:31:31 volumio-x86 systemd[1]: Reached target Remote File Systems (Pre). Oct 29 17:31:31 volumio-x86 systemd[1]: Reached target Remote File Systems. Oct 29 17:31:31 volumio-x86 alsactl[333]: alsactl 1.1.8 daemon started Oct 29 17:31:31 volumio-x86 avahi-daemon[335]: Successfully called chroot(). Oct 29 17:31:31 volumio-x86 avahi-daemon[335]: Successfully dropped remaining capabilities. Oct 29 17:31:31 volumio-x86 avahi-daemon[335]: Loading service file /services/volumio.service. Oct 29 17:31:31 volumio-x86 avahi-daemon[335]: Network interface enumeration completed. Oct 29 17:31:31 volumio-x86 avahi-daemon[335]: Server startup complete. Host name is volumio-x86.local. Local service cookie is 2189055709. Oct 29 17:31:31 volumio-x86 avahi-daemon[335]: Service "Volumio-X86" (/services/volumio.service) successfully established. Oct 29 17:31:31 volumio-x86 systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Oct 29 17:31:31 volumio-x86 systemd[1]: Reached target RPC Port Mapper. Oct 29 17:31:31 volumio-x86 kernel: pci 0000:00:00.0: Intel 945GM Chipset Oct 29 17:31:31 volumio-x86 kernel: pci 0000:00:00.0: detected gtt size: 262144K total, 262144K mappable Oct 29 17:31:31 volumio-x86 kernel: pci 0000:00:00.0: detected 8192K stolen memory Oct 29 17:31:31 volumio-x86 kernel: i915 0000:00:02.0: vgaarb: deactivate vga console Oct 29 17:31:31 volumio-x86 kernel: Console: switching to colour dummy device 80x25 Oct 29 17:31:31 volumio-x86 haveged[317]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K Oct 29 17:31:31 volumio-x86 haveged[317]: haveged: cpu: (L4 VC); data: 32K (L2 L4 V); inst: 32K (L2 L4 V); idx: 24/40; sz: 31410/52825 Oct 29 17:31:31 volumio-x86 haveged[317]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99988 Oct 29 17:31:31 volumio-x86 haveged[317]: haveged: fills: 0, generated: 0 Oct 29 17:31:31 volumio-x86 kernel: random: crng init done Oct 29 17:31:31 volumio-x86 kernel: random: 235 urandom warning(s) missed due to ratelimiting Oct 29 17:31:31 volumio-x86 kernel: resource sanity check: requesting [mem 0x000c0000-0x000dffff], which spans more than PCI Bus 0000:00 [mem 0x000d0000-0x000dffff window] Oct 29 17:31:31 volumio-x86 kernel: caller pci_map_rom+0x71/0x1c0 mapping multiple BARs Oct 29 17:31:31 volumio-x86 kernel: i915 0000:00:02.0: vgaarb: changed VGA decodes: olddecodes=io+mem,decodes=io+mem:owns=io+mem Oct 29 17:31:31 volumio-x86 kernel: i915 0000:00:02.0: [drm] Initialized overlay support. Oct 29 17:31:31 volumio-x86 kernel: [drm] Initialized i915 1.6.0 20200917 for 0000:00:02.0 on minor 0 Oct 29 17:31:31 volumio-x86 kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Oct 29 17:31:31 volumio-x86 ifup[303]: command failed: No such device (-19) Oct 29 17:31:31 volumio-x86 kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes Oct 29 17:31:31 volumio-x86 kernel: intelfb: Framebuffer driver for Intel(R) 830M/845G/852GM/855GM/865G/915G/915GM/945G/945GM/945GME/965G/965GM chipsets Oct 29 17:31:31 volumio-x86 kernel: intelfb: Version 0.9.6 Oct 29 17:31:31 volumio-x86 systemd[1]: iptables.service: Succeeded. Oct 29 17:31:31 volumio-x86 systemd[1]: man-db.service: Succeeded. Oct 29 17:31:31 volumio-x86 systemd[1]: Started Daily man-db regeneration. Oct 29 17:31:31 volumio-x86 kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes Oct 29 17:31:31 volumio-x86 dhcpcd[323]: no interfaces have a carrier Oct 29 17:31:31 volumio-x86 systemd[1]: Started DHCP Client Daemon. Oct 29 17:31:31 volumio-x86 dhcpcd[323]: no interfaces have a carrier Oct 29 17:31:31 volumio-x86 dhcpcd[323]: forked to background, child pid 394 Oct 29 17:31:31 volumio-x86 dhcpcd[323]: forked to background, child pid 394 Oct 29 17:31:31 volumio-x86 ifup[303]: command failed: No such device (-19) Oct 29 17:31:31 volumio-x86 kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes Oct 29 17:31:32 volumio-x86 systemd[1]: Found device 82573L Gigabit Ethernet Controller. Oct 29 17:31:32 volumio-x86 dhcpcd[394]: eth0: waiting for carrier Oct 29 17:31:32 volumio-x86 kernel: 8021q: adding VLAN 0 to HW filter on device eth0 Oct 29 17:31:32 volumio-x86 systemd[1]: Started ifup for eth0. Oct 29 17:31:32 volumio-x86 sh[411]: command failed: No such device (-19) Oct 29 17:31:32 volumio-x86 sh[411]: sending commands to master dhcpcd process Oct 29 17:31:32 volumio-x86 dhcpcd[445]: sending commands to master dhcpcd process Oct 29 17:31:32 volumio-x86 dhcpcd[394]: control command: /sbin/dhcpcd eth0 Oct 29 17:31:32 volumio-x86 volumio-remote-updater[325]: Error: No active session Oct 29 17:31:32 volumio-x86 volumio-remote-updater[325]: [2024-10-29 17:31:32] [info] asio async_connect error: system:111 (Connection refused) Oct 29 17:31:32 volumio-x86 volumio-remote-updater[325]: [2024-10-29 17:31:32] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 29 17:31:32 volumio-x86 volumio-remote-updater[325]: [2024-10-29 17:31:32] [error] handle_connect error: Underlying Transport Error Oct 29 17:31:32 volumio-x86 loadcpufreq[360]: Loading cpufreq kernel modules...done (acpi-cpufreq). Oct 29 17:31:32 volumio-x86 systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Oct 29 17:31:32 volumio-x86 systemd[1]: Starting LSB: set CPUFreq kernel parameters... Oct 29 17:31:32 volumio-x86 wpa_supplicant[331]: Successfully initialized wpa_supplicant Oct 29 17:31:32 volumio-x86 systemd[1]: Started WPA supplicant. Oct 29 17:31:32 volumio-x86 sh[411]: eth0=eth0 Oct 29 17:31:32 volumio-x86 systemd[1]: Started Raise network interfaces. Oct 29 17:31:32 volumio-x86 systemd[1]: Reached target Network. Oct 29 17:31:32 volumio-x86 systemd[1]: Starting Network Time Service... Oct 29 17:31:32 volumio-x86 systemd[1]: Reached target Network is Online. Oct 29 17:31:32 volumio-x86 systemd[1]: Starting LSB: Brings up/down network automatically... Oct 29 17:31:32 volumio-x86 systemd[1]: Starting Samba NMB Daemon... Oct 29 17:31:32 volumio-x86 volumio[330]: Could not open config: /tmp/upmpdcli.conf Oct 29 17:31:32 volumio-x86 systemd[1]: Starting /etc/rc.local Compatibility... Oct 29 17:31:32 volumio-x86 systemd[1]: Starting OpenBSD Secure Shell server... Oct 29 17:31:32 volumio-x86 systemd[1]: Starting Daily apt download activities... Oct 29 17:31:32 volumio-x86 systemd[1]: Starting Permit User Sessions... Oct 29 17:31:32 volumio-x86 systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Oct 29 17:31:32 volumio-x86 systemd[1]: Started /etc/rc.local Compatibility. Oct 29 17:31:32 volumio-x86 systemd[1]: Started Permit User Sessions. Oct 29 17:31:32 volumio-x86 cpufrequtils[499]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...done. Oct 29 17:31:32 volumio-x86 systemd[1]: Started LSB: set CPUFreq kernel parameters. Oct 29 17:31:32 volumio-x86 systemd[1]: Starting Terminate Plymouth Boot Screen... Oct 29 17:31:32 volumio-x86 systemd[1]: Starting Hold until boot process finishes up... Oct 29 17:31:32 volumio-x86 systemd[1]: plymouth-start.service: Succeeded. Oct 29 17:31:32 volumio-x86 systemd[1]: plymouth-quit.service: Succeeded. Oct 29 17:31:32 volumio-x86 systemd[1]: Started Terminate Plymouth Boot Screen. Oct 29 17:31:32 volumio-x86 systemd[1]: plymouth-quit-wait.service: Succeeded. Oct 29 17:31:32 volumio-x86 systemd[1]: Started Hold until boot process finishes up. Oct 29 17:31:32 volumio-x86 systemd[1]: Received SIGRTMIN+21 from PID 258 (n/a). Oct 29 17:31:32 volumio-x86 systemd[1]: Started Getty on tty1. Oct 29 17:31:32 volumio-x86 systemd[1]: Reached target Login Prompts. Oct 29 17:31:32 volumio-x86 ifplugd(eth0)[552]: ifplugd 0.28 initializing. Oct 29 17:31:32 volumio-x86 ifplugd(eth0)[552]: Using interface eth0/00:17:31:A7:02:1B with driver (version: 5.10.165-volumio) Oct 29 17:31:32 volumio-x86 ifplugd(eth0)[552]: Using detection mode: SIOCETHTOOL Oct 29 17:31:32 volumio-x86 ifplugd(eth0)[552]: Initialization complete, link beat not detected. Oct 29 17:31:32 volumio-x86 ifplugd[524]: Network Interface Plugging Daemon...start eth0...done. Oct 29 17:31:32 volumio-x86 systemd[1]: Started LSB: Brings up/down network automatically. Oct 29 17:31:32 volumio-x86 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 29 17:31:32 volumio-x86 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 29 17:31:32 volumio-x86 systemd[1]: Started Save/Restore Sound Card State. Oct 29 17:31:32 volumio-x86 systemd[1]: Reached target Sound Card. Oct 29 17:31:32 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 29 17:31:32 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 29 17:31:32 volumio-x86 ntpd[523]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 29 17:31:32 volumio-x86 ntpd[523]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 29 17:31:32 volumio-x86 systemd[1]: Started Network Time Service. Oct 29 17:31:32 volumio-x86 ntpd[558]: proto: precision = 0.138 usec (-23) Oct 29 17:31:32 volumio-x86 ntpd[558]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 29 17:31:32 volumio-x86 ntpd[558]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 29 17:31:32 volumio-x86 ntpd[558]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 672 days ago Oct 29 17:31:32 volumio-x86 ntpd[558]: Listen and drop on 0 v6wildcard [::]:123 Oct 29 17:31:32 volumio-x86 ntpd[558]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 29 17:31:32 volumio-x86 ntpd[558]: Listen normally on 2 lo 127.0.0.1:123 Oct 29 17:31:32 volumio-x86 ntpd[558]: Listening on routing socket on fd #19 for interface updates Oct 29 17:31:32 volumio-x86 ntpd[558]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 29 17:31:32 volumio-x86 ntpd[558]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 29 17:31:33 volumio-x86 sshd[562]: Server listening on 0.0.0.0 port 22. Oct 29 17:31:33 volumio-x86 sshd[562]: Server listening on :: port 22. Oct 29 17:31:33 volumio-x86 systemd[1]: Started OpenBSD Secure Shell server. Oct 29 17:31:33 volumio-x86 ntpd[558]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Oct 29 17:31:34 volumio-x86 dhcpcd[394]: eth0: carrier acquired Oct 29 17:31:34 volumio-x86 kernel: e1000e 0000:01:00.0 eth0: NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx Oct 29 17:31:34 volumio-x86 kernel: e1000e 0000:01:00.0 eth0: 10/100 speed: disabling TSO Oct 29 17:31:34 volumio-x86 dhcpcd[394]: DUID 00:04:00:02:00:03:00:04:00:05:00:06:00:07:00:08:00:09 Oct 29 17:31:34 volumio-x86 dhcpcd[394]: eth0: IAID 31:a7:02:1b Oct 29 17:31:34 volumio-x86 dhcpcd[394]: eth0: adding address fe80::931b:57c6:f71a:4e76 Oct 29 17:31:34 volumio-x86 dhcpcd[394]: ipv6_addaddr1: Permission denied Oct 29 17:31:34 volumio-x86 nmbd[539]: [2024/10/29 17:31:34.382535, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Oct 29 17:31:34 volumio-x86 nmbd[539]: started asyncdns process 609 Oct 29 17:31:34 volumio-x86 nmbd[539]: [2024/10/29 17:31:34.383696, 0] ../lib/util/become_daemon.c:149(daemon_status) Oct 29 17:31:34 volumio-x86 nmbd[539]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Oct 29 17:31:34 volumio-x86 nmbd[539]: [2024/10/29 17:31:34.384699, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Oct 29 17:31:34 volumio-x86 nmbd[539]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Oct 29 17:31:34 volumio-x86 systemd[1]: apt-daily.service: Succeeded. Oct 29 17:31:34 volumio-x86 systemd[1]: Started Daily apt download activities. Oct 29 17:31:34 volumio-x86 systemd[1]: Starting Daily apt upgrade and clean activities... Oct 29 17:31:34 volumio-x86 ifplugd(eth0)[552]: Link beat detected. Oct 29 17:31:34 volumio-x86 dhcpcd[394]: eth0: soliciting a DHCP lease Oct 29 17:31:34 volumio-x86 ifplugd(eth0)[552]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 29 17:31:34 volumio-x86 ifplugd(eth0)[552]: client: ifup: interface eth0 already configured Oct 29 17:31:34 volumio-x86 ifplugd(eth0)[552]: Program executed successfully. Oct 29 17:31:34 volumio-x86 ntpd[558]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Oct 29 17:31:34 volumio-x86 systemd[1]: apt-daily-upgrade.service: Succeeded. Oct 29 17:31:34 volumio-x86 systemd[1]: Started Daily apt upgrade and clean activities. Oct 29 17:31:35 volumio-x86 dhcpcd[394]: eth0: soliciting an IPv6 router Oct 29 17:31:35 volumio-x86 wireless.js[322]: WIRELESS: No wireless interface, exiting Oct 29 17:31:35 volumio-x86 iw[675]: command failed: No such device (-19) Oct 29 17:31:35 volumio-x86 systemd[1]: wireless.service: Control process exited, code=exited, status=237/KEYRING Oct 29 17:31:35 volumio-x86 systemd[1]: wireless.service: Failed with result 'exit-code'. Oct 29 17:31:35 volumio-x86 systemd[1]: Failed to start Wireless Services. Oct 29 17:31:35 volumio-x86 systemd[1]: Started Volumio Backend Module. Oct 29 17:31:35 volumio-x86 systemd[1]: Started Intel SST and HDA soundcard init service. Oct 29 17:31:35 volumio-x86 mpd[556]: Oct 29 17:31 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 29 17:31:35 volumio-x86 ntpd[558]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Oct 29 17:31:36 volumio-x86 systemd[1]: soundcard-init.service: Succeeded. Oct 29 17:31:36 volumio-x86 mpd[556]: Oct 29 17:31 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Oct 29 17:31:36 volumio-x86 mpd[556]: Oct 29 17:31 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Oct 29 17:31:36 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 29 17:31:36 volumio-x86 volumio[678]: info: ------------------------------------------- Oct 29 17:31:36 volumio-x86 volumio[678]: info: ----- Volumio3 ---- Oct 29 17:31:36 volumio-x86 volumio[678]: info: ------------------------------------------- Oct 29 17:31:36 volumio-x86 volumio[678]: info: ----- System startup ---- Oct 29 17:31:36 volumio-x86 volumio[678]: info: ------------------------------------------- Oct 29 17:31:36 volumio-x86 ntpd[558]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Oct 29 17:31:37 volumio-x86 volumio-remote-updater[325]: [2024-10-29 17:31:37] [connect] Successful connection Oct 29 17:31:37 volumio-x86 volumio[678]: info: MYVOLUMIO Environment detected Oct 29 17:31:37 volumio-x86 volumio[678]: info: Plugin folders cleanup Oct 29 17:31:37 volumio-x86 volumio[678]: info: Scanning into folder /volumio/app/plugins/ Oct 29 17:31:37 volumio-x86 volumio[678]: info: Scanning category audio_interface Oct 29 17:31:37 volumio-x86 volumio[678]: info: Scanning category miscellanea Oct 29 17:31:37 volumio-x86 volumio[678]: info: Scanning category music_service Oct 29 17:31:37 volumio-x86 volumio[678]: info: Scanning category plugins.json Oct 29 17:31:37 volumio-x86 volumio[678]: info: Scanning category system_controller Oct 29 17:31:37 volumio-x86 volumio[678]: info: Scanning category user_interface Oct 29 17:31:37 volumio-x86 volumio[678]: info: Scanning into folder /data/plugins/ Oct 29 17:31:37 volumio-x86 volumio[678]: info: Scanning category system_controller Oct 29 17:31:37 volumio-x86 volumio[678]: info: Plugin folders cleanup completed Oct 29 17:31:37 volumio-x86 volumio[678]: info: ------------------------------------------- Oct 29 17:31:37 volumio-x86 volumio[678]: info: ----- Core plugins startup ---- Oct 29 17:31:37 volumio-x86 volumio[678]: info: ------------------------------------------- Oct 29 17:31:37 volumio-x86 volumio[678]: info: Loading plugins from folder /volumio/app/plugins/ Oct 29 17:31:37 volumio-x86 volumio[678]: info: Adding plugin upnp to MyMusic Plugins Oct 29 17:31:37 volumio-x86 volumio[678]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 29 17:31:37 volumio-x86 volumio[678]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 29 17:31:37 volumio-x86 volumio[678]: info: Loading plugins from folder /data/plugins/ Oct 29 17:31:37 volumio-x86 volumio[678]: info: Loading plugin "system"... Oct 29 17:31:37 volumio-x86 volumio[678]: info: Loading plugin "appearance"... Oct 29 17:31:37 volumio-x86 dhcpcd[394]: eth0: offered 192.168.1.168 from 192.168.1.1 Oct 29 17:31:37 volumio-x86 dhcpcd[394]: eth0: probing address 192.168.1.168/24 Oct 29 17:31:38 volumio-x86 volumio[678]: info: Loading plugin "network"... Oct 29 17:31:38 volumio-x86 volumio[678]: info: Refreshing Cached IP Addresses Oct 29 17:31:38 volumio-x86 volumio[678]: info: Loading plugin "services"... Oct 29 17:31:38 volumio-x86 volumio[678]: info: Loading plugin "alsa_controller"... Oct 29 17:31:38 volumio-x86 sudo[790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 17:31:38 volumio-x86 sudo[788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 17:31:38 volumio-x86 sudo[788]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:38 volumio-x86 sudo[790]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:38 volumio-x86 sudo[792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 29 17:31:38 volumio-x86 sudo[792]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:38 volumio-x86 sudo[788]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:38 volumio-x86 sudo[790]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:38 volumio-x86 sudo[792]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:38 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 29 17:31:38 volumio-x86 volumio[678]: info: Loading plugin "wizard"... Oct 29 17:31:38 volumio-x86 volumio[678]: info: Loading plugin "volumio_command_line_client"... Oct 29 17:31:38 volumio-x86 volumio[678]: info: Plugin upnp is not enabled Oct 29 17:31:38 volumio-x86 volumio[678]: info: Loading plugin "my_music"... Oct 29 17:31:38 volumio-x86 volumio[678]: info: Loading plugin "mpd"... Oct 29 17:31:38 volumio-x86 volumio[678]: info: Creating MPD Configuration file Oct 29 17:31:38 volumio-x86 sudo[805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 29 17:31:38 volumio-x86 sudo[805]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:38 volumio-x86 sudo[805]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:38 volumio-x86 volumio[678]: info: Plugin upnp_browser is not enabled Oct 29 17:31:38 volumio-x86 volumio[678]: info: Loading plugin "networkfs"... Oct 29 17:31:38 volumio-x86 sudo[808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 29 17:31:38 volumio-x86 sudo[808]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:38 volumio-x86 systemd[1]: Stopping Music Player Daemon... Oct 29 17:31:38 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 29 17:31:38 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 29 17:31:38 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 29 17:31:38 volumio-x86 volumio[678]: info: Starting Udev Watcher for removable devices Oct 29 17:31:38 volumio-x86 sudo[815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=media,password=Xbox1,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.10/#~Muzic~# /mnt/NAS/Server Oct 29 17:31:38 volumio-x86 sudo[815]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:39 volumio-x86 kernel: FS-Cache: Loaded Oct 29 17:31:39 volumio-x86 kernel: Key type dns_resolver registered Oct 29 17:31:39 volumio-x86 volumio[678]: info: Ignoring mount for partition: boot Oct 29 17:31:39 volumio-x86 volumio[678]: info: Ignoring mount for partition: volumio Oct 29 17:31:39 volumio-x86 volumio[678]: info: Ignoring mount for partition: volumio_data Oct 29 17:31:39 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "alarm-clock"... Oct 29 17:31:39 volumio-x86 kernel: FS-Cache: Netfs 'cifs' registered for caching Oct 29 17:31:39 volumio-x86 sudo[815]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:39 volumio-x86 kernel: Key type cifs.spnego registered Oct 29 17:31:39 volumio-x86 kernel: Key type cifs.idmap registered Oct 29 17:31:39 volumio-x86 kernel: CIFS: Attempting to mount //192.168.0.10/#~Muzic~# Oct 29 17:31:39 volumio-x86 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. Oct 29 17:31:39 volumio-x86 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Oct 29 17:31:39 volumio-x86 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Oct 29 17:31:39 volumio-x86 volumio[678]: info: Plugin airplay_emulation is not enabled Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "last_100"... Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "webradio"... Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "i2s_dacs"... Oct 29 17:31:39 volumio-x86 volumio[678]: info: I2S DAC not set, start Auto-detection Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "volumiodiscovery"... Oct 29 17:31:39 volumio-x86 volumio[678]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 29 17:31:39 volumio-x86 volumio[678]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 29 17:31:39 volumio-x86 volumio[678]: *** WARNING *** For more information see Oct 29 17:31:39 volumio-x86 node[678]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 29 17:31:39 volumio-x86 volumio[678]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 29 17:31:39 volumio-x86 volumio[678]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 29 17:31:39 volumio-x86 volumio[678]: *** WARNING *** For more information see Oct 29 17:31:39 volumio-x86 node[678]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 29 17:31:39 volumio-x86 node[678]: *** WARNING *** For more information see Oct 29 17:31:39 volumio-x86 node[678]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 29 17:31:39 volumio-x86 node[678]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 29 17:31:39 volumio-x86 node[678]: *** WARNING *** For more information see Oct 29 17:31:39 volumio-x86 volumio[678]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 29 17:31:39 volumio-x86 volumio[678]: info: Discovery: Started advertising with name: Volumio-X86 Oct 29 17:31:39 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "autostart"... Oct 29 17:31:39 volumio-x86 mpd[813]: Oct 29 17:31 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 29 17:31:39 volumio-x86 volumio[678]: info: Applying required configuration parameters for plugin autostart Oct 29 17:31:39 volumio-x86 volumio[678]: info: AutoStart - onVolumioStart - read config.json Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "outputs"... Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "albumart"... Oct 29 17:31:39 volumio-x86 volumio[678]: info: Plugin example_plugin is not enabled Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "inputs"... Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "updater_comm"... Oct 29 17:31:39 volumio-x86 volumio[678]: info: Plugin mpdemulation is not enabled Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "rest_api"... Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading plugin "websocket"... Oct 29 17:31:39 volumio-x86 volumio[678]: info: Loading i18n strings for locale en Oct 29 17:31:39 volumio-x86 volumio[678]: Updating browse sources language Oct 29 17:31:39 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 29 17:31:39 volumio-x86 volumio[678]: Forking 1 albumart workers Oct 29 17:31:40 volumio-x86 mpd[813]: Oct 29 17:31 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Oct 29 17:31:40 volumio-x86 mpd[813]: Oct 29 17:31 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Oct 29 17:31:40 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 29 17:31:40 volumio-x86 sudo[808]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::initPlayerControls Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: Express server listening on port 3000 Oct 29 17:31:40 volumio-x86 volumio[678]: [Metrics] WebUI: 3s 754.01ms Oct 29 17:31:40 volumio-x86 volumio[678]: info: Setting Device type: x86 Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreStateMachine::resetVolumioState Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreStateMachine::getcurrentVolume Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::volumioRetrievevolume Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 29 17:31:40 volumio-x86 volumio[678]: info: Completed loading Core Plugins Oct 29 17:31:40 volumio-x86 volumio[678]: info: Preparing to generate the ALSA configuration file Oct 29 17:31:40 volumio-x86 volumio[678]: info: Cannot mount NAS Server at system boot, trial number 1 ,retrying in 5 seconds Oct 29 17:31:40 volumio-x86 volumio[678]: info: MPD Permissions set Oct 29 17:31:40 volumio-x86 volumio[678]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Oct 29 17:31:40 volumio-x86 volumio[678]: wlan0 Interface doesn't support scanning. Oct 29 17:31:40 volumio-x86 volumio[678]: info: Cannot use regular scanning, forcing with ap-force Oct 29 17:31:40 volumio-x86 sudo[849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Oct 29 17:31:40 volumio-x86 sudo[849]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:40 volumio-x86 sudo[849]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:40 volumio-x86 volumio[678]: command failed: No such device (-19) Oct 29 17:31:40 volumio-x86 volumio[678]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Oct 29 17:31:40 volumio-x86 volumio[678]: command failed: No such device (-19) Oct 29 17:31:40 volumio-x86 volumio-remote-updater[325]: [2024-10-29 17:31:40] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1730223097 101 Oct 29 17:31:40 volumio-x86 volumio[678]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Oct 29 17:31:40 volumio-x86 volumio[678]: info: MPD running with PID813 Oct 29 17:31:40 volumio-x86 volumio[678]: ,establishing connection Oct 29 17:31:40 volumio-x86 volumio[678]: Starting albumart workers Oct 29 17:31:40 volumio-x86 volumio[678]: error: MPD error: The expression evaluated to a falsy value: Oct 29 17:31:40 volumio-x86 volumio[678]: assert.ok(self.idling) Oct 29 17:31:40 volumio-x86 volumio[678]: error: The expression evaluated to a falsy value: Oct 29 17:31:40 volumio-x86 volumio[678]: assert.ok(self.idling) Oct 29 17:31:40 volumio-x86 volumio[678]: error: MPD error: The expression evaluated to a falsy value: Oct 29 17:31:40 volumio-x86 volumio[678]: assert.ok(self.idling) Oct 29 17:31:40 volumio-x86 volumio[678]: error: The expression evaluated to a falsy value: Oct 29 17:31:40 volumio-x86 volumio[678]: assert.ok(self.idling) Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: Reloading queue from file Oct 29 17:31:40 volumio-x86 volumio[678]: info: VolumeController:: Volume=28 Mute =false Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreStateMachine::pushState Oct 29 17:31:40 volumio-x86 volumio[678]: info: CorePlayQueue::getTrack 0 Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::volumioPushState Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreStateMachine::updateTrackBlock Oct 29 17:31:40 volumio-x86 volumio[678]: info: CorePlayQueue::getTrackBlock Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::volumioRetrievevolume Oct 29 17:31:40 volumio-x86 volumio[678]: info: Asound.conf file unchanged, so no further update is needed Oct 29 17:31:40 volumio-x86 volumio[678]: info: Output device has changed, restarting MPD Oct 29 17:31:40 volumio-x86 volumio[678]: info: ___________ START PLUGINS ___________ Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 29 17:31:40 volumio-x86 volumio[678]: info: [1730223100586] CoreMusicLibrary::Adding element Last_100 Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 29 17:31:40 volumio-x86 volumio[678]: info: [1730223100593] CoreMusicLibrary::Adding element Webradio Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 29 17:31:40 volumio-x86 volumio[678]: info: AutoStart - onStart Oct 29 17:31:40 volumio-x86 sudo[868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 29 17:31:40 volumio-x86 sudo[868]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:40 volumio-x86 sudo[867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 29 17:31:40 volumio-x86 sudo[867]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:40 volumio-x86 volumio[678]: info: Volumio Calling Home Oct 29 17:31:40 volumio-x86 sudo[867]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:40 volumio-x86 systemd[1]: Stopping Music Player Daemon... Oct 29 17:31:40 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 29 17:31:40 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 29 17:31:40 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 29 17:31:40 volumio-x86 volumio[678]: info: Completed starting Core Plugins Oct 29 17:31:40 volumio-x86 volumio[678]: info: ------------------------------------------- Oct 29 17:31:40 volumio-x86 volumio[678]: info: ----- MyVolumio plugins startup ---- Oct 29 17:31:40 volumio-x86 volumio[678]: info: ------------------------------------------- Oct 29 17:31:40 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreStateMachine::setRepeat null single undefined Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreStateMachine::pushState Oct 29 17:31:40 volumio-x86 volumio[678]: info: CorePlayQueue::getTrack 0 Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::volumioPushState Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreStateMachine::setRandom null Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreStateMachine::pushState Oct 29 17:31:40 volumio-x86 volumio[678]: info: CorePlayQueue::getTrack 0 Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::volumioPushState Oct 29 17:31:40 volumio-x86 volumio[678]: error: updateQueue error: null Oct 29 17:31:40 volumio-x86 volumio[678]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 29 17:31:40 volumio-x86 volumio[678]: info: MPD Permissions set Oct 29 17:31:40 volumio-x86 volumio[678]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 29 17:31:40 volumio-x86 volumio[678]: info: VolumeController:: Volume=28 Mute =false Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreStateMachine::pushState Oct 29 17:31:40 volumio-x86 volumio[678]: info: CorePlayQueue::getTrack 0 Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::volumioPushState Oct 29 17:31:40 volumio-x86 volumio[678]: info: CoreCommandRouter::volumioGetState Oct 29 17:31:40 volumio-x86 volumio[678]: info: CorePlayQueue::getTrack 0 Oct 29 17:31:41 volumio-x86 mpd[884]: Oct 29 17:31 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 29 17:31:41 volumio-x86 mpd[884]: Oct 29 17:31 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Oct 29 17:31:41 volumio-x86 mpd[884]: Oct 29 17:31 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Oct 29 17:31:41 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 29 17:31:41 volumio-x86 sudo[868]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:41 volumio-x86 volumio[678]: error: updateQueue error: null Oct 29 17:31:42 volumio-x86 dhcpcd[394]: eth0: leased 192.168.1.168 for 43200 seconds Oct 29 17:31:42 volumio-x86 dhcpcd[394]: eth0: adding route to 192.168.1.0/24 Oct 29 17:31:42 volumio-x86 dhcpcd[394]: eth0: adding default route via 192.168.1.1 Oct 29 17:31:42 volumio-x86 avahi-daemon[335]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.168. Oct 29 17:31:42 volumio-x86 avahi-daemon[335]: New relevant interface eth0.IPv4 for mDNS. Oct 29 17:31:42 volumio-x86 avahi-daemon[335]: Registering new address record for 192.168.1.168 on eth0.IPv4. Oct 29 17:31:42 volumio-x86 ntpd[558]: ntpd exiting on signal 15 (Terminated) Oct 29 17:31:42 volumio-x86 systemd[1]: Stopping Network Time Service... Oct 29 17:31:42 volumio-x86 systemd[1]: ntp.service: Succeeded. Oct 29 17:31:42 volumio-x86 systemd[1]: Stopped Network Time Service. Oct 29 17:31:42 volumio-x86 systemd[1]: Starting Network Time Service... Oct 29 17:31:42 volumio-x86 ntpd[928]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 29 17:31:42 volumio-x86 ntpd[928]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 29 17:31:42 volumio-x86 systemd[1]: Started Network Time Service. Oct 29 17:31:42 volumio-x86 ntpd[934]: proto: precision = 0.138 usec (-23) Oct 29 17:31:42 volumio-x86 ntpd[934]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 29 17:31:42 volumio-x86 ntpd[934]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 29 17:31:42 volumio-x86 ntpd[934]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 672 days ago Oct 29 17:31:42 volumio-x86 ntpd[934]: Listen and drop on 0 v6wildcard [::]:123 Oct 29 17:31:42 volumio-x86 ntpd[934]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 29 17:31:42 volumio-x86 ntpd[934]: Listen normally on 2 lo 127.0.0.1:123 Oct 29 17:31:42 volumio-x86 ntpd[934]: Listen normally on 3 eth0 192.168.1.168:123 Oct 29 17:31:42 volumio-x86 ntpd[934]: Listening on routing socket on fd #20 for interface updates Oct 29 17:31:42 volumio-x86 ntpd[934]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 29 17:31:42 volumio-x86 ntpd[934]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 29 17:31:43 volumio-x86 volumio[678]: info: Discovery: Browse raised the following error Error: getaddrinfo -3008 Oct 29 17:31:43 volumio-x86 ntpd[934]: Soliciting pool server 85.199.214.101 Oct 29 17:31:44 volumio-x86 ntpd[934]: Soliciting pool server 85.199.214.98 Oct 29 17:31:44 volumio-x86 ntpd[934]: Soliciting pool server 77.68.81.77 Oct 29 17:31:44 volumio-x86 nmbd[539]: [2024/10/29 17:31:44.387089, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 29 17:31:44 volumio-x86 nmbd[539]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 29 17:31:44 volumio-x86 systemd[1]: Started Samba NMB Daemon. Oct 29 17:31:44 volumio-x86 systemd[1]: Starting Samba Winbind Daemon... Oct 29 17:31:44 volumio-x86 winbindd[937]: [2024/10/29 17:31:44.532653, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Oct 29 17:31:44 volumio-x86 winbindd[937]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 29 17:31:44 volumio-x86 winbindd[937]: [2024/10/29 17:31:44.540599, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 29 17:31:44 volumio-x86 systemd[1]: Started Samba Winbind Daemon. Oct 29 17:31:44 volumio-x86 winbindd[937]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 29 17:31:44 volumio-x86 systemd[1]: Starting Samba SMB Daemon... Oct 29 17:31:44 volumio-x86 smbd[942]: [2024/10/29 17:31:44.800340, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 29 17:31:44 volumio-x86 systemd[1]: Started Samba SMB Daemon. Oct 29 17:31:44 volumio-x86 smbd[942]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 29 17:31:44 volumio-x86 systemd[1]: Reached target Multi-User System. Oct 29 17:31:44 volumio-x86 systemd[1]: Reached target Graphical Interface. Oct 29 17:31:44 volumio-x86 systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 29 17:31:44 volumio-x86 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 29 17:31:44 volumio-x86 systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 29 17:31:44 volumio-x86 systemd[1]: Startup finished in 20.961s (kernel) + 16.809s (userspace) = 37.770s. Oct 29 17:31:45 volumio-x86 sudo[952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=media,password=Xbox1,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.10/#~Muzic~# /mnt/NAS/Server Oct 29 17:31:45 volumio-x86 sudo[952]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:45 volumio-x86 kernel: CIFS: Attempting to mount //192.168.0.10/#~Muzic~# Oct 29 17:31:45 volumio-x86 sudo[952]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:45 volumio-x86 volumio[678]: info: Cannot mount NAS Server at system boot, trial number 2 ,retrying in 5 seconds Oct 29 17:31:45 volumio-x86 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Oct 29 17:31:45 volumio-x86 kernel: CIFS: VFS: cifs_mount failed w/return code = -111 Oct 29 17:31:45 volumio-x86 ntpd[934]: Soliciting pool server 217.114.59.3 Oct 29 17:31:45 volumio-x86 ntpd[934]: Soliciting pool server 51.89.151.183 Oct 29 17:31:45 volumio-x86 ntpd[934]: Soliciting pool server 85.199.214.99 Oct 29 17:31:46 volumio-x86 ntpd[934]: Soliciting pool server 82.219.4.30 Oct 29 17:31:46 volumio-x86 ntpd[934]: Soliciting pool server 149.22.220.130 Oct 29 17:31:46 volumio-x86 ntpd[934]: Soliciting pool server 85.199.214.102 Oct 29 17:31:47 volumio-x86 ntpd[934]: Soliciting pool server 185.57.191.229 Oct 29 17:31:47 volumio-x86 ntpd[934]: Soliciting pool server 185.57.191.229 Oct 29 17:31:47 volumio-x86 ntpd[934]: Soliciting pool server 193.57.144.50 Oct 29 17:31:48 volumio-x86 ntpd[934]: Soliciting pool server 81.142.114.66 Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 29 17:31:49 volumio-x86 volumio[678]: info: Adding plugin bluetooth to MyMusic Plugins Oct 29 17:31:49 volumio-x86 volumio[678]: info: Adding plugin multiroom to MyMusic Plugins Oct 29 17:31:49 volumio-x86 volumio[678]: info: Adding plugin metavolumio to MyMusic Plugins Oct 29 17:31:49 volumio-x86 volumio[678]: info: Adding plugin cd_controller to MyMusic Plugins Oct 29 17:31:49 volumio-x86 volumio[678]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 29 17:31:49 volumio-x86 volumio[678]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 29 17:31:49 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 29 17:31:49 volumio-x86 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 29 17:31:49 volumio-x86 volumio[678]: info: Starting MyVolumio Remote Streaming Endpoints Oct 29 17:31:49 volumio-x86 volumio[678]: info: MyVolumio login type: Token Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 29 17:31:49 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 29 17:31:50 volumio-x86 volumio[678]: info: Starting Streaming Service Transparent Proxy Oct 29 17:31:50 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 29 17:31:50 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 29 17:31:50 volumio-x86 volumio[678]: info: Streaming services startup Oct 29 17:31:50 volumio-x86 volumio[678]: info: Starting Streaming Daemon Oct 29 17:31:50 volumio-x86 sudo[965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 29 17:31:50 volumio-x86 volumio[678]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 29 17:31:50 volumio-x86 sudo[965]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:50 volumio-x86 sudo[965]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:50 volumio-x86 volumio[678]: error: Cannot start Volumio Streaming Daemon Oct 29 17:31:50 volumio-x86 volumio[678]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 29 17:31:50 volumio-x86 volumio[678]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 29 17:31:50 volumio-x86 sudo[971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=media,password=Xbox1,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.10/#~Muzic~# /mnt/NAS/Server Oct 29 17:31:50 volumio-x86 sudo[971]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:50 volumio-x86 kernel: CIFS: Attempting to mount //192.168.0.10/#~Muzic~# Oct 29 17:31:50 volumio-x86 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Oct 29 17:31:50 volumio-x86 kernel: CIFS: VFS: cifs_mount failed w/return code = -111 Oct 29 17:31:50 volumio-x86 sudo[971]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:50 volumio-x86 volumio[678]: info: Cannot mount NAS Server at system boot, trial number 3 ,retrying in 5 seconds Oct 29 17:31:50 volumio-x86 volumio[678]: error: MyVolumio Custom Token format not valid, refreshing it Oct 29 17:31:50 volumio-x86 volumio[678]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.449&uuid=83a80dcbaa3b9c5af43581d67c39df97" http://updates.volumio.org/downloader-v1/track-device Oct 29 17:31:50 volumio-x86 volumio[678]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 29 17:31:50 volumio-x86 volumio[678]: Dload Upload Total Spent Left Speed Oct 29 17:31:50 volumio-x86 volumio[678]: [132B blob data] Oct 29 17:31:50 volumio-x86 volumio[678]: retrying in 5 seconds, trial 0 Oct 29 17:31:50 volumio-x86 volumio[678]: info: Volumio Calling Home Oct 29 17:31:50 volumio-x86 volumio[678]: info: Volumio called home Oct 29 17:31:51 volumio-x86 volumio[678]: STREAMING PROXY: Starting server on port 3245 Oct 29 17:31:51 volumio-x86 volumio[678]: Node JS runtime: 14 Oct 29 17:31:51 volumio-x86 volumio[678]: info: MyVolumio login type: Token Oct 29 17:31:51 volumio-x86 volumio[678]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 29 17:31:51 volumio-x86 volumio[678]: info: MYVOLUMIO: Adding device Oct 29 17:31:51 volumio-x86 volumio[678]: info: MYVOLUMIO: Evaluating Server Oct 29 17:31:52 volumio-x86 volumio[678]: info: MyVolumio status changed Oct 29 17:31:52 volumio-x86 volumio[678]: info: Streaming services startup Oct 29 17:31:52 volumio-x86 volumio[678]: info: Starting Streaming Daemon Oct 29 17:31:52 volumio-x86 ntpd[934]: receive: Unexpected origin timestamp 0xeacb9a88.4cb83827 does not match aorg 0000000000.00000000 from server@185.57.191.229 xmt 0xeacb9a88.18f2f345 Oct 29 17:31:52 volumio-x86 ntpd[934]: receive: Unexpected origin timestamp 0xeacb9a88.4cc75347 does not match aorg 0000000000.00000000 from server@82.219.4.30 xmt 0xeacb9a88.19447922 Oct 29 17:31:52 volumio-x86 volumio[678]: info: Removing browser output: myVolumio user plan is not superstar Oct 29 17:31:52 volumio-x86 volumio[678]: info: Removing audio output: Oct 29 17:31:52 volumio-x86 volumio[678]: info: Stoppping Tunnel 1 Oct 29 17:31:52 volumio-x86 sudo[996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 29 17:31:52 volumio-x86 sudo[996]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:52 volumio-x86 sudo[996]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:52 volumio-x86 sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 29 17:31:52 volumio-x86 sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 17:31:52 volumio-x86 volumio[678]: error: Failed to ping endpoint us1.myvolumio.org : unknown error Oct 29 17:31:52 volumio-x86 volumio[678]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 17:31:52 volumio-x86 volumio[678]: Error: Unable to resolve or reject the same promise twice Oct 29 17:31:52 volumio-x86 volumio[678]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 29 17:31:52 volumio-x86 volumio[678]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:31810) Oct 29 17:31:52 volumio-x86 volumio[678]: at Socket.emit (events.js:412:35) Oct 29 17:31:52 volumio-x86 volumio[678]: at endReadableNT (internal/streams/readable.js:1333:12) Oct 29 17:31:52 volumio-x86 volumio[678]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Oct 29 17:31:52 volumio-x86 volumio[678]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 17:31:52 volumio-x86 sudo[1000]: pam_unix(sudo:session): session closed for user root Oct 29 17:31:52 volumio-x86 sudo[1011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-29 17:30 Oct 29 17:31:52 volumio-x86 sudo[1011]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="c87c6e2b1ae33dc5801986cbcbe970898b92e7b4" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="b949d6001d7e656b4668f31c119d2247cdf45158" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 30 Mar 2023 06:13:59 PM CEST" VOLUMIO_VERSION="3.449" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6a6571e2ab129da64c127254a7a779b9"