-- Logs begin at Mon 2025-06-23 10:03:02 UTC, end at Mon 2025-06-23 10:03:45 UTC. -- Jun 23 10:03:02 volumio-werkkamer2 kernel: Linux version 6.6.32-volumio (gkkpch@UbuntuVM24.04) (gcc (Ubuntu 13.2.0-23ubuntu4) 13.2.0, GNU ld (GNU Binutils for Ubuntu) 2.42) #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 Jun 23 10:03:02 volumio-werkkamer2 kernel: Command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=92947385-dd02-4870-acbc-cdf34605d219 bootpart=UUID=3101-B321 datapart=UUID=1bee0927-e695-46ea-ab3b-7bcb5a437135 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no Jun 23 10:03:02 volumio-werkkamer2 kernel: KERNEL supported cpus: Jun 23 10:03:02 volumio-werkkamer2 kernel: Intel GenuineIntel Jun 23 10:03:02 volumio-werkkamer2 kernel: AMD AuthenticAMD Jun 23 10:03:02 volumio-werkkamer2 kernel: Hygon HygonGenuine Jun 23 10:03:02 volumio-werkkamer2 kernel: Centaur CentaurHauls Jun 23 10:03:02 volumio-werkkamer2 kernel: zhaoxin Shanghai Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-provided physical RAM map: Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000008efff] usable Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x000000000008f000-0x000000000008ffff] ACPI NVS Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000000090000-0x000000000009ffff] usable Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000001effffff] usable Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x000000001f000000-0x00000000200fffff] reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000020100000-0x0000000079143fff] usable Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000079144000-0x0000000079173fff] reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000079174000-0x0000000079183fff] ACPI data Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000079184000-0x000000007990afff] ACPI NVS Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x000000007990b000-0x0000000079b8dfff] reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000079b8e000-0x0000000079bd5fff] type 20 Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000079bd6000-0x0000000079bd6fff] usable Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000079bd7000-0x0000000079c18fff] reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000079c19000-0x0000000079d87fff] usable Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000079d88000-0x0000000079ff9fff] reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x0000000079ffa000-0x0000000079ffffff] usable Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x00000000e00f8000-0x00000000e00f8fff] reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x00000000fed01000-0x00000000fed01fff] reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: BIOS-e820: [mem 0x00000000ffb00000-0x00000000ffffffff] reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: NX (Execute Disable) protection: active Jun 23 10:03:02 volumio-werkkamer2 kernel: APIC: Static calls initialized Jun 23 10:03:02 volumio-werkkamer2 kernel: efi: EFI v2.3.1 by American Megatrends Jun 23 10:03:02 volumio-werkkamer2 kernel: efi: ESRT=0x79b8a498 ACPI=0x79178000 ACPI 2.0=0x79178000 SMBIOS=0xf04d0 Jun 23 10:03:02 volumio-werkkamer2 kernel: efi: Not removing mem32: MMIO range=[0xe00f8000-0xe00f8fff] (4KB) from e820 map Jun 23 10:03:02 volumio-werkkamer2 kernel: efi: Not removing mem33: MMIO range=[0xfed01000-0xfed01fff] (4KB) from e820 map Jun 23 10:03:02 volumio-werkkamer2 kernel: efi: Remove mem34: MMIO range=[0xffb00000-0xffffffff] (5MB) from e820 map Jun 23 10:03:02 volumio-werkkamer2 kernel: e820: remove [mem 0xffb00000-0xffffffff] reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: SMBIOS 2.8 present. Jun 23 10:03:02 volumio-werkkamer2 kernel: DMI: Atrust Computer Corp. t180/t180, BIOS 1.20 05/06/2014 Jun 23 10:03:02 volumio-werkkamer2 kernel: tsc: Detected 1866.667 MHz processor Jun 23 10:03:02 volumio-werkkamer2 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jun 23 10:03:02 volumio-werkkamer2 kernel: last_pfn = 0x7a000 max_arch_pfn = 0x400000000 Jun 23 10:03:02 volumio-werkkamer2 kernel: MTRR map: 6 entries (4 fixed + 2 variable; max 20), built from 8 variable MTRRs Jun 23 10:03:02 volumio-werkkamer2 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jun 23 10:03:02 volumio-werkkamer2 kernel: found SMP MP-table at [mem 0x000fd650-0x000fd65f] Jun 23 10:03:02 volumio-werkkamer2 kernel: esrt: Reserving ESRT space from 0x0000000079b8a498 to 0x0000000079b8a4d0. Jun 23 10:03:02 volumio-werkkamer2 kernel: Secure boot could not be determined Jun 23 10:03:02 volumio-werkkamer2 kernel: RAMDISK: [mem 0x2fae7000-0x33d6afff] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Early table checksum verification disabled Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: RSDP 0x0000000079178000 000024 (v02 ALASKA) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: XSDT 0x0000000079178080 00007C (v01 ALASKA A M I 01072009 AMI 00010013) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: FACP 0x0000000079182960 00010C (v05 ALASKA A M I 01072009 AMI 00010013) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI BIOS Warning (bug): 32/64X length mismatch in FADT/Gpe0Block: 128/32 (20230628/tbfadt-564) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: DSDT 0x0000000079178188 00A7D4 (v02 ALASKA A M I 01072009 INTL 20120913) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: FACS 0x000000007990AF80 000040 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: APIC 0x0000000079182A70 000084 (v03 ALASKA A M I 01072009 AMI 00010013) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: FPDT 0x0000000079182AF8 000044 (v01 ALASKA A M I 01072009 AMI 00010013) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: MCFG 0x0000000079182B40 00003C (v01 ALASKA A M I 01072009 MSFT 00000097) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: LPIT 0x0000000079182B80 000104 (v01 ALASKA A M I 00000003 VLV2 0100000D) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: HPET 0x0000000079182C88 000038 (v01 ALASKA A M I 01072009 AMI. 00000005) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: SSDT 0x0000000079182CC0 000763 (v01 PmRef CpuPm 00003000 INTL 20061109) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: SSDT 0x0000000079183428 000290 (v01 PmRef Cpu0Tst 00003000 INTL 20061109) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: SSDT 0x00000000791836B8 00017A (v01 PmRef ApTst 00003000 INTL 20061109) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: UEFI 0x0000000079183838 000042 (v01 ALASKA A M I 00000000 00000000) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: BGRT 0x0000000079183880 000038 (v01 ALASKA A M I 01072009 AMI 00010013) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving FACP table memory at [mem 0x79182960-0x79182a6b] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving DSDT table memory at [mem 0x79178188-0x7918295b] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving FACS table memory at [mem 0x7990af80-0x7990afbf] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving APIC table memory at [mem 0x79182a70-0x79182af3] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving FPDT table memory at [mem 0x79182af8-0x79182b3b] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving MCFG table memory at [mem 0x79182b40-0x79182b7b] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving LPIT table memory at [mem 0x79182b80-0x79182c83] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving HPET table memory at [mem 0x79182c88-0x79182cbf] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving SSDT table memory at [mem 0x79182cc0-0x79183422] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving SSDT table memory at [mem 0x79183428-0x791836b7] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving SSDT table memory at [mem 0x791836b8-0x79183831] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving UEFI table memory at [mem 0x79183838-0x79183879] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Reserving BGRT table memory at [mem 0x79183880-0x791838b7] Jun 23 10:03:02 volumio-werkkamer2 kernel: Zone ranges: Jun 23 10:03:02 volumio-werkkamer2 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: DMA32 [mem 0x0000000001000000-0x0000000079ffffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: Normal empty Jun 23 10:03:02 volumio-werkkamer2 kernel: Movable zone start for each node Jun 23 10:03:02 volumio-werkkamer2 kernel: Early memory node ranges Jun 23 10:03:02 volumio-werkkamer2 kernel: node 0: [mem 0x0000000000001000-0x000000000008efff] Jun 23 10:03:02 volumio-werkkamer2 kernel: node 0: [mem 0x0000000000090000-0x000000000009ffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: node 0: [mem 0x0000000000100000-0x000000001effffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: node 0: [mem 0x0000000020100000-0x0000000079143fff] Jun 23 10:03:02 volumio-werkkamer2 kernel: node 0: [mem 0x0000000079bd6000-0x0000000079bd6fff] Jun 23 10:03:02 volumio-werkkamer2 kernel: node 0: [mem 0x0000000079c19000-0x0000000079d87fff] Jun 23 10:03:02 volumio-werkkamer2 kernel: node 0: [mem 0x0000000079ffa000-0x0000000079ffffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x0000000079ffffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jun 23 10:03:02 volumio-werkkamer2 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jun 23 10:03:02 volumio-werkkamer2 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Jun 23 10:03:02 volumio-werkkamer2 kernel: On node 0, zone DMA32: 4352 pages in unavailable ranges Jun 23 10:03:02 volumio-werkkamer2 kernel: On node 0, zone DMA32: 2706 pages in unavailable ranges Jun 23 10:03:02 volumio-werkkamer2 kernel: On node 0, zone DMA32: 66 pages in unavailable ranges Jun 23 10:03:02 volumio-werkkamer2 kernel: On node 0, zone DMA32: 626 pages in unavailable ranges Jun 23 10:03:02 volumio-werkkamer2 kernel: On node 0, zone DMA32: 24576 pages in unavailable ranges Jun 23 10:03:02 volumio-werkkamer2 kernel: x86/hpet: Will disable the HPET for this platform because it's not reliable Jun 23 10:03:02 volumio-werkkamer2 kernel: Reserving Intel graphics memory at [mem 0x7b000000-0x7effffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PM-Timer IO Port: 0x408 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] high level lint[0x69]) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: NMI not connected to LINT 1! Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: LAPIC_NMI (acpi_id[0x02] dfl res lint[0xdd]) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: NMI not connected to LINT 1! Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: LAPIC_NMI (acpi_id[0x03] res dfl lint[0xa]) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: NMI not connected to LINT 1! Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: LAPIC_NMI (acpi_id[0x04] low dfl lint[0xee]) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: NMI not connected to LINT 1! Jun 23 10:03:02 volumio-werkkamer2 kernel: IOAPIC[0]: apic_id 1, version 32, address 0xfec00000, GSI 0-86 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jun 23 10:03:02 volumio-werkkamer2 kernel: e820: update [mem 0x6d926000-0x6db66fff] usable ==> reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: TSC deadline timer available Jun 23 10:03:02 volumio-werkkamer2 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x0008f000-0x0008ffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000fffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x1f000000-0x200fffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x6d926000-0x6db66fff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x79144000-0x79173fff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x79174000-0x79183fff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x79184000-0x7990afff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x7990b000-0x79b8dfff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x79b8e000-0x79bd5fff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x79bd7000-0x79c18fff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PM: hibernation: Registered nosave memory: [mem 0x79d88000-0x79ff9fff] Jun 23 10:03:02 volumio-werkkamer2 kernel: [mem 0x7f000000-0xe00f7fff] available for PCI devices Jun 23 10:03:02 volumio-werkkamer2 kernel: Booting paravirtualized kernel on bare hardware Jun 23 10:03:02 volumio-werkkamer2 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Jun 23 10:03:02 volumio-werkkamer2 kernel: setup_percpu: NR_CPUS:8 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jun 23 10:03:02 volumio-werkkamer2 kernel: percpu: Embedded 56 pages/cpu s191400 r8192 d29784 u524288 Jun 23 10:03:02 volumio-werkkamer2 kernel: pcpu-alloc: s191400 r8192 d29784 u524288 alloc=1*2097152 Jun 23 10:03:02 volumio-werkkamer2 kernel: pcpu-alloc: [0] 0 1 2 3 Jun 23 10:03:02 volumio-werkkamer2 kernel: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=92947385-dd02-4870-acbc-cdf34605d219 bootpart=UUID=3101-B321 datapart=UUID=1bee0927-e695-46ea-ab3b-7bcb5a437135 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no Jun 23 10:03:02 volumio-werkkamer2 kernel: Unknown kernel command line parameters "splash BOOT_IMAGE=/vmlinuz biosdevname=0 imgpart=UUID=92947385-dd02-4870-acbc-cdf34605d219 bootpart=UUID=3101-B321 datapart=UUID=1bee0927-e695-46ea-ab3b-7bcb5a437135 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh use_kmsg=no", will be passed to user space. Jun 23 10:03:02 volumio-werkkamer2 kernel: random: crng init done Jun 23 10:03:02 volumio-werkkamer2 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: Built 1 zonelists, mobility grouping on. Total pages: 483898 Jun 23 10:03:02 volumio-werkkamer2 kernel: mem auto-init: stack:all(zero), heap alloc:off, heap free:off Jun 23 10:03:02 volumio-werkkamer2 kernel: Memory: 1578492K/1967456K available (14336K kernel code, 1878K rwdata, 4640K rodata, 2988K init, 1148K bss, 388708K reserved, 0K cma-reserved) Jun 23 10:03:02 volumio-werkkamer2 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jun 23 10:03:02 volumio-werkkamer2 kernel: Kernel/User page tables isolation: enabled Jun 23 10:03:02 volumio-werkkamer2 kernel: ftrace: allocating 40433 entries in 158 pages Jun 23 10:03:02 volumio-werkkamer2 kernel: ftrace: allocated 158 pages with 5 groups Jun 23 10:03:02 volumio-werkkamer2 kernel: Dynamic Preempt: voluntary Jun 23 10:03:02 volumio-werkkamer2 kernel: rcu: Preemptible hierarchical RCU implementation. Jun 23 10:03:02 volumio-werkkamer2 kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Jun 23 10:03:02 volumio-werkkamer2 kernel: Trampoline variant of Tasks RCU enabled. Jun 23 10:03:02 volumio-werkkamer2 kernel: Rude variant of Tasks RCU enabled. Jun 23 10:03:02 volumio-werkkamer2 kernel: Tracing variant of Tasks RCU enabled. Jun 23 10:03:02 volumio-werkkamer2 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Jun 23 10:03:02 volumio-werkkamer2 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jun 23 10:03:02 volumio-werkkamer2 kernel: NR_IRQS: 4352, nr_irqs: 1024, preallocated irqs: 16 Jun 23 10:03:02 volumio-werkkamer2 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jun 23 10:03:02 volumio-werkkamer2 kernel: Console: colour dummy device 80x25 Jun 23 10:03:02 volumio-werkkamer2 kernel: printk: console [tty0] enabled Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Core revision 20230628 Jun 23 10:03:02 volumio-werkkamer2 kernel: APIC: Switch to symmetric I/O mode setup Jun 23 10:03:02 volumio-werkkamer2 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x35d0576519e, max_idle_ns: 881590626659 ns Jun 23 10:03:02 volumio-werkkamer2 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 3733.33 BogoMIPS (lpj=7466668) Jun 23 10:03:02 volumio-werkkamer2 kernel: CPU0: Thermal monitoring enabled (TM1) Jun 23 10:03:02 volumio-werkkamer2 kernel: process: using mwait in idle threads Jun 23 10:03:02 volumio-werkkamer2 kernel: Last level iTLB entries: 4KB 48, 2MB 0, 4MB 0 Jun 23 10:03:02 volumio-werkkamer2 kernel: Last level dTLB entries: 4KB 128, 2MB 16, 4MB 16, 1GB 0 Jun 23 10:03:02 volumio-werkkamer2 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jun 23 10:03:02 volumio-werkkamer2 kernel: Spectre V2 : Mitigation: Retpolines Jun 23 10:03:02 volumio-werkkamer2 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Jun 23 10:03:02 volumio-werkkamer2 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Jun 23 10:03:02 volumio-werkkamer2 kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Jun 23 10:03:02 volumio-werkkamer2 kernel: MMIO Stale Data: Unknown: No mitigations Jun 23 10:03:02 volumio-werkkamer2 kernel: x86/fpu: x87 FPU will use FXSAVE Jun 23 10:03:02 volumio-werkkamer2 kernel: Freeing SMP alternatives memory: 32K Jun 23 10:03:02 volumio-werkkamer2 kernel: pid_max: default: 32768 minimum: 301 Jun 23 10:03:02 volumio-werkkamer2 kernel: LSM: initializing lsm=capability,yama,integrity Jun 23 10:03:02 volumio-werkkamer2 kernel: Yama: becoming mindful. Jun 23 10:03:02 volumio-werkkamer2 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: smpboot: CPU0: Intel(R) Celeron(R) CPU N2920 @ 1.86GHz (family: 0x6, model: 0x37, stepping: 0x3) Jun 23 10:03:02 volumio-werkkamer2 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Jun 23 10:03:02 volumio-werkkamer2 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Jun 23 10:03:02 volumio-werkkamer2 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Jun 23 10:03:02 volumio-werkkamer2 kernel: Performance Events: PEBS fmt2+, 8-deep LBR, Silvermont events, 8-deep LBR, full-width counters, Intel PMU driver. Jun 23 10:03:02 volumio-werkkamer2 kernel: ... version: 3 Jun 23 10:03:02 volumio-werkkamer2 kernel: ... bit width: 40 Jun 23 10:03:02 volumio-werkkamer2 kernel: ... generic registers: 2 Jun 23 10:03:02 volumio-werkkamer2 kernel: ... value mask: 000000ffffffffff Jun 23 10:03:02 volumio-werkkamer2 kernel: ... max period: 0000007fffffffff Jun 23 10:03:02 volumio-werkkamer2 kernel: ... fixed-purpose events: 3 Jun 23 10:03:02 volumio-werkkamer2 kernel: ... event mask: 0000000700000003 Jun 23 10:03:02 volumio-werkkamer2 kernel: signal: max sigframe size: 1440 Jun 23 10:03:02 volumio-werkkamer2 kernel: Estimated ratio of average max frequency by base frequency (times 1024): 1097 Jun 23 10:03:02 volumio-werkkamer2 kernel: rcu: Hierarchical SRCU implementation. Jun 23 10:03:02 volumio-werkkamer2 kernel: rcu: Max phase no-delay instances is 1000. Jun 23 10:03:02 volumio-werkkamer2 kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. Jun 23 10:03:02 volumio-werkkamer2 kernel: smp: Bringing up secondary CPUs ... Jun 23 10:03:02 volumio-werkkamer2 kernel: smpboot: x86: Booting SMP configuration: Jun 23 10:03:02 volumio-werkkamer2 kernel: .... node #0, CPUs: #1 #2 #3 Jun 23 10:03:02 volumio-werkkamer2 kernel: smp: Brought up 1 node, 4 CPUs Jun 23 10:03:02 volumio-werkkamer2 kernel: smpboot: Max logical packages: 1 Jun 23 10:03:02 volumio-werkkamer2 kernel: smpboot: Total of 4 processors activated (14933.33 BogoMIPS) Jun 23 10:03:02 volumio-werkkamer2 kernel: devtmpfs: initialized Jun 23 10:03:02 volumio-werkkamer2 kernel: x86/mm: Memory block size: 128MB Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0008f000-0x0008ffff] (4096 bytes) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x79184000-0x7990afff] (7892992 bytes) Jun 23 10:03:02 volumio-werkkamer2 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Jun 23 10:03:02 volumio-werkkamer2 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: pinctrl core: initialized pinctrl subsystem Jun 23 10:03:02 volumio-werkkamer2 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jun 23 10:03:02 volumio-werkkamer2 kernel: audit: initializing netlink subsys (disabled) Jun 23 10:03:02 volumio-werkkamer2 kernel: audit: type=2000 audit(1750672972.004:1): state=initialized audit_enabled=0 res=1 Jun 23 10:03:02 volumio-werkkamer2 kernel: thermal_sys: Registered thermal governor 'fair_share' Jun 23 10:03:02 volumio-werkkamer2 kernel: thermal_sys: Registered thermal governor 'bang_bang' Jun 23 10:03:02 volumio-werkkamer2 kernel: thermal_sys: Registered thermal governor 'step_wise' Jun 23 10:03:02 volumio-werkkamer2 kernel: thermal_sys: Registered thermal governor 'user_space' Jun 23 10:03:02 volumio-werkkamer2 kernel: EISA bus registered Jun 23 10:03:02 volumio-werkkamer2 kernel: cpuidle: using governor ladder Jun 23 10:03:02 volumio-werkkamer2 kernel: cpuidle: using governor menu Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI FADT declares the system doesn't support PCIe ASPM, so disable it Jun 23 10:03:02 volumio-werkkamer2 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jun 23 10:03:02 volumio-werkkamer2 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Jun 23 10:03:02 volumio-werkkamer2 kernel: PCI: not using MMCONFIG Jun 23 10:03:02 volumio-werkkamer2 kernel: PCI: Using configuration type 1 for base access Jun 23 10:03:02 volumio-werkkamer2 kernel: ENERGY_PERF_BIAS: Set to 'normal', was 'performance' Jun 23 10:03:02 volumio-werkkamer2 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jun 23 10:03:02 volumio-werkkamer2 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jun 23 10:03:02 volumio-werkkamer2 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Added _OSI(Module Device) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Added _OSI(Processor Device) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: 4 ACPI AML tables successfully acquired and loaded Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Dynamic OEM Table Load: Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: SSDT 0xFFFF888001959000 000440 (v01 PmRef Cpu0Ist 00003000 INTL 20061109) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Dynamic OEM Table Load: Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: SSDT 0xFFFF888001959800 000433 (v01 PmRef Cpu0Cst 00003001 INTL 20061109) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Dynamic OEM Table Load: Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: SSDT 0xFFFF888001816400 00015F (v01 PmRef ApIst 00003000 INTL 20061109) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Dynamic OEM Table Load: Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: SSDT 0xFFFF888001371180 00008D (v01 PmRef ApCst 00003000 INTL 20061109) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: _OSC evaluated successfully for all CPUs Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Interpreter enabled Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PM: (supports S0 S3 S4 S5) Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Using IOAPIC for interrupt routing Jun 23 10:03:02 volumio-werkkamer2 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Jun 23 10:03:02 volumio-werkkamer2 kernel: PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved as ACPI motherboard resource Jun 23 10:03:02 volumio-werkkamer2 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jun 23 10:03:02 volumio-werkkamer2 kernel: PCI: Using E820 reservations for host bridge windows Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: Enabled 9 GPEs in block 00 to 3F Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: \_SB_.USBC: New power resource Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: \_SB_.I2C4.CLK0: New power resource Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: \_SB_.I2C4.CLK1: New power resource Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: \_TZ_.FN00: New power resource Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jun 23 10:03:02 volumio-werkkamer2 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jun 23 10:03:02 volumio-werkkamer2 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug SHPCHotplug PME] Jun 23 10:03:02 volumio-werkkamer2 kernel: acpi PNP0A08:00: _OSC: OS now controls [AER PCIeCapability LTR] Jun 23 10:03:02 volumio-werkkamer2 kernel: acpi PNP0A08:00: FADT indicates ASPM is unsupported, using BIOS configuration Jun 23 10:03:02 volumio-werkkamer2 kernel: PCI host bridge to bus 0000:00 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: root bus resource [io 0x0070-0x0077] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x006f window] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: root bus resource [io 0x0078-0x0cf7 window] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000fffff window] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xc8715fff window] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:00.0: [8086:0f00] type 00 class 0x060000 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:02.0: [8086:0f31] type 00 class 0x030000 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xc8000000-0xc83fffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xc0000000-0xc7ffffff pref] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:02.0: reg 0x20: [io 0xf080-0xf087] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:02.0: BAR 2: assigned to efifb Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:13.0: [8086:0f23] type 00 class 0x010601 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:13.0: reg 0x10: [io 0xf070-0xf077] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:13.0: reg 0x14: [io 0xf060-0xf063] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:13.0: reg 0x18: [io 0xf050-0xf057] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:13.0: reg 0x1c: [io 0xf040-0xf043] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:13.0: reg 0x20: [io 0xf020-0xf03f] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:13.0: reg 0x24: [mem 0xc8715000-0xc87157ff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:13.0: PME# supported from D3hot Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:14.0: [8086:0f35] type 00 class 0x0c0330 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:14.0: reg 0x10: [mem 0xc8700000-0xc870ffff 64bit] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:14.0: PME# supported from D3hot D3cold Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1a.0: [8086:0f18] type 00 class 0x108000 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1a.0: reg 0x10: [mem 0xc8500000-0xc85fffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1a.0: reg 0x14: [mem 0xc8400000-0xc84fffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1a.0: PME# supported from D0 D3hot Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1b.0: [8086:0f04] type 00 class 0x040300 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1b.0: reg 0x10: [mem 0xc8710000-0xc8713fff 64bit] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1c.0: [8086:0f48] type 01 class 0x060400 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1f.0: [8086:0f1c] type 00 class 0x060100 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1f.3: [8086:0f12] type 00 class 0x0c0500 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1f.3: reg 0x10: [mem 0xc8714000-0xc871401f] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1f.3: reg 0x20: [io 0xf000-0xf01f] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:01:00.0: [10ec:8168] type 00 class 0x020000 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:01:00.0: reg 0x10: [io 0xe000-0xe0ff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:01:00.0: reg 0x18: [mem 0xc8604000-0xc8604fff 64bit] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:01:00.0: reg 0x20: [mem 0xc8600000-0xc8603fff 64bit pref] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:01:00.0: supports D1 D2 Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:01:00.0: PME# supported from D0 D1 D2 D3hot D3cold Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1c.0: PCI bridge to [bus 01] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1c.0: bridge window [io 0xe000-0xefff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1c.0: bridge window [mem 0xc8600000-0xc86fffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: on NUMA node 0 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 11 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 0 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI: Interrupt link LNKB disabled Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 4 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 10 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 5 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 0 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI: Interrupt link LNKF disabled Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 3 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 0 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: PCI: Interrupt link LNKH disabled Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: \_SB_.LPEA.PLPE: New power resource Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: \_SB_.LPA2.PLPE: New power resource Jun 23 10:03:02 volumio-werkkamer2 kernel: iommu: Default domain type: Translated Jun 23 10:03:02 volumio-werkkamer2 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jun 23 10:03:02 volumio-werkkamer2 kernel: SCSI subsystem initialized Jun 23 10:03:02 volumio-werkkamer2 kernel: libata version 3.00 loaded. Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: bus type USB registered Jun 23 10:03:02 volumio-werkkamer2 kernel: usbcore: registered new interface driver usbfs Jun 23 10:03:02 volumio-werkkamer2 kernel: usbcore: registered new interface driver hub Jun 23 10:03:02 volumio-werkkamer2 kernel: usbcore: registered new device driver usb Jun 23 10:03:02 volumio-werkkamer2 kernel: efivars: Registered efivars operations Jun 23 10:03:02 volumio-werkkamer2 kernel: PCI: Using ACPI for IRQ routing Jun 23 10:03:02 volumio-werkkamer2 kernel: PCI: pci_cache_line_size set to 64 bytes Jun 23 10:03:02 volumio-werkkamer2 kernel: e820: reserve RAM buffer [mem 0x0008f000-0x0008ffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: e820: reserve RAM buffer [mem 0x1f000000-0x1fffffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: e820: reserve RAM buffer [mem 0x6d926000-0x6fffffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: e820: reserve RAM buffer [mem 0x79144000-0x7bffffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: e820: reserve RAM buffer [mem 0x79bd7000-0x7bffffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: e820: reserve RAM buffer [mem 0x79d88000-0x7bffffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: e820: reserve RAM buffer [mem 0x7a000000-0x7bffffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jun 23 10:03:02 volumio-werkkamer2 kernel: vgaarb: loaded Jun 23 10:03:02 volumio-werkkamer2 kernel: clocksource: Switched to clocksource tsc-early Jun 23 10:03:02 volumio-werkkamer2 kernel: VFS: Disk quotas dquot_6.6.0 Jun 23 10:03:02 volumio-werkkamer2 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jun 23 10:03:02 volumio-werkkamer2 kernel: pnp: PnP ACPI init Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:01: [io 0x0680-0x069f] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:01: [io 0x0400-0x047f] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:01: [io 0x0500-0x05fe] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:01: [io 0x0600-0x061f] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:02: [mem 0xe0000000-0xefffffff] could not be reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:02: [mem 0xfed01000-0xfed01fff] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:02: [mem 0xfed03000-0xfed03fff] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:02: [mem 0xfed04000-0xfed04fff] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:02: [mem 0xfed0c000-0xfed0ffff] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:02: [mem 0xfed08000-0xfed08fff] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:02: [mem 0xfed1c000-0xfed1cfff] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:02: [mem 0xfee00000-0xfeefffff] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: system 00:02: [mem 0xfef00000-0xfeffffff] has been reserved Jun 23 10:03:02 volumio-werkkamer2 kernel: pnp: PnP ACPI: found 3 devices Jun 23 10:03:02 volumio-werkkamer2 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jun 23 10:03:02 volumio-werkkamer2 kernel: NET: Registered PF_INET protocol family Jun 23 10:03:02 volumio-werkkamer2 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: TCP: Hash tables configured (established 16384 bind 16384) Jun 23 10:03:02 volumio-werkkamer2 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Jun 23 10:03:02 volumio-werkkamer2 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1c.0: PCI bridge to [bus 01] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1c.0: bridge window [io 0xe000-0xefff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci 0000:00:1c.0: bridge window [mem 0xc8600000-0xc86fffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: resource 4 [io 0x0070-0x0077] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0x006f window] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: resource 6 [io 0x0078-0x0cf7 window] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: resource 7 [io 0x0d00-0xffff window] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: resource 8 [mem 0x000a0000-0x000fffff window] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:00: resource 9 [mem 0x80000000-0xc8715fff window] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:01: resource 0 [io 0xe000-0xefff] Jun 23 10:03:02 volumio-werkkamer2 kernel: pci_bus 0000:01: resource 1 [mem 0xc8600000-0xc86fffff] Jun 23 10:03:02 volumio-werkkamer2 kernel: PCI: CLS 64 bytes, default 64 Jun 23 10:03:02 volumio-werkkamer2 kernel: Trying to unpack rootfs image as initramfs... Jun 23 10:03:02 volumio-werkkamer2 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x35d0576519e, max_idle_ns: 881590626659 ns Jun 23 10:03:02 volumio-werkkamer2 kernel: clocksource: Switched to clocksource tsc Jun 23 10:03:02 volumio-werkkamer2 kernel: Initialise system trusted keyrings Jun 23 10:03:02 volumio-werkkamer2 kernel: workingset: timestamp_bits=46 max_order=19 bucket_order=0 Jun 23 10:03:02 volumio-werkkamer2 kernel: zbud: loaded Jun 23 10:03:02 volumio-werkkamer2 kernel: Key type asymmetric registered Jun 23 10:03:02 volumio-werkkamer2 kernel: Asymmetric key parser 'x509' registered Jun 23 10:03:02 volumio-werkkamer2 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) Jun 23 10:03:02 volumio-werkkamer2 kernel: io scheduler mq-deadline registered Jun 23 10:03:02 volumio-werkkamer2 kernel: io scheduler kyber registered Jun 23 10:03:02 volumio-werkkamer2 kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Jun 23 10:03:02 volumio-werkkamer2 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: button: Power Button [PWRB] Jun 23 10:03:02 volumio-werkkamer2 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: button: Sleep Button [SLPB] Jun 23 10:03:02 volumio-werkkamer2 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: button: Power Button [PWRF] Jun 23 10:03:02 volumio-werkkamer2 kernel: thermal LNXTHERM:00: registered as thermal_zone0 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: thermal: Thermal Zone [TZ01] (27 C) Jun 23 10:03:02 volumio-werkkamer2 kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Jun 23 10:03:02 volumio-werkkamer2 kernel: hpet: number irqs doesn't agree with number of timers Jun 23 10:03:02 volumio-werkkamer2 kernel: Linux agpgart interface v0.103 Jun 23 10:03:02 volumio-werkkamer2 kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller Jun 23 10:03:02 volumio-werkkamer2 kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1 Jun 23 10:03:02 volumio-werkkamer2 kernel: xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x0000000000009810 Jun 23 10:03:02 volumio-werkkamer2 kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller Jun 23 10:03:02 volumio-werkkamer2 kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2 Jun 23 10:03:02 volumio-werkkamer2 kernel: xhci_hcd 0000:00:14.0: Host supports USB 3.0 SuperSpeed Jun 23 10:03:02 volumio-werkkamer2 kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Jun 23 10:03:02 volumio-werkkamer2 kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jun 23 10:03:02 volumio-werkkamer2 kernel: usb usb1: Product: xHCI Host Controller Jun 23 10:03:02 volumio-werkkamer2 kernel: usb usb1: Manufacturer: Linux 6.6.32-volumio xhci-hcd Jun 23 10:03:02 volumio-werkkamer2 kernel: usb usb1: SerialNumber: 0000:00:14.0 Jun 23 10:03:02 volumio-werkkamer2 kernel: hub 1-0:1.0: USB hub found Jun 23 10:03:02 volumio-werkkamer2 kernel: hub 1-0:1.0: 6 ports detected Jun 23 10:03:02 volumio-werkkamer2 kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Jun 23 10:03:02 volumio-werkkamer2 kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jun 23 10:03:02 volumio-werkkamer2 kernel: usb usb2: Product: xHCI Host Controller Jun 23 10:03:02 volumio-werkkamer2 kernel: usb usb2: Manufacturer: Linux 6.6.32-volumio xhci-hcd Jun 23 10:03:02 volumio-werkkamer2 kernel: usb usb2: SerialNumber: 0000:00:14.0 Jun 23 10:03:02 volumio-werkkamer2 kernel: hub 2-0:1.0: USB hub found Jun 23 10:03:02 volumio-werkkamer2 kernel: hub 2-0:1.0: 1 port detected Jun 23 10:03:02 volumio-werkkamer2 kernel: i8042: PNP: No PS/2 controller found. Jun 23 10:03:02 volumio-werkkamer2 kernel: mousedev: PS/2 mouse device common for all mice Jun 23 10:03:02 volumio-werkkamer2 kernel: rtc_cmos 00:00: RTC can wake from S4 Jun 23 10:03:02 volumio-werkkamer2 kernel: rtc_cmos 00:00: registered as rtc0 Jun 23 10:03:02 volumio-werkkamer2 kernel: rtc_cmos 00:00: setting system clock to 2025-06-23T10:02:52 UTC (1750672972) Jun 23 10:03:02 volumio-werkkamer2 kernel: rtc_cmos 00:00: alarms up to one month, y3k, 242 bytes nvram Jun 23 10:03:02 volumio-werkkamer2 kernel: i2c_dev: i2c /dev entries driver Jun 23 10:03:02 volumio-werkkamer2 kernel: platform eisa.0: Probing EISA bus 0 Jun 23 10:03:02 volumio-werkkamer2 kernel: platform eisa.0: EISA: Cannot allocate resource for mainboard Jun 23 10:03:02 volumio-werkkamer2 kernel: intel_pstate: Intel P-state driver initializing Jun 23 10:03:02 volumio-werkkamer2 kernel: ledtrig-cpu: registered to indicate activity on CPUs Jun 23 10:03:02 volumio-werkkamer2 kernel: efifb: probing for efifb Jun 23 10:03:02 volumio-werkkamer2 kernel: efifb: framebuffer at 0xc0000000, using 5120k, total 5120k Jun 23 10:03:02 volumio-werkkamer2 kernel: efifb: mode is 1280x1024x32, linelength=5120, pages=1 Jun 23 10:03:02 volumio-werkkamer2 kernel: efifb: scrolling: redraw Jun 23 10:03:02 volumio-werkkamer2 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jun 23 10:03:02 volumio-werkkamer2 kernel: Console: switching to colour frame buffer device 160x64 Jun 23 10:03:02 volumio-werkkamer2 kernel: fb0: EFI VGA frame buffer device Jun 23 10:03:02 volumio-werkkamer2 kernel: NET: Registered PF_INET6 protocol family Jun 23 10:03:02 volumio-werkkamer2 kernel: Segment Routing with IPv6 Jun 23 10:03:02 volumio-werkkamer2 kernel: In-situ OAM (IOAM) with IPv6 Jun 23 10:03:02 volumio-werkkamer2 kernel: mip6: Mobile IPv6 Jun 23 10:03:02 volumio-werkkamer2 kernel: NET: Registered PF_PACKET protocol family Jun 23 10:03:02 volumio-werkkamer2 kernel: mpls_gso: MPLS GSO support Jun 23 10:03:02 volumio-werkkamer2 kernel: microcode: Microcode Update Driver: v2.2. Jun 23 10:03:02 volumio-werkkamer2 kernel: IPI shorthand broadcast: enabled Jun 23 10:03:02 volumio-werkkamer2 kernel: sched_clock: Marking stable (304005872, 989910)->(353630794, -48635012) Jun 23 10:03:02 volumio-werkkamer2 kernel: Loading compiled-in X.509 certificates Jun 23 10:03:02 volumio-werkkamer2 kernel: clk: Disabling unused clocks Jun 23 10:03:02 volumio-werkkamer2 kernel: usb 1-3: new high-speed USB device number 2 using xhci_hcd Jun 23 10:03:02 volumio-werkkamer2 kernel: usb 1-3: New USB device found, idVendor=05e3, idProduct=0608, bcdDevice=85.37 Jun 23 10:03:02 volumio-werkkamer2 kernel: usb 1-3: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Jun 23 10:03:02 volumio-werkkamer2 kernel: usb 1-3: Product: USB2.0 Hub Jun 23 10:03:02 volumio-werkkamer2 kernel: hub 1-3:1.0: USB hub found Jun 23 10:03:02 volumio-werkkamer2 kernel: hub 1-3:1.0: 4 ports detected Jun 23 10:03:02 volumio-werkkamer2 kernel: Freeing initrd memory: 68112K Jun 23 10:03:02 volumio-werkkamer2 kernel: Freeing unused kernel image (initmem) memory: 2988K Jun 23 10:03:02 volumio-werkkamer2 kernel: Write protecting the kernel read-only data: 20480k Jun 23 10:03:02 volumio-werkkamer2 kernel: Freeing unused kernel image (rodata/data gap) memory: 1504K Jun 23 10:03:02 volumio-werkkamer2 kernel: Run /init as init process Jun 23 10:03:02 volumio-werkkamer2 kernel: with arguments: Jun 23 10:03:02 volumio-werkkamer2 kernel: /init Jun 23 10:03:02 volumio-werkkamer2 kernel: splash Jun 23 10:03:02 volumio-werkkamer2 kernel: with environment: Jun 23 10:03:02 volumio-werkkamer2 kernel: HOME=/ Jun 23 10:03:02 volumio-werkkamer2 kernel: TERM=linux Jun 23 10:03:02 volumio-werkkamer2 kernel: BOOT_IMAGE=/vmlinuz Jun 23 10:03:02 volumio-werkkamer2 kernel: biosdevname=0 Jun 23 10:03:02 volumio-werkkamer2 kernel: imgpart=UUID=92947385-dd02-4870-acbc-cdf34605d219 Jun 23 10:03:02 volumio-werkkamer2 kernel: bootpart=UUID=3101-B321 Jun 23 10:03:02 volumio-werkkamer2 kernel: datapart=UUID=1bee0927-e695-46ea-ab3b-7bcb5a437135 Jun 23 10:03:02 volumio-werkkamer2 kernel: hwdevice=x86 Jun 23 10:03:02 volumio-werkkamer2 kernel: uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg Jun 23 10:03:02 volumio-werkkamer2 kernel: imgfile=/volumio_current.sqsh Jun 23 10:03:02 volumio-werkkamer2 kernel: use_kmsg=no Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: bus type drm_connector registered Jun 23 10:03:02 volumio-werkkamer2 kernel: ahci 0000:00:13.0: version 3.0 Jun 23 10:03:02 volumio-werkkamer2 kernel: ahci 0000:00:13.0: controller can't do DEVSLP, turning off Jun 23 10:03:02 volumio-werkkamer2 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jun 23 10:03:02 volumio-werkkamer2 kernel: ahci 0000:00:13.0: AHCI 0001.0300 32 slots 2 ports 3 Gbps 0x1 impl SATA mode Jun 23 10:03:02 volumio-werkkamer2 kernel: ahci 0000:00:13.0: flags: 64bit ncq pm led clo pio slum part deso Jun 23 10:03:02 volumio-werkkamer2 kernel: hid: raw HID events driver (C) Jiri Kosina Jun 23 10:03:02 volumio-werkkamer2 kernel: scsi host0: ahci Jun 23 10:03:02 volumio-werkkamer2 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Jun 23 10:03:02 volumio-werkkamer2 kernel: scsi host1: ahci Jun 23 10:03:02 volumio-werkkamer2 kernel: ata1: SATA max UDMA/133 abar m2048@0xc8715000 port 0xc8715100 irq 89 Jun 23 10:03:02 volumio-werkkamer2 kernel: ata2: DUMMY Jun 23 10:03:02 volumio-werkkamer2 kernel: i2c i2c-0: Successfully instantiated SPD at 0x50 Jun 23 10:03:02 volumio-werkkamer2 kernel: ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Jun 23 10:03:02 volumio-werkkamer2 kernel: ata1.00: ATA-10: SATA SSD, S9FM01.5, max UDMA/100 Jun 23 10:03:02 volumio-werkkamer2 kernel: ata1.00: 15649200 sectors, multi 16: LBA48 NCQ (depth 32), AA Jun 23 10:03:02 volumio-werkkamer2 kernel: ata1.00: configured for UDMA/100 Jun 23 10:03:02 volumio-werkkamer2 kernel: scsi 0:0:0:0: Direct-Access ATA SATA SSD 01.5 PQ: 0 ANSI: 5 Jun 23 10:03:02 volumio-werkkamer2 kernel: sd 0:0:0:0: [sda] 15649200 512-byte logical blocks: (8.01 GB/7.46 GiB) Jun 23 10:03:02 volumio-werkkamer2 kernel: sd 0:0:0:0: [sda] Write Protect is off Jun 23 10:03:02 volumio-werkkamer2 kernel: sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 Jun 23 10:03:02 volumio-werkkamer2 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jun 23 10:03:02 volumio-werkkamer2 kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 512 bytes Jun 23 10:03:02 volumio-werkkamer2 kernel: sda: sda1 sda2 sda3 Jun 23 10:03:02 volumio-werkkamer2 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Jun 23 10:03:02 volumio-werkkamer2 kernel: r8169 0000:01:00.0: can't disable ASPM; OS doesn't have ASPM control Jun 23 10:03:02 volumio-werkkamer2 kernel: r8169 0000:01:00.0 eth0: RTL8168g/8111g, 00:1f:d8:01:19:80, XID 4c0, IRQ 90 Jun 23 10:03:02 volumio-werkkamer2 kernel: r8169 0000:01:00.0 eth0: jumbo features [frames: 9194 bytes, tx checksumming: ko] Jun 23 10:03:02 volumio-werkkamer2 kernel: Console: switching to colour dummy device 80x25 Jun 23 10:03:02 volumio-werkkamer2 kernel: i915 0000:00:02.0: vgaarb: deactivate vga console Jun 23 10:03:02 volumio-werkkamer2 kernel: [drm] Initialized i915 1.6.0 20201103 for 0000:00:02.0 on minor 0 Jun 23 10:03:02 volumio-werkkamer2 kernel: ACPI: video: Video Device [GFX0] (multi-head: yes rom: no post: no) Jun 23 10:03:02 volumio-werkkamer2 kernel: input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input3 Jun 23 10:03:02 volumio-werkkamer2 kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes Jun 23 10:03:02 volumio-werkkamer2 kernel: i915 0000:00:02.0: vgaarb: VGA decodes changed: olddecodes=io+mem,decodes=io+mem:owns=io+mem Jun 23 10:03:02 volumio-werkkamer2 kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes Jun 23 10:03:02 volumio-werkkamer2 kernel: i915 0000:00:02.0: [drm] Cannot find any crtc or sizes Jun 23 10:03:02 volumio-werkkamer2 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jun 23 10:03:02 volumio-werkkamer2 kernel: sdhci: Secure Digital Host Controller Interface driver Jun 23 10:03:02 volumio-werkkamer2 kernel: sdhci: Copyright(c) Pierre Ossman Jun 23 10:03:02 volumio-werkkamer2 kernel: usbcore: registered new interface driver usbhid Jun 23 10:03:02 volumio-werkkamer2 kernel: usbhid: USB HID core driver Jun 23 10:03:02 volumio-werkkamer2 kernel: fuse: init (API version 7.39) Jun 23 10:03:02 volumio-werkkamer2 kernel: usbcore: registered new interface driver usb-storage Jun 23 10:03:02 volumio-werkkamer2 kernel: usbcore: registered new interface driver uas Jun 23 10:03:02 volumio-werkkamer2 kernel: [drm] radeon kernel modesetting enabled. Jun 23 10:03:02 volumio-werkkamer2 kernel: scsi host2: pata_legacy Jun 23 10:03:02 volumio-werkkamer2 kernel: ata3: PATA max PIO4 cmd 0x1f0 ctl 0x3f6 irq 14 Jun 23 10:03:02 volumio-werkkamer2 kernel: scsi host2: pata_legacy Jun 23 10:03:02 volumio-werkkamer2 kernel: ata4: PATA max PIO4 cmd 0x170 ctl 0x376 irq 15 Jun 23 10:03:02 volumio-werkkamer2 kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jun 23 10:03:02 volumio-werkkamer2 kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jun 23 10:03:02 volumio-werkkamer2 kernel: EXT4-fs (sda2): recovery complete Jun 23 10:03:02 volumio-werkkamer2 kernel: EXT4-fs (sda2): mounted filesystem 92947385-dd02-4870-acbc-cdf34605d219 r/w with ordered data mode. Quota mode: none. Jun 23 10:03:02 volumio-werkkamer2 kernel: loop: module loaded Jun 23 10:03:02 volumio-werkkamer2 kernel: block device autoloading is deprecated and will be removed. Jun 23 10:03:02 volumio-werkkamer2 kernel: loop0: detected capacity change from 0 to 1726400 Jun 23 10:03:02 volumio-werkkamer2 kernel: EXT4-fs (sda3): 2 orphan inodes deleted Jun 23 10:03:02 volumio-werkkamer2 kernel: EXT4-fs (sda3): recovery complete Jun 23 10:03:02 volumio-werkkamer2 kernel: EXT4-fs (sda3): mounted filesystem 1bee0927-e695-46ea-ab3b-7bcb5a437135 r/w with ordered data mode. Quota mode: none. Jun 23 10:03:02 volumio-werkkamer2 kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038-01-19 (0x7fffffff) Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Inserted module 'autofs4' Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Detected architecture x86-64. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Set hostname to . Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: File /lib/systemd/system/systemd-journald.service:12 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Created slice system-systemd\x2dfsck.slice. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Reached target System Time Synchronized. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Listening on udev Control Socket. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Created slice User and Session Slice. Jun 23 10:03:02 volumio-werkkamer2 kernel: RPC: Registered named UNIX socket transport module. Jun 23 10:03:02 volumio-werkkamer2 kernel: RPC: Registered udp transport module. Jun 23 10:03:02 volumio-werkkamer2 kernel: RPC: Registered tcp transport module. Jun 23 10:03:02 volumio-werkkamer2 kernel: RPC: Registered tcp-with-tls transport module. Jun 23 10:03:02 volumio-werkkamer2 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jun 23 10:03:02 volumio-werkkamer2 systemd-journald[449]: Journal started Jun 23 10:03:02 volumio-werkkamer2 systemd-journald[449]: Runtime journal (/run/log/journal/add847249a309e16664fa1706336b2ef) is 3.7M, max 30.0M, 26.2M free. Jun 23 10:03:02 volumio-werkkamer2 fake-hwclock[442]: Current system time: 2025-06-23 10:03:02 Jun 23 10:03:02 volumio-werkkamer2 fake-hwclock[442]: fake-hwclock saved clock information is in the past: 2025-04-09 11:34:24 Jun 23 10:03:02 volumio-werkkamer2 fake-hwclock[442]: To set system time to this saved clock anyway, use "force" Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Mounted Kernel Configuration File System. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Started Apply Kernel Variables. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: dynamicswap.service: Succeeded. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Started Create System Users. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Starting Create Static Device Nodes in /dev... Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Started Create Static Device Nodes in /dev. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Starting udev Kernel Device Manager... Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Reached target Local File Systems (Pre). Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Mounting /var/log... Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Mounting /tmp... Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Mounting /var/spool/cups... Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Mounted /var/log. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Mounted /tmp. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Mounted /var/spool/cups. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Mounting /var/spool/cups/tmp... Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Starting Flush Journal to Persistent Storage... Jun 23 10:03:02 volumio-werkkamer2 systemd-udevd[475]: Network interface NamePolicy= disabled on kernel command line, ignoring. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Mounted /var/spool/cups/tmp. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Started udev Coldplug all Devices. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Starting Helper to synchronize boot up for ifupdown... Jun 23 10:03:02 volumio-werkkamer2 systemd-journald[449]: Runtime journal (/run/log/journal/add847249a309e16664fa1706336b2ef) is 3.7M, max 30.0M, 26.2M free. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Started udev Kernel Device Manager. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Starting Show Plymouth Boot Screen... Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Started Flush Journal to Persistent Storage. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: plymouth-start.service: Succeeded. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Started Show Plymouth Boot Screen. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Reached target Local Encrypted Volumes. Jun 23 10:03:02 volumio-werkkamer2 systemd[1]: Reached target Paths. Jun 23 10:03:02 volumio-werkkamer2 kernel: cryptd: max_cpu_qlen set to 1000 Jun 23 10:03:02 volumio-werkkamer2 kernel: mei_txe 0000:00:1a.0: can't derive routing for PCI INT A Jun 23 10:03:02 volumio-werkkamer2 kernel: mei_txe 0000:00:1a.0: PCI INT A: not connected Jun 23 10:03:02 volumio-werkkamer2 kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Jun 23 10:03:02 volumio-werkkamer2 systemd-udevd[485]: Using default interface naming scheme 'v240'. Jun 23 10:03:02 volumio-werkkamer2 systemd-udevd[485]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jun 23 10:03:02 volumio-werkkamer2 kernel: at24 0-0050: supply vcc not found, using dummy regulator Jun 23 10:03:02 volumio-werkkamer2 kernel: at24 0-0050: 256 byte spd EEPROM, read-only Jun 23 10:03:02 volumio-werkkamer2 kernel: pstore: Using crash dump compression: deflate Jun 23 10:03:02 volumio-werkkamer2 kernel: pstore: Registered efi_pstore as persistent store backend Jun 23 10:03:03 volumio-werkkamer2 systemd-udevd[490]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 23 10:03:03 volumio-werkkamer2 systemd-udevd[488]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 23 10:03:03 volumio-werkkamer2 kernel: snd_hda_intel 0000:00:1b.0: bound 0000:00:02.0 (ops __SCT__tp_func_intel_frontbuffer_flush [i915]) Jun 23 10:03:03 volumio-werkkamer2 systemd-udevd[500]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 23 10:03:03 volumio-werkkamer2 systemd-udevd[487]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 23 10:03:03 volumio-werkkamer2 systemd-udevd[487]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jun 23 10:03:03 volumio-werkkamer2 kernel: snd_hda_codec_via hdaudioC0D0: autoconfig for VT1802: line_outs=1 (0x24/0x0/0x0/0x0/0x0) type:speaker Jun 23 10:03:03 volumio-werkkamer2 kernel: snd_hda_codec_via hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Jun 23 10:03:03 volumio-werkkamer2 kernel: snd_hda_codec_via hdaudioC0D0: hp_outs=1 (0x25/0x0/0x0/0x0/0x0) Jun 23 10:03:03 volumio-werkkamer2 kernel: snd_hda_codec_via hdaudioC0D0: mono: mono_out=0x0 Jun 23 10:03:03 volumio-werkkamer2 kernel: snd_hda_codec_via hdaudioC0D0: inputs: Jun 23 10:03:03 volumio-werkkamer2 kernel: snd_hda_codec_via hdaudioC0D0: Mic=0x2b Jun 23 10:03:03 volumio-werkkamer2 kernel: snd_hda_codec_via hdaudioC0D0: Internal Mic=0x29 Jun 23 10:03:03 volumio-werkkamer2 kernel: input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input4 Jun 23 10:03:03 volumio-werkkamer2 kernel: input: HDA Intel PCH Front Headphone as /devices/pci0000:00/0000:00:1b.0/sound/card0/input5 Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Found device SATA_SSD boot. Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: Core ver 2.22 Jun 23 10:03:03 volumio-werkkamer2 kernel: NET: Registered PF_BLUETOOTH protocol family Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI device and connection manager initialized Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI socket layer initialized Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: L2CAP socket layer initialized Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: SCO socket layer initialized Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI UART driver ver 2.3 Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI UART protocol H4 registered Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI UART protocol BCSP registered Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI UART protocol LL registered Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI UART protocol ATH3K registered Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI UART protocol Intel registered Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI UART protocol Broadcom registered Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI UART protocol QCA registered Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI UART protocol AG6XX registered Jun 23 10:03:03 volumio-werkkamer2 kernel: Bluetooth: HCI UART protocol Marvell registered Jun 23 10:03:03 volumio-werkkamer2 systemd-udevd[493]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 23 10:03:03 volumio-werkkamer2 systemd-udevd[495]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 23 10:03:03 volumio-werkkamer2 kernel: alsactl[578]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Started Helper to synchronize boot up for ifupdown. Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Condition check resulted in RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller being skipped. Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Starting Show Plymouth Boot Screen... Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Starting File System Check on /dev/disk/by-uuid/3101-B321... Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: plymouth-start.service: Succeeded. Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Started Show Plymouth Boot Screen. Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Started File System Check Daemon to report status. Jun 23 10:03:03 volumio-werkkamer2 systemd-fsck[585]: fsck.fat 4.1 (2017-01-24) Jun 23 10:03:03 volumio-werkkamer2 systemd-fsck[585]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Jun 23 10:03:03 volumio-werkkamer2 systemd-fsck[585]: Automatically removing dirty bit. Jun 23 10:03:03 volumio-werkkamer2 systemd-fsck[585]: Performing changes. Jun 23 10:03:03 volumio-werkkamer2 systemd-fsck[585]: /dev/sda1: 21 files, 19974/43727 clusters Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Started File System Check on /dev/disk/by-uuid/3101-B321. Jun 23 10:03:03 volumio-werkkamer2 systemd[1]: Mounting /boot... Jun 23 10:03:03 volumio-werkkamer2 kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Mounted /boot. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Reached target Local File Systems. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started ifup for eth0. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting Preprocess NFS configuration... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting Raise network interfaces... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting Create Volatile Files and Directories... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Received SIGRTMIN+20 from PID 337 (plymouthd). Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: nfs-config.service: Succeeded. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Preprocess NFS configuration. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: plymouth-read-write.service: Succeeded. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Reached target NFS client services. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Create Volatile Files and Directories. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Jun 23 10:03:04 volumio-werkkamer2 kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting RPC bind portmap service... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Update UTMP about System Boot/Shutdown. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Reached target System Initialization. Jun 23 10:03:04 volumio-werkkamer2 kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Jun 23 10:03:04 volumio-werkkamer2 kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Listening on D-Bus System Message Bus Socket. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Daily Cleanup of Temporary Directories. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Daily man-db regeneration. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Daily apt download activities. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Listening on triggerhappy.socket. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Reached target Sockets. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Reached target Basic System. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Jun 23 10:03:04 volumio-werkkamer2 ifup[596]: command failed: No such device (-19) Jun 23 10:03:04 volumio-werkkamer2 sh[592]: command failed: No such device (-19) Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Volumio Iptables Module. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting Volumio Time Update Utility... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Volumio Log Rotation Service. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting triggerhappy global hotkey daemon... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started UPnP Renderer front-end to MPD. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Manage Sound Card State (restore and store). Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting Save/Restore Sound Card State... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting Wireless Services... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started volumio-remote-updater.service. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started MPD Monitor Service. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting DHCP Client Daemon... Jun 23 10:03:04 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Fetching time from Volumio... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started D-Bus System Message Bus. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting WPA supplicant... Jun 23 10:03:04 volumio-werkkamer2 alsactl[641]: alsactl 1.1.8 daemon started Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Daily apt upgrade and clean activities. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Reached target Timers. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting Login Service... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started RPC bind portmap service. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting Daily man-db regeneration... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Reached target RPC Port Mapper. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Reached target Remote File Systems (Pre). Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Reached target Remote File Systems. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Jun 23 10:03:04 volumio-werkkamer2 thd[639]: Unable to parse trigger line: Jun 23 10:03:04 volumio-werkkamer2 thd[639]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Jun 23 10:03:04 volumio-werkkamer2 thd[639]: Unable to parse trigger line: Jun 23 10:03:04 volumio-werkkamer2 thd[639]: Found socket passed from systemd Jun 23 10:03:04 volumio-werkkamer2 mpd_monitor.sh[650]: MPD Monitor Service: Starting MPD Monitor Service Jun 23 10:03:04 volumio-werkkamer2 systemd-logind[658]: New seat seat0. Jun 23 10:03:04 volumio-werkkamer2 systemd-logind[658]: Watching system buttons on /dev/input/event2 (Power Button) Jun 23 10:03:04 volumio-werkkamer2 systemd-logind[658]: Watching system buttons on /dev/input/event0 (Power Button) Jun 23 10:03:04 volumio-werkkamer2 systemd-logind[658]: Watching system buttons on /dev/input/event1 (Sleep Button) Jun 23 10:03:04 volumio-werkkamer2 mpd_monitor.sh[650]: MPD error: Connection refused Jun 23 10:03:04 volumio-werkkamer2 mpd_monitor.sh[650]: MPD Monitor Service: MPD Appears to be inactive, restarting Jun 23 10:03:04 volumio-werkkamer2 ifup[596]: command failed: No such device (-19) Jun 23 10:03:04 volumio-werkkamer2 kernel: 8021q: 802.1Q VLAN Support v1.8 Jun 23 10:03:04 volumio-werkkamer2 mpd_monitor.sh[650]: mpd: no process found Jun 23 10:03:04 volumio-werkkamer2 avahi-daemon[647]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Jun 23 10:03:04 volumio-werkkamer2 avahi-daemon[647]: Successfully dropped root privileges. Jun 23 10:03:04 volumio-werkkamer2 avahi-daemon[647]: avahi-daemon 0.7 starting up. Jun 23 10:03:04 volumio-werkkamer2 haveged[614]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K Jun 23 10:03:04 volumio-werkkamer2 haveged[614]: haveged: cpu: (L4 VC); data: 24K (L4 V); inst: 32K (L4 V); idx: 24/40; sz: 31410/52825 Jun 23 10:03:04 volumio-werkkamer2 haveged[614]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99995 Jun 23 10:03:04 volumio-werkkamer2 haveged[614]: haveged: fills: 0, generated: 0 Jun 23 10:03:04 volumio-werkkamer2 dhcpcd[651]: no interfaces have a carrier Jun 23 10:03:04 volumio-werkkamer2 dhcpcd[651]: forked to background, child pid 732 Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started triggerhappy global hotkey daemon. Jun 23 10:03:04 volumio-werkkamer2 dhcpcd[651]: no interfaces have a carrier Jun 23 10:03:04 volumio-werkkamer2 dhcpcd[651]: forked to background, child pid 732 Jun 23 10:03:04 volumio-werkkamer2 avahi-daemon[647]: Successfully called chroot(). Jun 23 10:03:04 volumio-werkkamer2 avahi-daemon[647]: Successfully dropped remaining capabilities. Jun 23 10:03:04 volumio-werkkamer2 wpa_supplicant[655]: Successfully initialized wpa_supplicant Jun 23 10:03:04 volumio-werkkamer2 avahi-daemon[647]: Loading service file /services/volumio.service. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Save/Restore Sound Card State. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started DHCP Client Daemon. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: iptables.service: Succeeded. Jun 23 10:03:04 volumio-werkkamer2 kernel: Generic FE-GE Realtek PHY r8169-0-100:00: attached PHY driver (mii_bus:phy_addr=r8169-0-100:00, irq=MAC) Jun 23 10:03:04 volumio-werkkamer2 volumio-remote-updater[649]: Error: No active session Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Login Service. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Started WPA supplicant. Jun 23 10:03:04 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Date not found in response Jun 23 10:03:04 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Retrying in 5 seconds... Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Listening on mpd.socket. Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: Reached target Sound Card. Jun 23 10:03:04 volumio-werkkamer2 volumio[640]: Could not open config: /tmp/upmpdcli.conf Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jun 23 10:03:04 volumio-werkkamer2 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jun 23 10:03:04 volumio-werkkamer2 ifup[596]: command failed: No such device (-19) Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: man-db.service: Succeeded. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started Daily man-db regeneration. Jun 23 10:03:05 volumio-werkkamer2 sh[592]: eth0: waiting for carrier Jun 23 10:03:05 volumio-werkkamer2 sh[592]: eth0: carrier acquired Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[732]: eth0: waiting for carrier Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[646]: eth0: waiting for carrier Jun 23 10:03:05 volumio-werkkamer2 volumio-remote-updater[649]: [2025-06-23 10:03:05] [info] asio async_connect error: system:111 (Connection refused) Jun 23 10:03:05 volumio-werkkamer2 volumio-remote-updater[649]: [2025-06-23 10:03:05] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[732]: eth0: carrier acquired Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[646]: eth0: carrier acquired Jun 23 10:03:05 volumio-werkkamer2 kernel: r8169 0000:01:00.0 eth0: Link is Down Jun 23 10:03:05 volumio-werkkamer2 avahi-daemon[647]: Network interface enumeration completed. Jun 23 10:03:05 volumio-werkkamer2 avahi-daemon[647]: Server startup complete. Host name is volumio-werkkamer2.local. Local service cookie is 1063750420. Jun 23 10:03:05 volumio-werkkamer2 avahi-daemon[647]: Service "Volumio-werkkamer2" (/services/volumio.service) successfully established. Jun 23 10:03:05 volumio-werkkamer2 sh[592]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09 Jun 23 10:03:05 volumio-werkkamer2 sh[592]: eth0: IAID d8:01:19:80 Jun 23 10:03:05 volumio-werkkamer2 sh[592]: eth0: adding address fe80::21f:d8ff:fe01:1980 Jun 23 10:03:05 volumio-werkkamer2 sh[592]: ipv6_addaddr1: Permission denied Jun 23 10:03:05 volumio-werkkamer2 sh[592]: eth0: carrier lost Jun 23 10:03:05 volumio-werkkamer2 volumio-remote-updater[649]: [2025-06-23 10:03:05] [error] handle_connect error: Underlying Transport Error Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[646]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09 Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[646]: eth0: IAID d8:01:19:80 Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[646]: eth0: adding address fe80::21f:d8ff:fe01:1980 Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[646]: ipv6_addaddr1: Permission denied Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[646]: eth0: carrier lost Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[732]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09 Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[732]: eth0: IAID d8:01:19:80 Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[732]: eth0: adding address fe80::21f:d8ff:fe01:1980 Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[732]: ipv6_addaddr1: Permission denied Jun 23 10:03:05 volumio-werkkamer2 dhcpcd[732]: eth0: carrier lost Jun 23 10:03:05 volumio-werkkamer2 loadcpufreq[661]: Loading cpufreq kernel modules...done (acpi-cpufreq). Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Starting LSB: set CPUFreq kernel parameters... Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started Raise network interfaces. Jun 23 10:03:05 volumio-werkkamer2 cpufrequtils[826]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Reached target Network. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Starting Network Time Service... Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Starting Permit User Sessions... Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Starting Music Player Daemon... Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Starting OpenBSD Secure Shell server... Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Reached target Network is Online. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Starting Samba NMB Daemon... Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Starting Daily apt download activities... Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Starting LSB: Brings up/down network automatically... Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Starting /etc/rc.local Compatibility... Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started LSB: set CPUFreq kernel parameters. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started Permit User Sessions. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started /etc/rc.local Compatibility. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Starting Hold until boot process finishes up... Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Starting Terminate Plymouth Boot Screen... Jun 23 10:03:05 volumio-werkkamer2 ntpd[873]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 23 10:03:05 volumio-werkkamer2 ntpd[873]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jun 23 10:03:05 volumio-werkkamer2 ntpd[894]: proto: precision = 0.202 usec (-22) Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started Network Time Service. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: plymouth-quit-wait.service: Succeeded. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started Hold until boot process finishes up. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: plymouth-quit.service: Succeeded. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started Terminate Plymouth Boot Screen. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Received SIGRTMIN+21 from PID 337 (n/a). Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Received SIGRTMIN+21 from PID 337 (n/a). Jun 23 10:03:05 volumio-werkkamer2 ntpd[894]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 23 10:03:05 volumio-werkkamer2 ntpd[894]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 23 10:03:05 volumio-werkkamer2 ntpd[894]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 909 days ago Jun 23 10:03:05 volumio-werkkamer2 ntpd[894]: Listen and drop on 0 v6wildcard [::]:123 Jun 23 10:03:05 volumio-werkkamer2 ntpd[894]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 23 10:03:05 volumio-werkkamer2 ntpd[894]: Listen normally on 2 lo 127.0.0.1:123 Jun 23 10:03:05 volumio-werkkamer2 ntpd[894]: Listening on routing socket on fd #19 for interface updates Jun 23 10:03:05 volumio-werkkamer2 ntpd[894]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 23 10:03:05 volumio-werkkamer2 ntpd[894]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 23 10:03:05 volumio-werkkamer2 ifplugd(eth0)[905]: ifplugd 0.28 initializing. Jun 23 10:03:05 volumio-werkkamer2 ifplugd(eth0)[905]: Using interface eth0/00:1F:D8:01:19:80 with driver (version: 6.6.32-volumio) Jun 23 10:03:05 volumio-werkkamer2 ifplugd(eth0)[905]: Using detection mode: SIOCETHTOOL Jun 23 10:03:05 volumio-werkkamer2 ifplugd(eth0)[905]: Initialization complete, link beat not detected. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started Getty on tty1. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Reached target Login Prompts. Jun 23 10:03:05 volumio-werkkamer2 sshd[908]: Server listening on 0.0.0.0 port 22. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started OpenBSD Secure Shell server. Jun 23 10:03:05 volumio-werkkamer2 sshd[908]: Server listening on :: port 22. Jun 23 10:03:05 volumio-werkkamer2 sudo[876]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 23 10:03:05 volumio-werkkamer2 sudo[876]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:05 volumio-werkkamer2 sudo[876]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 23 10:03:05 volumio-werkkamer2 sudo[876]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:05 volumio-werkkamer2 ifplugd[885]: Network Interface Plugging Daemon...start eth0...done. Jun 23 10:03:05 volumio-werkkamer2 systemd[1]: Started LSB: Brings up/down network automatically. Jun 23 10:03:06 volumio-werkkamer2 wireless.js[648]: WIRELESS: No wireless interface, exiting Jun 23 10:03:06 volumio-werkkamer2 nmbd[888]: [2025/06/23 10:03:06.082995, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jun 23 10:03:06 volumio-werkkamer2 nmbd[888]: started asyncdns process 943 Jun 23 10:03:06 volumio-werkkamer2 nmbd[888]: [2025/06/23 10:03:06.086814, 0] ../lib/util/become_daemon.c:149(daemon_status) Jun 23 10:03:06 volumio-werkkamer2 nmbd[888]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jun 23 10:03:06 volumio-werkkamer2 nmbd[888]: [2025/06/23 10:03:06.086938, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jun 23 10:03:06 volumio-werkkamer2 nmbd[888]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jun 23 10:03:06 volumio-werkkamer2 iw[939]: command failed: No such device (-19) Jun 23 10:03:06 volumio-werkkamer2 iwconfig[946]: Error for wireless request "Set Power Management" (8B2C) : Jun 23 10:03:06 volumio-werkkamer2 iwconfig[946]: SET failed on device wlan0 ; No such device. Jun 23 10:03:06 volumio-werkkamer2 systemd[1]: wireless.service: Succeeded. Jun 23 10:03:06 volumio-werkkamer2 systemd[1]: Started Wireless Services. Jun 23 10:03:06 volumio-werkkamer2 systemd[1]: Started Volumio Backend Module. Jun 23 10:03:06 volumio-werkkamer2 systemd[1]: Started Start Volumio Kiosk. Jun 23 10:03:06 volumio-werkkamer2 systemd[1]: Started Intel SST and HDA soundcard init service. Jun 23 10:03:06 volumio-werkkamer2 systemd[1]: Started Volumio Cpu Tweaker. Jun 23 10:03:06 volumio-werkkamer2 volumio-cpu-tweak[960]: Setting RT Priority for mpd Jun 23 10:03:06 volumio-werkkamer2 volumio-cpu-tweak[960]: Setting MPD Affinity Jun 23 10:03:06 volumio-werkkamer2 volumio-cpu-tweak[960]: pid 910's current affinity mask: f Jun 23 10:03:06 volumio-werkkamer2 volumio-cpu-tweak[960]: pid 910's new affinity mask: 3 Jun 23 10:03:06 volumio-werkkamer2 volumio-cpu-tweak[960]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jun 23 10:03:06 volumio-werkkamer2 systemd[1]: volumio_cpu_tweak.service: Succeeded. Jun 23 10:03:06 volumio-werkkamer2 ntpd[894]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jun 23 10:03:06 volumio-werkkamer2 systemd[1]: apt-daily.service: Succeeded. Jun 23 10:03:06 volumio-werkkamer2 systemd[1]: Started Daily apt download activities. Jun 23 10:03:06 volumio-werkkamer2 systemd[1]: Starting Daily apt upgrade and clean activities... Jun 23 10:03:06 volumio-werkkamer2 startx[952]: X.Org X Server 1.20.4 Jun 23 10:03:06 volumio-werkkamer2 startx[952]: X Protocol Version 11, Revision 0 Jun 23 10:03:06 volumio-werkkamer2 startx[952]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Jun 23 10:03:06 volumio-werkkamer2 startx[952]: Current Operating System: Linux volumio-werkkamer2 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Jun 23 10:03:06 volumio-werkkamer2 startx[952]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=92947385-dd02-4870-acbc-cdf34605d219 bootpart=UUID=3101-B321 datapart=UUID=1bee0927-e695-46ea-ab3b-7bcb5a437135 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no Jun 23 10:03:06 volumio-werkkamer2 startx[952]: Build Date: 18 December 2021 09:05:36AM Jun 23 10:03:06 volumio-werkkamer2 startx[952]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Jun 23 10:03:06 volumio-werkkamer2 startx[952]: Current version of pixman: 0.36.0 Jun 23 10:03:06 volumio-werkkamer2 startx[952]: Before reporting problems, check http://wiki.x.org Jun 23 10:03:06 volumio-werkkamer2 startx[952]: to make sure that you have the latest version. Jun 23 10:03:06 volumio-werkkamer2 startx[952]: Markers: (--) probed, (**) from config file, (==) default setting, Jun 23 10:03:06 volumio-werkkamer2 startx[952]: (++) from command line, (!!) notice, (II) informational, Jun 23 10:03:06 volumio-werkkamer2 startx[952]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jun 23 10:03:06 volumio-werkkamer2 startx[952]: (==) Log file: "/var/log/Xorg.0.log", Time: Mon Jun 23 10:03:06 2025 Jun 23 10:03:06 volumio-werkkamer2 startx[952]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jun 23 10:03:07 volumio-werkkamer2 kernel: broken atomic modeset userspace detected, disabling atomic Jun 23 10:03:07 volumio-werkkamer2 systemd[1]: apt-daily-upgrade.service: Succeeded. Jun 23 10:03:07 volumio-werkkamer2 systemd[1]: Started Daily apt upgrade and clean activities. Jun 23 10:03:07 volumio-werkkamer2 startx[952]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Jun 23 10:03:07 volumio-werkkamer2 systemd[1]: soundcard-init.service: Succeeded. Jun 23 10:03:07 volumio-werkkamer2 ntpd[894]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jun 23 10:03:08 volumio-werkkamer2 mpd[910]: Jun 23 10:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 23 10:03:08 volumio-werkkamer2 systemd[1]: Started Music Player Daemon. Jun 23 10:03:08 volumio-werkkamer2 mpd_monitor.sh[650]: MPD Monitor Service: MPD restarted due to no mpc output. Jun 23 10:03:08 volumio-werkkamer2 ntpd[894]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jun 23 10:03:08 volumio-werkkamer2 volumio[951]: info: ------------------------------------------- Jun 23 10:03:08 volumio-werkkamer2 volumio[951]: info: ----- Volumio3 ---- Jun 23 10:03:08 volumio-werkkamer2 volumio[951]: info: ------------------------------------------- Jun 23 10:03:08 volumio-werkkamer2 volumio[951]: info: ----- System startup ---- Jun 23 10:03:08 volumio-werkkamer2 volumio[951]: info: ------------------------------------------- Jun 23 10:03:09 volumio-werkkamer2 ntpd[894]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jun 23 10:03:09 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Fetching time from Volumio... Jun 23 10:03:09 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Date not found in response Jun 23 10:03:09 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Retrying in 5 seconds... Jun 23 10:03:10 volumio-werkkamer2 volumio-remote-updater[649]: [2025-06-23 10:03:10] [connect] Successful connection Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: MYVOLUMIO Environment detected Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Plugin folders cleanup Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Scanning into folder /volumio/app/plugins/ Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Scanning category audio_interface Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Scanning category miscellanea Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Scanning category music_service Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Scanning category plugins.json Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Scanning category system_controller Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Scanning category user_interface Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Scanning into folder /data/plugins/ Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Scanning category music_service Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Plugin folders cleanup completed Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: ------------------------------------------- Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: ----- Core plugins startup ---- Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: ------------------------------------------- Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Loading plugins from folder /volumio/app/plugins/ Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Adding plugin upnp to MyMusic Plugins Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Loading plugins from folder /data/plugins/ Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Loading plugin "system"... Jun 23 10:03:10 volumio-werkkamer2 volumio[951]: info: Loading plugin "appearance"... Jun 23 10:03:11 volumio-werkkamer2 dbus-daemon[653]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.6' (uid=0 pid=1192 comm="/usr/lib/chromium/chromium --show-component-extens") Jun 23 10:03:11 volumio-werkkamer2 systemd[1]: Starting Bluetooth service... Jun 23 10:03:11 volumio-werkkamer2 bluetoothd[1245]: Bluetooth daemon 5.50 Jun 23 10:03:11 volumio-werkkamer2 bluetoothd[1245]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Jun 23 10:03:11 volumio-werkkamer2 dbus-daemon[653]: [system] Successfully activated service 'org.bluez' Jun 23 10:03:11 volumio-werkkamer2 systemd[1]: Started Bluetooth service. Jun 23 10:03:11 volumio-werkkamer2 bluetoothd[1245]: Starting SDP server Jun 23 10:03:11 volumio-werkkamer2 bluetoothd[1245]: Excluding (cli) sap Jun 23 10:03:11 volumio-werkkamer2 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Jun 23 10:03:11 volumio-werkkamer2 kernel: Bluetooth: BNEP filters: protocol multicast Jun 23 10:03:11 volumio-werkkamer2 kernel: Bluetooth: BNEP socket layer initialized Jun 23 10:03:11 volumio-werkkamer2 dbus-daemon[653]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.7' (uid=0 pid=1245 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Jun 23 10:03:11 volumio-werkkamer2 bluetoothd[1245]: Bluetooth management interface 1.22 initialized Jun 23 10:03:11 volumio-werkkamer2 systemd[1]: Starting Hostname Service... Jun 23 10:03:11 volumio-werkkamer2 volumio[951]: info: Loading plugin "network"... Jun 23 10:03:11 volumio-werkkamer2 volumio[951]: info: Refreshing Cached IP Addresses Jun 23 10:03:11 volumio-werkkamer2 sudo[1265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 23 10:03:11 volumio-werkkamer2 sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:11 volumio-werkkamer2 volumio[951]: info: Loading plugin "services"... Jun 23 10:03:11 volumio-werkkamer2 volumio[951]: info: Loading plugin "alsa_controller"... Jun 23 10:03:11 volumio-werkkamer2 sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 23 10:03:11 volumio-werkkamer2 sudo[1265]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:11 volumio-werkkamer2 sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:11 volumio-werkkamer2 dbus-daemon[653]: [system] Successfully activated service 'org.freedesktop.hostname1' Jun 23 10:03:11 volumio-werkkamer2 systemd[1]: Started Hostname Service. Jun 23 10:03:11 volumio-werkkamer2 sudo[1277]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: Loading plugin "wizard"... Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: Loading plugin "networkfs"... Jun 23 10:03:12 volumio-werkkamer2 sudo[1319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Klassiek /mnt/NAS/Media Jun 23 10:03:12 volumio-werkkamer2 sudo[1319]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:12 volumio-werkkamer2 sudo[1324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Jazz /mnt/NAS/Media-Jazz Jun 23 10:03:12 volumio-werkkamer2 sudo[1324]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: Starting Udev Watcher for removable devices Jun 23 10:03:12 volumio-werkkamer2 sudo[1336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Klassiek /mnt/NAS/Media-Klassiek Jun 23 10:03:12 volumio-werkkamer2 sudo[1336]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: Ignoring mount for partition: boot Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: Ignoring mount for partition: volumio Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: Ignoring mount for partition: volumio_data Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: Loading plugin "volumio_command_line_client"... Jun 23 10:03:12 volumio-werkkamer2 kernel: FS-Cache: Loaded Jun 23 10:03:12 volumio-werkkamer2 kernel: Key type dns_resolver registered Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: Loading plugin "upnp"... Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: [1750672992239] Starting Upmpd Daemon Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: Loading plugin "my_music"... Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: Loading plugin "mpd"... Jun 23 10:03:12 volumio-werkkamer2 kernel: Key type cifs.spnego registered Jun 23 10:03:12 volumio-werkkamer2 kernel: Key type cifs.idmap registered Jun 23 10:03:12 volumio-werkkamer2 kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Jun 23 10:03:12 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Jazz Jun 23 10:03:12 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:12 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:12 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Klassiek Jun 23 10:03:12 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:12 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:12 volumio-werkkamer2 sudo[1324]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:12 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Klassiek Jun 23 10:03:12 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:12 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:12 volumio-werkkamer2 sudo[1319]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:12 volumio-werkkamer2 sudo[1336]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:12 volumio-werkkamer2 volumio[951]: info: Loading plugin "upnp_browser"... Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: Loading plugin "alarm-clock"... Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: Loading plugin "airplay_emulation"... Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: Starting Shairport Sync Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: Loading plugin "last_100"... Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: Loading plugin "webradio"... Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: Loading plugin "i2s_dacs"... Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: I2S DAC not set, start Auto-detection Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: Loading plugin "volumiodiscovery"... Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 23 10:03:13 volumio-werkkamer2 node[951]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: *** WARNING *** For more information see Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: *** WARNING *** For more information see Jun 23 10:03:13 volumio-werkkamer2 node[951]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 23 10:03:13 volumio-werkkamer2 node[951]: *** WARNING *** For more information see Jun 23 10:03:13 volumio-werkkamer2 node[951]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 23 10:03:13 volumio-werkkamer2 node[951]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 23 10:03:13 volumio-werkkamer2 node[951]: *** WARNING *** For more information see Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: Discovery: Started advertising with name: Volumio-werkkamer2 Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 23 10:03:13 volumio-werkkamer2 volumio[951]: info: Loading plugin "spop"... Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: Loading plugin "outputs"... Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: Loading plugin "albumart"... Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: Plugin example_plugin is not enabled Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: Loading plugin "inputs"... Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: Loading plugin "updater_comm"... Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: Forking 3 albumart workers Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: Plugin mpdemulation is not enabled Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: Loading plugin "rest_api"... Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: Loading plugin "websocket"... Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: Starting Socket.io Server version 2.3.0 Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: Loading i18n strings for locale en Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: Updating browse sources language Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::initPlayerControls Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 10:03:14 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Fetching time from Volumio... Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: Express server listening on port 3000 Jun 23 10:03:14 volumio-werkkamer2 volumio[951]: [Metrics] WebUI: 7s 82.41ms Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Setting Device type: x86 Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreStateMachine::resetVolumioState Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreStateMachine::getcurrentVolume Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioRetrievevolume Jun 23 10:03:15 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Date not found in response Jun 23 10:03:15 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Retrying in 5 seconds... Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Completed loading Core Plugins Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Preparing to generate the ALSA configuration file Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Volumio Network Manager: Network status updated: 0 Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media-Klassiek at system boot, trial number 1 ,retrying in 5 seconds Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media-Jazz at system boot, trial number 1 ,retrying in 5 seconds Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media at system boot, trial number 1 ,retrying in 5 seconds Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: Starting albumart workers Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: Starting albumart workers Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: Starting albumart workers Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Reloading queue from file Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Asound.conf file unchanged, so no further update is needed Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Output device has changed, restarting MPD Jun 23 10:03:15 volumio-werkkamer2 sudo[1414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Output device has changed, restarting Shairport Sync Jun 23 10:03:15 volumio-werkkamer2 sudo[1414]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:15 volumio-werkkamer2 sudo[1414]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:15 volumio-werkkamer2 sudo[1416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 23 10:03:15 volumio-werkkamer2 sudo[1416]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:15 volumio-werkkamer2 systemd[1]: Stopping Music Player Daemon... Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: ___________ START PLUGINS ___________ Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: ControllerMpd::onStart: Initializing MPD Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Creating MPD Configuration file Jun 23 10:03:15 volumio-werkkamer2 systemd[1]: mpd.service: Succeeded. Jun 23 10:03:15 volumio-werkkamer2 systemd[1]: Stopped Music Player Daemon. Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: [1750672995488] CoreMusicLibrary::Adding element Media Servers Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 10:03:15 volumio-werkkamer2 sudo[1423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 23 10:03:15 volumio-werkkamer2 sudo[1423]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:15 volumio-werkkamer2 sudo[1425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 23 10:03:15 volumio-werkkamer2 systemd[1]: Starting Music Player Daemon... Jun 23 10:03:15 volumio-werkkamer2 sudo[1425]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:15 volumio-werkkamer2 sudo[1423]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:15 volumio-werkkamer2 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 23 10:03:15 volumio-werkkamer2 systemd[1]: mpd.service: Succeeded. Jun 23 10:03:15 volumio-werkkamer2 systemd[1]: Stopped Music Player Daemon. Jun 23 10:03:15 volumio-werkkamer2 systemd[1]: Starting Music Player Daemon... Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: [1750672995609] CoreMusicLibrary::Adding element Last_100 Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 10:03:15 volumio-werkkamer2 sudo[1429]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: [1750672995612] CoreMusicLibrary::Adding element Webradio Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 10:03:15 volumio-werkkamer2 sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:15 volumio-werkkamer2 sudo[1429]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Initializing BBC Radios Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Creating Spotify config file Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Volumio Calling Home Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreStateMachine::setRepeat null single undefined Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreStateMachine::pushState Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioPushState Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreStateMachine::setRandom null Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreStateMachine::pushState Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioPushState Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: Unhandled rejection Error: No sockets available, cannot start. Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: An error occurred while refreshing Spotify Token Error: getaddrinfo EBUSY oauth-performer.prod.vlmapi.io Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: MPD Permissions set Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: MPD Permissions set Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: VolumeController:: Volume=24 Mute =false Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreStateMachine::pushState Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioPushState Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreStateMachine::updateTrackBlock Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrackBlock Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioRetrievevolume Jun 23 10:03:15 volumio-werkkamer2 volumio[951]: info: Spotify config file written Jun 23 10:03:16 volumio-werkkamer2 sudo[1477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 23 10:03:16 volumio-werkkamer2 sudo[1477]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 23 10:03:16 volumio-werkkamer2 go-librespot[1484]: Librespot-go daemon starting... Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: Started go-librespot Daemon. Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 sudo[1477]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:16 volumio-werkkamer2 go-librespot[1484]: time="2025-06-23T10:03:16Z" level=info msg="generated new device id: 7bc5cfb4fbaf52f3125bd3d8027d719df5fb473e" Jun 23 10:03:16 volumio-werkkamer2 go-librespot[1484]: time="2025-06-23T10:03:16Z" level=debug msg="stored credentials found for dcvanoostveen" Jun 23 10:03:16 volumio-werkkamer2 go-librespot[1484]: time="2025-06-23T10:03:16Z" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioGetState Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: Starting Shairport Sync Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: Starting Shairport Sync Jun 23 10:03:16 volumio-werkkamer2 sudo[1501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: Starting Shairport Sync Jun 23 10:03:16 volumio-werkkamer2 sudo[1501]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 23 10:03:16 volumio-werkkamer2 sudo[1503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 10:03:16 volumio-werkkamer2 sudo[1503]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: shairport-sync.service: Succeeded. Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 23 10:03:16 volumio-werkkamer2 sudo[1506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: VolumeController:: Volume=24 Mute =false Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreStateMachine::pushState Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioPushState Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 23 10:03:16 volumio-werkkamer2 sudo[1506]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:16 volumio-werkkamer2 sudo[1501]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: shairport-sync.service: Succeeded. Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: Shairport-Sync Started Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 23 10:03:16 volumio-werkkamer2 sudo[1506]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:16 volumio-werkkamer2 sudo[1503]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: Error adding Membership: Error: addMembership EINVAL Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: Shairport-Sync Started Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: Shairport-Sync Started Jun 23 10:03:16 volumio-werkkamer2 mpd[1437]: Jun 23 10:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 23 10:03:16 volumio-werkkamer2 systemd[1]: Started Music Player Daemon. Jun 23 10:03:16 volumio-werkkamer2 sudo[1416]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:16 volumio-werkkamer2 sudo[1425]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: Completed starting Core Plugins Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: ------------------------------------------- Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: ----- MyVolumio plugins startup ---- Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: ------------------------------------------- Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: error: MPD error: The expression evaluated to a falsy value: Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: assert.ok(self.idling) Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: error: The expression evaluated to a falsy value: Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: assert.ok(self.idling) Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: info: MPD running with PID1437 Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: ,establishing connection Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: error: updateQueue error: null Jun 23 10:03:16 volumio-werkkamer2 volumio[951]: error: updateQueue error: null Jun 23 10:03:18 volumio-werkkamer2 volumio[951]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: go-librespot daemon successfully initialized Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jun 23 10:03:19 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 10:03:19 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Jun 23 10:03:19 volumio-werkkamer2 systemd[1]: Stopped go-librespot Daemon. Jun 23 10:03:19 volumio-werkkamer2 systemd[1]: Started go-librespot Daemon. Jun 23 10:03:19 volumio-werkkamer2 go-librespot[1518]: Librespot-go daemon starting... Jun 23 10:03:19 volumio-werkkamer2 go-librespot[1518]: time="2025-06-23T10:03:19Z" level=info msg="generated new device id: 7c7a010990c94fa934ce1db7537727dc303b0307" Jun 23 10:03:19 volumio-werkkamer2 go-librespot[1518]: time="2025-06-23T10:03:19Z" level=debug msg="stored credentials found for dcvanoostveen" Jun 23 10:03:19 volumio-werkkamer2 go-librespot[1518]: time="2025-06-23T10:03:19Z" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 23 10:03:19 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 10:03:19 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioGetVisibleSources Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioGetState Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: Received Get System Info Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: Discovery: Getting this device information Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioGetState Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioGetState Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: Listing playlists Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 23 10:03:19 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 23 10:03:20 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Fetching time from Volumio... Jun 23 10:03:20 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Date not found in response Jun 23 10:03:20 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Retrying in 5 seconds... Jun 23 10:03:20 volumio-werkkamer2 sudo[1531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Klassiek /mnt/NAS/Media-Klassiek Jun 23 10:03:20 volumio-werkkamer2 sudo[1531]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:20 volumio-werkkamer2 sudo[1531]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:20 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Klassiek Jun 23 10:03:20 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:20 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:20 volumio-werkkamer2 sudo[1534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Jazz /mnt/NAS/Media-Jazz Jun 23 10:03:20 volumio-werkkamer2 sudo[1534]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:20 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media-Klassiek at system boot, trial number 2 ,retrying in 5 seconds Jun 23 10:03:20 volumio-werkkamer2 sudo[1534]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:20 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Jazz Jun 23 10:03:20 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:20 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:20 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media-Jazz at system boot, trial number 2 ,retrying in 5 seconds Jun 23 10:03:20 volumio-werkkamer2 sudo[1538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Klassiek /mnt/NAS/Media Jun 23 10:03:20 volumio-werkkamer2 sudo[1538]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:20 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Klassiek Jun 23 10:03:20 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:20 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:20 volumio-werkkamer2 sudo[1538]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:20 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media at system boot, trial number 2 ,retrying in 5 seconds Jun 23 10:03:20 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioGetState Jun 23 10:03:20 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:20 volumio-werkkamer2 dhcpcd[732]: eth0: carrier acquired Jun 23 10:03:20 volumio-werkkamer2 dhcpcd[646]: eth0: carrier acquired Jun 23 10:03:20 volumio-werkkamer2 sh[592]: eth0: carrier acquired Jun 23 10:03:20 volumio-werkkamer2 kernel: r8169 0000:01:00.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx Jun 23 10:03:20 volumio-werkkamer2 sh[592]: eth0: IAID d8:01:19:80 Jun 23 10:03:20 volumio-werkkamer2 dhcpcd[646]: eth0: IAID d8:01:19:80 Jun 23 10:03:20 volumio-werkkamer2 dhcpcd[732]: eth0: IAID d8:01:19:80 Jun 23 10:03:20 volumio-werkkamer2 dhcpcd[732]: eth0: soliciting a DHCP lease Jun 23 10:03:21 volumio-werkkamer2 dhcpcd[732]: eth0: soliciting an IPv6 router Jun 23 10:03:21 volumio-werkkamer2 sh[592]: eth0: soliciting a DHCP lease Jun 23 10:03:21 volumio-werkkamer2 dhcpcd[646]: eth0: soliciting a DHCP lease Jun 23 10:03:21 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 23 10:03:21 volumio-werkkamer2 volumio[951]: info: Received Get System Info Jun 23 10:03:21 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 10:03:21 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 10:03:21 volumio-werkkamer2 volumio[951]: info: Discovery: Getting this device information Jun 23 10:03:21 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioGetState Jun 23 10:03:21 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:21 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 10:03:21 volumio-werkkamer2 sh[592]: eth0: soliciting an IPv6 router Jun 23 10:03:21 volumio-werkkamer2 dhcpcd[646]: eth0: soliciting an IPv6 router Jun 23 10:03:21 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 23 10:03:21 volumio-werkkamer2 ifplugd(eth0)[905]: Link beat detected. Jun 23 10:03:21 volumio-werkkamer2 ifplugd(eth0)[905]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jun 23 10:03:21 volumio-werkkamer2 ifplugd(eth0)[905]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Jun 23 10:03:21 volumio-werkkamer2 kernel: r8169 0000:01:00.0 eth0: Link is Down Jun 23 10:03:21 volumio-werkkamer2 dhcpcd[646]: eth0: carrier lost Jun 23 10:03:21 volumio-werkkamer2 sh[592]: eth0: carrier lost Jun 23 10:03:21 volumio-werkkamer2 dhcpcd[732]: eth0: carrier lost Jun 23 10:03:21 volumio-werkkamer2 volumio[951]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 23 10:03:22 volumio-werkkamer2 sudo[1603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 23 10:03:22 volumio-werkkamer2 volumio[951]: info: Initializing connection to go-librespot Websocket Jun 23 10:03:22 volumio-werkkamer2 sudo[1603]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:22 volumio-werkkamer2 sudo[1603]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:22 volumio-werkkamer2 sudo[1605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 23 10:03:22 volumio-werkkamer2 sudo[1605]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:22 volumio-werkkamer2 volumio[951]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 10:03:22 volumio-werkkamer2 sudo[1605]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:22 volumio-werkkamer2 sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 23 10:03:22 volumio-werkkamer2 sudo[1611]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:22 volumio-werkkamer2 systemd[1]: Started UPnP Renderer front-end to MPD. Jun 23 10:03:22 volumio-werkkamer2 sudo[1611]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:22 volumio-werkkamer2 volumio[951]: info: Upmpdcli Daemon Started Jun 23 10:03:22 volumio-werkkamer2 volumio-remote-updater[649]: [2025-06-23 10:03:22] [connect] Successful connection Jun 23 10:03:22 volumio-werkkamer2 volumio-remote-updater[649]: [2025-06-23 10:03:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1750673002 101 Jun 23 10:03:22 volumio-werkkamer2 volumio[951]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4 Jun 23 10:03:22 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 10:03:22 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Jun 23 10:03:22 volumio-werkkamer2 systemd[1]: Stopped go-librespot Daemon. Jun 23 10:03:22 volumio-werkkamer2 systemd[1]: Started go-librespot Daemon. Jun 23 10:03:22 volumio-werkkamer2 go-librespot[1626]: Librespot-go daemon starting... Jun 23 10:03:22 volumio-werkkamer2 go-librespot[1626]: time="2025-06-23T10:03:22Z" level=info msg="generated new device id: e908440ca92e6d05f7e224983869cad0adfa9cb3" Jun 23 10:03:22 volumio-werkkamer2 go-librespot[1626]: time="2025-06-23T10:03:22Z" level=debug msg="stored credentials found for dcvanoostveen" Jun 23 10:03:22 volumio-werkkamer2 go-librespot[1626]: time="2025-06-23T10:03:22Z" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 23 10:03:22 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 10:03:22 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 10:03:24 volumio-werkkamer2 sh[592]: eth0: carrier acquired Jun 23 10:03:24 volumio-werkkamer2 dhcpcd[646]: eth0: carrier acquired Jun 23 10:03:24 volumio-werkkamer2 dhcpcd[732]: eth0: carrier acquired Jun 23 10:03:24 volumio-werkkamer2 kernel: r8169 0000:01:00.0 eth0: Link is Up - 1Gbps/Full - flow control off Jun 23 10:03:24 volumio-werkkamer2 sh[592]: eth0: IAID d8:01:19:80 Jun 23 10:03:24 volumio-werkkamer2 dhcpcd[646]: eth0: IAID d8:01:19:80 Jun 23 10:03:24 volumio-werkkamer2 dhcpcd[732]: eth0: IAID d8:01:19:80 Jun 23 10:03:25 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Fetching time from Volumio... Jun 23 10:03:25 volumio-werkkamer2 dhcpcd[732]: eth0: soliciting a DHCP lease Jun 23 10:03:25 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Date not found in response Jun 23 10:03:25 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Retrying in 5 seconds... Jun 23 10:03:25 volumio-werkkamer2 sh[592]: eth0: soliciting an IPv6 router Jun 23 10:03:25 volumio-werkkamer2 dhcpcd[646]: eth0: soliciting an IPv6 router Jun 23 10:03:25 volumio-werkkamer2 sudo[1641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Klassiek /mnt/NAS/Media-Klassiek Jun 23 10:03:25 volumio-werkkamer2 sudo[1641]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:25 volumio-werkkamer2 sudo[1641]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:25 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Klassiek Jun 23 10:03:25 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:25 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:25 volumio-werkkamer2 sudo[1644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Jazz /mnt/NAS/Media-Jazz Jun 23 10:03:25 volumio-werkkamer2 sudo[1644]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:25 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media-Klassiek at system boot, trial number 3 ,retrying in 5 seconds Jun 23 10:03:25 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Jazz Jun 23 10:03:25 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:25 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:25 volumio-werkkamer2 sudo[1644]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:25 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media-Jazz at system boot, trial number 3 ,retrying in 5 seconds Jun 23 10:03:25 volumio-werkkamer2 sudo[1649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Klassiek /mnt/NAS/Media Jun 23 10:03:25 volumio-werkkamer2 sudo[1649]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:25 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Klassiek Jun 23 10:03:25 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:25 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:25 volumio-werkkamer2 sudo[1649]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:25 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media at system boot, trial number 3 ,retrying in 5 seconds Jun 23 10:03:25 volumio-werkkamer2 volumio[951]: info: Initializing connection to go-librespot Websocket Jun 23 10:03:25 volumio-werkkamer2 volumio[951]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 10:03:25 volumio-werkkamer2 sh[592]: eth0: soliciting a DHCP lease Jun 23 10:03:25 volumio-werkkamer2 dhcpcd[646]: eth0: soliciting a DHCP lease Jun 23 10:03:25 volumio-werkkamer2 dhcpcd[732]: eth0: soliciting an IPv6 router Jun 23 10:03:25 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 10:03:25 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Jun 23 10:03:25 volumio-werkkamer2 systemd[1]: Stopped go-librespot Daemon. Jun 23 10:03:25 volumio-werkkamer2 systemd[1]: Started go-librespot Daemon. Jun 23 10:03:25 volumio-werkkamer2 go-librespot[1655]: Librespot-go daemon starting... Jun 23 10:03:25 volumio-werkkamer2 go-librespot[1655]: time="2025-06-23T10:03:25Z" level=info msg="generated new device id: 35fbfaa83e79f61888433045a967a7831cf3ff8d" Jun 23 10:03:25 volumio-werkkamer2 go-librespot[1655]: time="2025-06-23T10:03:25Z" level=debug msg="stored credentials found for dcvanoostveen" Jun 23 10:03:25 volumio-werkkamer2 go-librespot[1655]: time="2025-06-23T10:03:25Z" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 23 10:03:25 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 10:03:25 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 10:03:25 volumio-werkkamer2 volumio[951]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.799&uuid=cd9efb7a2b0e854d3b1592bf7891960b" http://updates.volumio.org/downloader-v1/track-device Jun 23 10:03:25 volumio-werkkamer2 volumio[951]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 23 10:03:25 volumio-werkkamer2 volumio[951]: Dload Upload Total Spent Left Speed Jun 23 10:03:25 volumio-werkkamer2 volumio[951]: [132B blob data] Jun 23 10:03:25 volumio-werkkamer2 volumio[951]: retrying in 5 seconds, trial 0 Jun 23 10:03:25 volumio-werkkamer2 volumio[951]: info: Volumio Calling Home Jun 23 10:03:28 volumio-werkkamer2 volumio[951]: info: Initializing connection to go-librespot Websocket Jun 23 10:03:28 volumio-werkkamer2 volumio[951]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 10:03:29 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 10:03:29 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Jun 23 10:03:29 volumio-werkkamer2 systemd[1]: Stopped go-librespot Daemon. Jun 23 10:03:29 volumio-werkkamer2 systemd[1]: Started go-librespot Daemon. Jun 23 10:03:29 volumio-werkkamer2 go-librespot[1844]: Librespot-go daemon starting... Jun 23 10:03:29 volumio-werkkamer2 go-librespot[1844]: time="2025-06-23T10:03:29Z" level=info msg="generated new device id: ecbd5bf15b01fb3a01d843b8cffd67f33705e9a1" Jun 23 10:03:29 volumio-werkkamer2 go-librespot[1844]: time="2025-06-23T10:03:29Z" level=debug msg="stored credentials found for dcvanoostveen" Jun 23 10:03:29 volumio-werkkamer2 go-librespot[1844]: time="2025-06-23T10:03:29Z" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 23 10:03:29 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 10:03:29 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 10:03:29 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 23 10:03:29 volumio-werkkamer2 sh[592]: eth0: offered 192.168.1.123 from 192.168.1.1 Jun 23 10:03:29 volumio-werkkamer2 dhcpcd[646]: eth0: offered 192.168.1.123 from 192.168.1.1 Jun 23 10:03:29 volumio-werkkamer2 dhcpcd[646]: eth0: probing address 192.168.1.123/24 Jun 23 10:03:29 volumio-werkkamer2 sh[592]: eth0: probing address 192.168.1.123/24 Jun 23 10:03:30 volumio-werkkamer2 dhcpcd[732]: eth0: probing for an IPv4LL address Jun 23 10:03:30 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Fetching time from Volumio... Jun 23 10:03:30 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Date not found in response Jun 23 10:03:30 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Retrying in 5 seconds... Jun 23 10:03:30 volumio-werkkamer2 sudo[1857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Klassiek /mnt/NAS/Media-Klassiek Jun 23 10:03:30 volumio-werkkamer2 sudo[1857]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:30 volumio-werkkamer2 sudo[1857]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:30 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Klassiek Jun 23 10:03:30 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:30 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:30 volumio-werkkamer2 sudo[1862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Jazz /mnt/NAS/Media-Jazz Jun 23 10:03:30 volumio-werkkamer2 sudo[1862]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:30 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Jazz Jun 23 10:03:30 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:30 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:30 volumio-werkkamer2 sudo[1862]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:30 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media-Klassiek at system boot, trial number 4 ,retrying in 5 seconds Jun 23 10:03:30 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media-Jazz at system boot, trial number 4 ,retrying in 5 seconds Jun 23 10:03:30 volumio-werkkamer2 sudo[1867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Klassiek /mnt/NAS/Media Jun 23 10:03:30 volumio-werkkamer2 sudo[1867]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:30 volumio-werkkamer2 sudo[1867]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:30 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Klassiek Jun 23 10:03:30 volumio-werkkamer2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 23 10:03:30 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jun 23 10:03:30 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS Media at system boot, trial number 4 ,retrying in 5 seconds Jun 23 10:03:31 volumio-werkkamer2 volumio[951]: info: Initializing connection to go-librespot Websocket Jun 23 10:03:31 volumio-werkkamer2 volumio[951]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 10:03:32 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 10:03:32 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Jun 23 10:03:32 volumio-werkkamer2 systemd[1]: Stopped go-librespot Daemon. Jun 23 10:03:32 volumio-werkkamer2 systemd[1]: Started go-librespot Daemon. Jun 23 10:03:32 volumio-werkkamer2 go-librespot[1885]: Librespot-go daemon starting... Jun 23 10:03:32 volumio-werkkamer2 go-librespot[1885]: time="2025-06-23T10:03:32Z" level=info msg="generated new device id: c4819db69b09e90d56cd61454b8df67c40df1cdf" Jun 23 10:03:32 volumio-werkkamer2 go-librespot[1885]: time="2025-06-23T10:03:32Z" level=debug msg="stored credentials found for dcvanoostveen" Jun 23 10:03:32 volumio-werkkamer2 go-librespot[1885]: time="2025-06-23T10:03:32Z" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 23 10:03:32 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 23 10:03:32 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 23 10:03:34 volumio-werkkamer2 systemd[1]: systemd-fsckd.service: Succeeded. Jun 23 10:03:34 volumio-werkkamer2 volumio[951]: info: Initializing connection to go-librespot Websocket Jun 23 10:03:34 volumio-werkkamer2 volumio[951]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 23 10:03:34 volumio-werkkamer2 sh[592]: timed out Jun 23 10:03:34 volumio-werkkamer2 dhcpcd[646]: timed out Jun 23 10:03:34 volumio-werkkamer2 sh[592]: dhcpcd exited Jun 23 10:03:34 volumio-werkkamer2 dhcpcd[646]: dhcpcd exited Jun 23 10:03:34 volumio-werkkamer2 sh[592]: ifup: failed to bring up eth0 Jun 23 10:03:34 volumio-werkkamer2 systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jun 23 10:03:34 volumio-werkkamer2 systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jun 23 10:03:34 volumio-werkkamer2 ifplugd(eth0)[905]: client: command failed: No such device (-19) Jun 23 10:03:34 volumio-werkkamer2 dhcpcd[1908]: sending commands to master dhcpcd process Jun 23 10:03:34 volumio-werkkamer2 ifplugd(eth0)[905]: client: sending commands to master dhcpcd process Jun 23 10:03:34 volumio-werkkamer2 dhcpcd[732]: control command: /sbin/dhcpcd eth0 Jun 23 10:03:35 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Fetching time from Volumio... Jun 23 10:03:35 volumio-werkkamer2 dhcpcd[732]: eth0: using IPv4LL address 169.254.135.56 Jun 23 10:03:35 volumio-werkkamer2 dhcpcd[732]: eth0: adding route to 169.254.0.0/16 Jun 23 10:03:35 volumio-werkkamer2 avahi-daemon[647]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.135.56. Jun 23 10:03:35 volumio-werkkamer2 dhcpcd[732]: eth0: adding default route Jun 23 10:03:35 volumio-werkkamer2 avahi-daemon[647]: New relevant interface eth0.IPv4 for mDNS. Jun 23 10:03:35 volumio-werkkamer2 avahi-daemon[647]: Registering new address record for 169.254.135.56 on eth0.IPv4. Jun 23 10:03:35 volumio-werkkamer2 ifplugd(eth0)[905]: Program executed successfully. Jun 23 10:03:35 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Date not found in response Jun 23 10:03:35 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Retrying in 5 seconds... Jun 23 10:03:35 volumio-werkkamer2 sudo[1952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Klassiek /mnt/NAS/Media-Klassiek Jun 23 10:03:35 volumio-werkkamer2 sudo[1952]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:35 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Klassiek Jun 23 10:03:35 volumio-werkkamer2 sudo[1957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Jazz /mnt/NAS/Media-Jazz Jun 23 10:03:35 volumio-werkkamer2 sudo[1957]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:35 volumio-werkkamer2 sudo[1961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daniel,password=e4C3ebtxYhH42B,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/Media/Music/Klassiek /mnt/NAS/Media Jun 23 10:03:35 volumio-werkkamer2 sudo[1961]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:35 volumio-werkkamer2 dhcpcd[732]: eth0: offered 192.168.1.123 from 192.168.1.1 Jun 23 10:03:35 volumio-werkkamer2 dhcpcd[732]: eth0: probing address 192.168.1.123/24 Jun 23 10:03:35 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 23 10:03:35 volumio-werkkamer2 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 6. Jun 23 10:03:35 volumio-werkkamer2 systemd[1]: Stopped go-librespot Daemon. Jun 23 10:03:35 volumio-werkkamer2 systemd[1]: Started go-librespot Daemon. Jun 23 10:03:35 volumio-werkkamer2 go-librespot[1966]: Librespot-go daemon starting... Jun 23 10:03:35 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:35Z" level=info msg="generated new device id: 5cd095f570712c5739666b108224afb1d8cac5d2" Jun 23 10:03:35 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:35Z" level=debug msg="stored credentials found for dcvanoostveen" Jun 23 10:03:35 volumio-werkkamer2 dhcpcd[732]: eth0: hardware address b8:69:f4:9d:80:10 claims 169.254.135.56 Jun 23 10:03:35 volumio-werkkamer2 dhcpcd[732]: eth0: hardware address b8:69:f4:9d:80:10 claims 169.254.135.56 Jun 23 10:03:35 volumio-werkkamer2 dhcpcd[732]: eth0: IPv4LL 10 second defence failed for 169.254.135.56/16 Jun 23 10:03:35 volumio-werkkamer2 avahi-daemon[647]: Withdrawing address record for 169.254.135.56 on eth0. Jun 23 10:03:35 volumio-werkkamer2 avahi-daemon[647]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.135.56. Jun 23 10:03:35 volumio-werkkamer2 avahi-daemon[647]: Interface eth0.IPv4 no longer relevant for mDNS. Jun 23 10:03:35 volumio-werkkamer2 volumio[951]: info: Discovery: A device disappeared from network Jun 23 10:03:35 volumio-werkkamer2 volumio[951]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Jun 23 10:03:35 volumio-werkkamer2 dhcpcd[732]: eth0: deleted route to 169.254.0.0/16 Jun 23 10:03:35 volumio-werkkamer2 dhcpcd[732]: eth0: deleted default route Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.799&uuid=cd9efb7a2b0e854d3b1592bf7891960b" http://updates.volumio.org/downloader-v1/track-device Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: Dload Upload Total Spent Left Speed Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: [132B blob data] Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: retrying in 5 seconds, trial 1 Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: info: Volumio Calling Home Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: error: MyVolumio Plugin failed to start in a timely fashion Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: [Metrics] CommandRouter: 27s 795.56ms Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumiosetStartupVolume Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::Close All Modals sent Jun 23 10:03:36 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::Close All Modals sent Jun 23 10:03:37 volumio-werkkamer2 volumio[951]: info: Initializing connection to go-librespot Websocket Jun 23 10:03:37 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:37Z" level=debug msg="new websocket client" Jun 23 10:03:37 volumio-werkkamer2 volumio[951]: info: Connection to go-librespot Websocket established Jun 23 10:03:37 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 23 10:03:37 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 23 10:03:37 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 23 10:03:40 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Fetching time from Volumio... Jun 23 10:03:40 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Date not found in response Jun 23 10:03:40 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Retrying in 5 seconds... Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: Discovery: Browse raised the following error Error: dns service error: unknown Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: Getting Spotify volume Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioGetState Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:40 volumio-werkkamer2 dhcpcd[732]: eth0: leased 192.168.1.123 for 43200 seconds Jun 23 10:03:40 volumio-werkkamer2 dhcpcd[732]: eth0: adding route to 192.168.1.0/24 Jun 23 10:03:40 volumio-werkkamer2 dhcpcd[732]: eth0: adding default route via 192.168.1.1 Jun 23 10:03:40 volumio-werkkamer2 avahi-daemon[647]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.123. Jun 23 10:03:40 volumio-werkkamer2 avahi-daemon[647]: New relevant interface eth0.IPv4 for mDNS. Jun 23 10:03:40 volumio-werkkamer2 avahi-daemon[647]: Registering new address record for 192.168.1.123 on eth0.IPv4. Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: SPOTIFY: SPOTIFY VOLUME undefined Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: SPOTIFY: VOLUMIO VOLUME 24 Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: Aligning Spotify Volume to Volumio Volume Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioGetState Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: Setting Spotify Volume from Volumio: 24 Jun 23 10:03:40 volumio-werkkamer2 kernel: CIFS: VFS: cifs_mount failed w/return code = -112 Jun 23 10:03:40 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Jazz Jun 23 10:03:40 volumio-werkkamer2 sudo[1952]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Jun 23 10:03:40 volumio-werkkamer2 ntpd[894]: ntpd exiting on signal 15 (Terminated) Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: Stopping Network Time Service... Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: ntp.service: Succeeded. Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: Stopped Network Time Service. Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: Starting Network Time Service... Jun 23 10:03:40 volumio-werkkamer2 ntpd[2038]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 23 10:03:40 volumio-werkkamer2 ntpd[2038]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 104:103 Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: Started Network Time Service. Jun 23 10:03:40 volumio-werkkamer2 ntpd[2049]: proto: precision = 0.203 usec (-22) Jun 23 10:03:40 volumio-werkkamer2 ntpd[2049]: Listen and drop on 0 v6wildcard [::]:123 Jun 23 10:03:40 volumio-werkkamer2 ntpd[2049]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 23 10:03:40 volumio-werkkamer2 ntpd[2049]: Listen normally on 2 lo 127.0.0.1:123 Jun 23 10:03:40 volumio-werkkamer2 ntpd[2049]: Listen normally on 3 eth0 192.168.1.123:123 Jun 23 10:03:40 volumio-werkkamer2 ntpd[2049]: Listening on routing socket on fd #20 for interface updates Jun 23 10:03:40 volumio-werkkamer2 ntpd[2049]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 23 10:03:40 volumio-werkkamer2 ntpd[2049]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 23 10:03:40 volumio-werkkamer2 sudo[1957]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:40 volumio-werkkamer2 kernel: CIFS: Attempting to mount //192.168.1.2/Media/Music/Klassiek Jun 23 10:03:40 volumio-werkkamer2 sudo[1961]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:40 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:40Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Jun 23 10:03:40 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:40Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jun 23 10:03:40 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:40Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jun 23 10:03:40 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:40Z" level=debug msg="zeroconf server listening on port 43771" Jun 23 10:03:40 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:40Z" level=debug msg="obtained new client token: AADa350cqQn8eKSBZshUmBKW5Xw9AisnOVLzYhaNdIFjneEUoB7yc3DJggnW8vciZu+IN1YJM1tPUJfs9xwwXXsI2CGvxR+o74UuXVguDrtvB6ZCMn0vJmA81F5uP9jqYvFUtenJzmqLXyMJVY/oQyz9l8DRx/MIVItDHQsMtody2F9AczWhqACHsUE8qai5ON5Lw2Rs2gjWnEITny6MjNP4EG9ZV82/zYrFLMonMgwIoLpqC4ni80+Rzw==" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="completed keyexchange" Jun 23 10:03:41 volumio-werkkamer2 nmbd[888]: [2025/06/23 10:03:41.098507, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 23 10:03:41 volumio-werkkamer2 nmbd[888]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jun 23 10:03:41 volumio-werkkamer2 systemd[1]: Started Samba NMB Daemon. Jun 23 10:03:41 volumio-werkkamer2 systemd[1]: Starting Samba Winbind Daemon... Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: Adding plugin bluetooth to MyMusic Plugins Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: Adding plugin multiroom to MyMusic Plugins Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: Adding plugin metavolumio to MyMusic Plugins Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: Adding plugin cd_controller to MyMusic Plugins Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 23 10:03:41 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 23 10:03:41 volumio-werkkamer2 winbindd[2051]: [2025/06/23 10:03:41.350557, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jun 23 10:03:41 volumio-werkkamer2 winbindd[2051]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jun 23 10:03:41 volumio-werkkamer2 winbindd[2051]: [2025/06/23 10:03:41.356858, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 23 10:03:41 volumio-werkkamer2 winbindd[2051]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jun 23 10:03:41 volumio-werkkamer2 systemd[1]: Started Samba Winbind Daemon. Jun 23 10:03:41 volumio-werkkamer2 systemd[1]: Starting Samba SMB Daemon... Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="completed challenge" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="authenticated as dcvanoostveen" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="authenticated as dcvanoostveen" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="dealer connection opened" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="initializing zeroconf session, username: dcvanoostveen" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="autoplay enabled: false" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="received connection id: OGFiZWNiZWItZGYzZi00MjEwLWFiNjYtMGQ0NjM1NDUyZjFhK2RlYWxlcit0Y3A6Ly8wYWNhNThhOS5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArRTQ1OEQ5RjEzMUQyRTZFNjI1NjRFNjA1NDc5MkMyMDdBNjc0NEFBQ0E4MUU3RDY4MzhDRDI5RkNEQjYxNkUwNw==" Jun 23 10:03:41 volumio-werkkamer2 smbd[2056]: [2025/06/23 10:03:41.739631, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 23 10:03:41 volumio-werkkamer2 systemd[1]: Started Samba SMB Daemon. Jun 23 10:03:41 volumio-werkkamer2 smbd[2056]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 23 10:03:41 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:41Z" level=debug msg="put connect state because NEW_DEVICE" Jun 23 10:03:41 volumio-werkkamer2 systemd[1]: systemd-hostnamed.service: Succeeded. Jun 23 10:03:42 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 23 10:03:42 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 23 10:03:42 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:42 volumio-werkkamer2 volumio[951]: info: Starting MyVolumio Remote Streaming Endpoints Jun 23 10:03:42 volumio-werkkamer2 volumio[951]: info: MyVolumio login type: Token Jun 23 10:03:42 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 23 10:03:42 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: Starting Streaming Service Transparent Proxy Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: Streaming services startup Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: Starting Streaming Daemon Jun 23 10:03:43 volumio-werkkamer2 sudo[2088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 23 10:03:43 volumio-werkkamer2 sudo[2088]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:43 volumio-werkkamer2 sudo[2088]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: SPOTIFY: SETTING SPOTIFY VOLUME 24 Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: Sending Spotify command with payload to local API: /player/volume Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: Spotify volume: 100 Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: Volumio Network Manager: Network status updated: 1 Jun 23 10:03:43 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:43Z" level=debug msg="update volume to 15728/65535" Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: error: Cannot start Volumio Streaming Daemon Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: Discovery: adding a4419bc4-5866-4e4c-b994-c3329f1724d0 Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: Discovery: Found device Volumio-werkkamer2 Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioGetState Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 23 10:03:43 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:43Z" level=debug msg="put connect state because VOLUME_CHANGED" Jun 23 10:03:43 volumio-werkkamer2 go-librespot[1966]: time="2025-06-23T10:03:43Z" level=trace msg="emitting websocket event: volume" Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: Received Get System Info Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: Discovery: Getting this device information Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::volumioGetState Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: CorePlayQueue::getTrack 0 Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: SPOTIFY: received: {"type":"volume","data":{"value":24,"max":100}} Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: SPOTIFY: RECEIVED SPOTIFY VOLUME 24 Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: error: MyVolumio Custom Token format not valid, refreshing it Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: BOOT COMPLETED Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: info: MyVolumio login type: Token Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: STREAMING PROXY: Starting server on port 3245 Jun 23 10:03:43 volumio-werkkamer2 volumio[951]: Node JS runtime: 14 Jun 23 10:03:44 volumio-werkkamer2 volumio[951]: info: MyVolumio login type: Token Jun 23 10:03:44 volumio-werkkamer2 volumio[951]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 23 10:03:44 volumio-werkkamer2 volumio[1613]: Generating RSA private key, 4096 bit long modulus (2 primes) Jun 23 10:03:44 volumio-werkkamer2 volumio[951]: info: MyVolumio token set successfully Jun 23 10:03:44 volumio-werkkamer2 volumio[951]: info: MYVOLUMIO: Adding device Jun 23 10:03:44 volumio-werkkamer2 volumio[951]: info: MYVOLUMIO: Evaluating Server Jun 23 10:03:45 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Fetching time from Volumio... Jun 23 10:03:45 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: Setting system time to: 2025-06-23 10:03:40 Jun 23 10:03:45 volumio-werkkamer2 volumio[951]: info: MyVolumio status changed Jun 23 10:03:45 volumio-werkkamer2 sudo[2118]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-06-23 10:03:40 Jun 23 10:03:45 volumio-werkkamer2 volumio[951]: info: Streaming services startup Jun 23 10:03:45 volumio-werkkamer2 volumio[951]: info: Starting Streaming Daemon Jun 23 10:03:45 volumio-werkkamer2 sudo[2118]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:45 volumio-werkkamer2 volumio[951]: info: Removing browser output: myVolumio user plan is not superstar Jun 23 10:03:45 volumio-werkkamer2 volumio[951]: info: Removing audio output: Jun 23 10:03:45 volumio-werkkamer2 volumio[951]: info: Stoppping Tunnel 1 Jun 23 10:03:45 volumio-werkkamer2 dbus-daemon[653]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.16' (uid=0 pid=2120 comm="timedatectl set-time 2025-06-23 10:03:40 ") Jun 23 10:03:45 volumio-werkkamer2 sudo[2122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 23 10:03:45 volumio-werkkamer2 sudo[2122]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:45 volumio-werkkamer2 sudo[2125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jun 23 10:03:45 volumio-werkkamer2 sudo[2125]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 10:03:45 volumio-werkkamer2 systemd[1]: Starting Time & Date Service... Jun 23 10:03:45 volumio-werkkamer2 sudo[2122]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:45 volumio-werkkamer2 volumio[951]: error: Cannot start Volumio Streaming Daemon Jun 23 10:03:45 volumio-werkkamer2 volumio[951]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 23 10:03:45 volumio-werkkamer2 volumio[951]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 23 10:03:45 volumio-werkkamer2 sudo[2125]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:45 volumio-werkkamer2 volumio[951]: info: Remote SSH Stopped Jun 23 10:03:45 volumio-werkkamer2 dbus-daemon[653]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 23 10:03:45 volumio-werkkamer2 systemd[1]: Started Time & Date Service. Jun 23 10:03:40 volumio-werkkamer2 systemd-timedated[2126]: Changed local time to Mon Jun 23 10:03:40 2025 Jun 23 10:03:40 volumio-werkkamer2 sudo[2118]: pam_unix(sudo:session): session closed for user root Jun 23 10:03:40 volumio-werkkamer2 volumio-time-update[635]: volumio-time-update-util: System time updated successfully. Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: Started Volumio Time Update Utility. Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: Reached target Multi-User System. Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: Reached target Graphical Interface. Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 23 10:03:40 volumio-werkkamer2 systemd[1]: Startup finished in 3.474s (firmware) + 2.270s (loader) + 9.361s (kernel) + 43.940s (userspace) = 59.047s. Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: error: Failed to ping endpoint au1.myvolumio.org : unknown error Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: Setting Geolocation for MyVolumio to eu8 Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: Error: Unable to resolve or reject the same promise twice Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: at Socket.emit (events.js:412:35) Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: at endReadableNT (internal/streams/readable.js:1333:12) Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jun 23 10:03:40 volumio-werkkamer2 volumio[951]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 23 10:03:40 volumio-werkkamer2 volumio[1613]: ...............................................++++ Jun 23 10:03:40 volumio-werkkamer2 sudo[2139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-23 10:02 Jun 23 10:03:40 volumio-werkkamer2 sudo[2139]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"