-- Logs begin at Fri 2024-03-29 15:37:40 CET, end at Fri 2024-03-29 15:38:43 CET. -- Mar 29 15:37:40 volumio-pc kernel: Linux version 6.6.7-volumio (gkkpch@TWINUNX-20) (gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #2 SMP PREEMPT_DYNAMIC Mon Dec 18 16:22:28 CET 2023 Mar 29 15:37:40 volumio-pc kernel: Command line: BOOT_IMAGE=/vmlinuz biosdevname=0 splash plymouth.ignore-serial-consoles quiet ro rootwait imgpart=UUID=f9f7c575-874e-43ef-a723-80ec9af506d0 bootpart=UUID=6F6B-311A datapart=UUID=5e594c75-cc80-4bc2-957a-50cc329bdaa4 imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor use_kmsg=yes net.ifnames=0 loglevel=0 Mar 29 15:37:40 volumio-pc kernel: KERNEL supported cpus: Mar 29 15:37:40 volumio-pc kernel: Intel GenuineIntel Mar 29 15:37:40 volumio-pc kernel: AMD AuthenticAMD Mar 29 15:37:40 volumio-pc kernel: Hygon HygonGenuine Mar 29 15:37:40 volumio-pc kernel: Centaur CentaurHauls Mar 29 15:37:40 volumio-pc kernel: zhaoxin Shanghai Mar 29 15:37:40 volumio-pc kernel: BIOS-provided physical RAM map: Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000003efff] usable Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000000003f000-0x000000000003ffff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x0000000000040000-0x000000000009efff] usable Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000000009f000-0x00000000000fffff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x0000000000100000-0x000000000fffffff] usable Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x0000000010000000-0x0000000012150fff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x0000000012151000-0x000000006b4e0fff] usable Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006b4e1000-0x000000006d5d9fff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006d5da000-0x000000006d6b0fff] usable Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006d6b1000-0x000000006d9d4fff] ACPI NVS Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006d9d5000-0x000000006dd77fff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006dd78000-0x000000006ddd6fff] type 20 Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006ddd7000-0x000000006e14ffff] usable Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006e150000-0x000000006e150fff] ACPI NVS Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006e151000-0x000000006e17afff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006e17b000-0x000000006e755fff] usable Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006e756000-0x000000006e757fff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006e758000-0x000000006effffff] usable Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x000000006f000000-0x000000007fffffff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x00000000d0000000-0x00000000d0ffffff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x00000000fe042000-0x00000000fe044fff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x00000000fe900000-0x00000000fe902fff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x00000000fed01000-0x00000000fed01fff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x00000000ff800000-0x00000000ffffffff] reserved Mar 29 15:37:40 volumio-pc kernel: BIOS-e820: [mem 0x0000000100000000-0x000000027fffffff] usable Mar 29 15:37:40 volumio-pc kernel: NX (Execute Disable) protection: active Mar 29 15:37:40 volumio-pc kernel: APIC: Static calls initialized Mar 29 15:37:40 volumio-pc kernel: efi: EFI v2.5 by American Megatrends Mar 29 15:37:40 volumio-pc kernel: efi: ESRT=0x6dd76918 ACPI=0x6d9b6000 ACPI 2.0=0x6d9b6000 SMBIOS=0xf05e0 SMBIOS 3.0=0xf0600 Mar 29 15:37:40 volumio-pc kernel: efi: Remove mem35: MMIO range=[0xd0000000-0xd0ffffff] (16MB) from e820 map Mar 29 15:37:40 volumio-pc kernel: e820: remove [mem 0xd0000000-0xd0ffffff] reserved Mar 29 15:37:40 volumio-pc kernel: efi: Remove mem36: MMIO range=[0xe0000000-0xefffffff] (256MB) from e820 map Mar 29 15:37:40 volumio-pc kernel: e820: remove [mem 0xe0000000-0xefffffff] reserved Mar 29 15:37:40 volumio-pc kernel: efi: Not removing mem37: MMIO range=[0xfe042000-0xfe042fff] (4KB) from e820 map Mar 29 15:37:40 volumio-pc kernel: efi: Not removing mem38: MMIO range=[0xfe043000-0xfe043fff] (4KB) from e820 map Mar 29 15:37:40 volumio-pc kernel: efi: Not removing mem39: MMIO range=[0xfe044000-0xfe044fff] (4KB) from e820 map Mar 29 15:37:40 volumio-pc kernel: efi: Not removing mem40: MMIO range=[0xfe900000-0xfe902fff] (12KB) from e820 map Mar 29 15:37:40 volumio-pc kernel: efi: Not removing mem41: MMIO range=[0xfec00000-0xfec00fff] (4KB) from e820 map Mar 29 15:37:40 volumio-pc kernel: efi: Not removing mem42: MMIO range=[0xfed01000-0xfed01fff] (4KB) from e820 map Mar 29 15:37:40 volumio-pc kernel: efi: Not removing mem43: MMIO range=[0xfee00000-0xfee00fff] (4KB) from e820 map Mar 29 15:37:40 volumio-pc kernel: efi: Remove mem44: MMIO range=[0xff800000-0xffffffff] (8MB) from e820 map Mar 29 15:37:40 volumio-pc kernel: e820: remove [mem 0xff800000-0xffffffff] reserved Mar 29 15:37:40 volumio-pc kernel: SMBIOS 3.0.0 present. Mar 29 15:37:40 volumio-pc kernel: DMI: To Be Filled By O.E.M. To Be Filled By O.E.M./J4205-ITX, BIOS P1.40 07/14/2017 Mar 29 15:37:40 volumio-pc kernel: tsc: Detected 1497.600 MHz processor Mar 29 15:37:40 volumio-pc kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Mar 29 15:37:40 volumio-pc kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Mar 29 15:37:40 volumio-pc kernel: last_pfn = 0x280000 max_arch_pfn = 0x400000000 Mar 29 15:37:40 volumio-pc kernel: MTRR map: 9 entries (5 fixed + 4 variable; max 25), built from 10 variable MTRRs Mar 29 15:37:40 volumio-pc kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Mar 29 15:37:40 volumio-pc kernel: last_pfn = 0x6f000 max_arch_pfn = 0x400000000 Mar 29 15:37:40 volumio-pc kernel: found SMP MP-table at [mem 0x000fcbd0-0x000fcbdf] Mar 29 15:37:40 volumio-pc kernel: esrt: Reserving ESRT space from 0x000000006dd76918 to 0x000000006dd76950. Mar 29 15:37:40 volumio-pc kernel: Using GB pages for direct mapping Mar 29 15:37:40 volumio-pc kernel: Secure boot could not be determined Mar 29 15:37:40 volumio-pc kernel: RAMDISK: [mem 0x2fc33000-0x33e10fff] Mar 29 15:37:40 volumio-pc kernel: ACPI: Early table checksum verification disabled Mar 29 15:37:40 volumio-pc kernel: ACPI: RSDP 0x000000006D9B6000 000024 (v02 ALASKA) Mar 29 15:37:40 volumio-pc kernel: ACPI: XSDT 0x000000006D9B60C0 0000E4 (v01 ALASKA A M I 01072009 AMI 00010013) Mar 29 15:37:40 volumio-pc kernel: ACPI: FACP 0x000000006D9BF210 000114 (v06 ALASKA A M I 01072009 AMI 00010013) Mar 29 15:37:40 volumio-pc kernel: ACPI: DSDT 0x000000006D9B6250 008FB3 (v02 ALASKA A M I 01072009 INTL 20120913) Mar 29 15:37:40 volumio-pc kernel: ACPI: FACS 0x000000006D9D4080 000040 Mar 29 15:37:40 volumio-pc kernel: ACPI: FPDT 0x000000006D9BF330 000044 (v01 ALASKA A M I 01072009 AMI 00010013) Mar 29 15:37:40 volumio-pc kernel: ACPI: FIDT 0x000000006D9BF380 00009C (v01 ALASKA A M I 01072009 AMI 00010013) Mar 29 15:37:40 volumio-pc kernel: ACPI: MCFG 0x000000006D9BF420 00003C (v01 ALASKA A M I 01072009 MSFT 00000097) Mar 29 15:37:40 volumio-pc kernel: ACPI: DBG2 0x000000006D9BF460 000072 (v00 INTEL EDK2 00000003 BRXT 0100000D) Mar 29 15:37:40 volumio-pc kernel: ACPI: DBGP 0x000000006D9BF4E0 000034 (v01 INTEL EDK2 00000003 BRXT 0100000D) Mar 29 15:37:40 volumio-pc kernel: ACPI: HPET 0x000000006D9BF520 000038 (v01 INTEL EDK2 00000003 BRXT 0100000D) Mar 29 15:37:40 volumio-pc kernel: ACPI: LPIT 0x000000006D9BF560 00005C (v01 INTEL EDK2 00000003 BRXT 0100000D) Mar 29 15:37:40 volumio-pc kernel: ACPI: APIC 0x000000006D9BF5C0 000084 (v03 INTEL EDK2 00000003 BRXT 0100000D) Mar 29 15:37:40 volumio-pc kernel: ACPI: NPKT 0x000000006D9BF650 000065 (v01 INTEL EDK2 00000003 BRXT 0100000D) Mar 29 15:37:40 volumio-pc kernel: ACPI: PRAM 0x000000006D9BF6C0 000030 (v01 INTEL EDK2 00000003 BRXT 0100000D) Mar 29 15:37:40 volumio-pc kernel: ACPI: WSMT 0x000000006D9BF6F0 000028 (v00 INTEL EDK2 00000003 BRXT 0100000D) Mar 29 15:37:40 volumio-pc kernel: ACPI: SSDT 0x000000006D9BF720 000B53 (v02 INTEL UsbCTabl 00000003 BRXT 0100000D) Mar 29 15:37:40 volumio-pc kernel: ACPI: SSDT 0x000000006D9C0280 0016E9 (v01 Intel_ Platform 00001000 INTL 20120913) Mar 29 15:37:40 volumio-pc kernel: ACPI: AAFT 0x000000006D9C1970 0002DA (v01 ALASKA OEMAAFT 01072009 MSFT 00000097) Mar 29 15:37:40 volumio-pc kernel: ACPI: SSDT 0x000000006D9C1C50 0004A5 (v02 PmRef Cpu0Ist 00003000 INTL 20120913) Mar 29 15:37:40 volumio-pc kernel: ACPI: SSDT 0x000000006D9C2100 00072B (v02 CpuRef CpuSsdt 00003000 INTL 20120913) Mar 29 15:37:40 volumio-pc kernel: ACPI: SSDT 0x000000006D9C2830 00032D (v02 PmRef Cpu0Tst 00003000 INTL 20120913) Mar 29 15:37:40 volumio-pc kernel: ACPI: SSDT 0x000000006D9C2B60 00017C (v02 PmRef ApTst 00003000 INTL 20120913) Mar 29 15:37:40 volumio-pc kernel: ACPI: SSDT 0x000000006D9C2CE0 002760 (v02 SaSsdt SaSsdt 00003000 INTL 20120913) Mar 29 15:37:40 volumio-pc kernel: ACPI: UEFI 0x000000006D9C5440 000042 (v01 ALASKA A M I 00000000 00000000) Mar 29 15:37:40 volumio-pc kernel: ACPI: BGRT 0x000000006D9C5490 000038 (v01 ALASKA A M I 01072009 AMI 00010013) Mar 29 15:37:40 volumio-pc kernel: ACPI: WDAT 0x000000006D9C54D0 000104 (v01 00000000 00000000) Mar 29 15:37:40 volumio-pc kernel: ACPI: NHLT 0x000000006D9C55E0 001A50 (v00 INTEL EDK2 00000002 01000013) Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving FACP table memory at [mem 0x6d9bf210-0x6d9bf323] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving DSDT table memory at [mem 0x6d9b6250-0x6d9bf202] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving FACS table memory at [mem 0x6d9d4080-0x6d9d40bf] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving FPDT table memory at [mem 0x6d9bf330-0x6d9bf373] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving FIDT table memory at [mem 0x6d9bf380-0x6d9bf41b] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving MCFG table memory at [mem 0x6d9bf420-0x6d9bf45b] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving DBG2 table memory at [mem 0x6d9bf460-0x6d9bf4d1] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving DBGP table memory at [mem 0x6d9bf4e0-0x6d9bf513] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving HPET table memory at [mem 0x6d9bf520-0x6d9bf557] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving LPIT table memory at [mem 0x6d9bf560-0x6d9bf5bb] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving APIC table memory at [mem 0x6d9bf5c0-0x6d9bf643] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving NPKT table memory at [mem 0x6d9bf650-0x6d9bf6b4] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving PRAM table memory at [mem 0x6d9bf6c0-0x6d9bf6ef] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving WSMT table memory at [mem 0x6d9bf6f0-0x6d9bf717] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving SSDT table memory at [mem 0x6d9bf720-0x6d9c0272] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving SSDT table memory at [mem 0x6d9c0280-0x6d9c1968] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving AAFT table memory at [mem 0x6d9c1970-0x6d9c1c49] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving SSDT table memory at [mem 0x6d9c1c50-0x6d9c20f4] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving SSDT table memory at [mem 0x6d9c2100-0x6d9c282a] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving SSDT table memory at [mem 0x6d9c2830-0x6d9c2b5c] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving SSDT table memory at [mem 0x6d9c2b60-0x6d9c2cdb] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving SSDT table memory at [mem 0x6d9c2ce0-0x6d9c543f] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving UEFI table memory at [mem 0x6d9c5440-0x6d9c5481] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving BGRT table memory at [mem 0x6d9c5490-0x6d9c54c7] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving WDAT table memory at [mem 0x6d9c54d0-0x6d9c55d3] Mar 29 15:37:40 volumio-pc kernel: ACPI: Reserving NHLT table memory at [mem 0x6d9c55e0-0x6d9c702f] Mar 29 15:37:40 volumio-pc kernel: Zone ranges: Mar 29 15:37:40 volumio-pc kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Mar 29 15:37:40 volumio-pc kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Mar 29 15:37:40 volumio-pc kernel: Normal [mem 0x0000000100000000-0x000000027fffffff] Mar 29 15:37:40 volumio-pc kernel: Movable zone start for each node Mar 29 15:37:40 volumio-pc kernel: Early memory node ranges Mar 29 15:37:40 volumio-pc kernel: node 0: [mem 0x0000000000001000-0x000000000003efff] Mar 29 15:37:40 volumio-pc kernel: node 0: [mem 0x0000000000040000-0x000000000009efff] Mar 29 15:37:40 volumio-pc kernel: node 0: [mem 0x0000000000100000-0x000000000fffffff] Mar 29 15:37:40 volumio-pc kernel: node 0: [mem 0x0000000012151000-0x000000006b4e0fff] Mar 29 15:37:40 volumio-pc kernel: node 0: [mem 0x000000006d5da000-0x000000006d6b0fff] Mar 29 15:37:40 volumio-pc kernel: node 0: [mem 0x000000006ddd7000-0x000000006e14ffff] Mar 29 15:37:40 volumio-pc kernel: node 0: [mem 0x000000006e17b000-0x000000006e755fff] Mar 29 15:37:40 volumio-pc kernel: node 0: [mem 0x000000006e758000-0x000000006effffff] Mar 29 15:37:40 volumio-pc kernel: node 0: [mem 0x0000000100000000-0x000000027fffffff] Mar 29 15:37:40 volumio-pc kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000027fffffff] Mar 29 15:37:40 volumio-pc kernel: On node 0, zone DMA: 1 pages in unavailable ranges Mar 29 15:37:40 volumio-pc kernel: On node 0, zone DMA: 1 pages in unavailable ranges Mar 29 15:37:40 volumio-pc kernel: On node 0, zone DMA: 97 pages in unavailable ranges Mar 29 15:37:40 volumio-pc kernel: On node 0, zone DMA32: 8529 pages in unavailable ranges Mar 29 15:37:40 volumio-pc kernel: On node 0, zone DMA32: 8441 pages in unavailable ranges Mar 29 15:37:40 volumio-pc kernel: On node 0, zone DMA32: 1830 pages in unavailable ranges Mar 29 15:37:40 volumio-pc kernel: On node 0, zone DMA32: 43 pages in unavailable ranges Mar 29 15:37:40 volumio-pc kernel: On node 0, zone DMA32: 2 pages in unavailable ranges Mar 29 15:37:40 volumio-pc kernel: On node 0, zone Normal: 4096 pages in unavailable ranges Mar 29 15:37:40 volumio-pc kernel: Reserving Intel graphics memory at [mem 0x70000000-0x7fffffff] Mar 29 15:37:40 volumio-pc kernel: ACPI: PM-Timer IO Port: 0x408 Mar 29 15:37:40 volumio-pc kernel: ACPI: LAPIC_NMI (acpi_id[0x01] high level lint[0x1]) Mar 29 15:37:40 volumio-pc kernel: ACPI: LAPIC_NMI (acpi_id[0x02] high level lint[0x1]) Mar 29 15:37:40 volumio-pc kernel: ACPI: LAPIC_NMI (acpi_id[0x03] high level lint[0x1]) Mar 29 15:37:40 volumio-pc kernel: ACPI: LAPIC_NMI (acpi_id[0x04] high level lint[0x1]) Mar 29 15:37:40 volumio-pc kernel: IOAPIC[0]: apic_id 1, version 32, address 0xfec00000, GSI 0-119 Mar 29 15:37:40 volumio-pc kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Mar 29 15:37:40 volumio-pc kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 low level) Mar 29 15:37:40 volumio-pc kernel: ACPI: Using ACPI (MADT) for SMP configuration information Mar 29 15:37:40 volumio-pc kernel: ACPI: HPET id: 0x8086a701 base: 0xfed00000 Mar 29 15:37:40 volumio-pc kernel: e820: update [mem 0x69980000-0x699c0fff] usable ==> reserved Mar 29 15:37:40 volumio-pc kernel: TSC deadline timer available Mar 29 15:37:40 volumio-pc kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x0003f000-0x0003ffff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x10000000-0x12150fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x69980000-0x699c0fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x6b4e1000-0x6d5d9fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x6d6b1000-0x6d9d4fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x6d9d5000-0x6dd77fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x6dd78000-0x6ddd6fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x6e150000-0x6e150fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x6e151000-0x6e17afff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x6e756000-0x6e757fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x6f000000-0x7fffffff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0x80000000-0xfe041fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0xfe042000-0xfe044fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0xfe045000-0xfe8fffff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0xfe900000-0xfe902fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0xfe903000-0xfebfffff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0xfec00000-0xfec00fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0xfec01000-0xfed00fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0xfed01000-0xfed01fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0xfed02000-0xfedfffff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0xfee00000-0xfee00fff] Mar 29 15:37:40 volumio-pc kernel: PM: hibernation: Registered nosave memory: [mem 0xfee01000-0xffffffff] Mar 29 15:37:40 volumio-pc kernel: [mem 0x80000000-0xfe041fff] available for PCI devices Mar 29 15:37:40 volumio-pc kernel: Booting paravirtualized kernel on bare hardware Mar 29 15:37:40 volumio-pc kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Mar 29 15:37:40 volumio-pc kernel: setup_percpu: NR_CPUS:8 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Mar 29 15:37:40 volumio-pc kernel: percpu: Embedded 56 pages/cpu s191400 r8192 d29784 u524288 Mar 29 15:37:40 volumio-pc kernel: pcpu-alloc: s191400 r8192 d29784 u524288 alloc=1*2097152 Mar 29 15:37:40 volumio-pc kernel: pcpu-alloc: [0] 0 1 2 3 Mar 29 15:37:40 volumio-pc kernel: Kernel command line: BOOT_IMAGE=/vmlinuz biosdevname=0 splash plymouth.ignore-serial-consoles quiet ro rootwait imgpart=UUID=f9f7c575-874e-43ef-a723-80ec9af506d0 bootpart=UUID=6F6B-311A datapart=UUID=5e594c75-cc80-4bc2-957a-50cc329bdaa4 imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor use_kmsg=yes net.ifnames=0 loglevel=0 Mar 29 15:37:40 volumio-pc kernel: Unknown kernel command line parameters "splash BOOT_IMAGE=/vmlinuz biosdevname=0 imgpart=UUID=f9f7c575-874e-43ef-a723-80ec9af506d0 bootpart=UUID=6F6B-311A datapart=UUID=5e594c75-cc80-4bc2-957a-50cc329bdaa4 imgfile=/volumio_current.sqsh use_kmsg=yes", will be passed to user space. Mar 29 15:37:40 volumio-pc kernel: random: crng init done Mar 29 15:37:40 volumio-pc kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: Built 1 zonelists, mobility grouping on. Total pages: 1977033 Mar 29 15:37:40 volumio-pc kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Mar 29 15:37:40 volumio-pc kernel: software IO TLB: area num 4. Mar 29 15:37:40 volumio-pc kernel: Memory: 7641132K/8034304K available (14336K kernel code, 1874K rwdata, 4632K rodata, 2960K init, 1184K bss, 392916K reserved, 0K cma-reserved) Mar 29 15:37:40 volumio-pc kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Mar 29 15:37:40 volumio-pc kernel: Kernel/User page tables isolation: enabled Mar 29 15:37:40 volumio-pc kernel: ftrace: allocating 40414 entries in 158 pages Mar 29 15:37:40 volumio-pc kernel: ftrace: allocated 158 pages with 5 groups Mar 29 15:37:40 volumio-pc kernel: Dynamic Preempt: voluntary Mar 29 15:37:40 volumio-pc kernel: rcu: Preemptible hierarchical RCU implementation. Mar 29 15:37:40 volumio-pc kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Mar 29 15:37:40 volumio-pc kernel: Trampoline variant of Tasks RCU enabled. Mar 29 15:37:40 volumio-pc kernel: Rude variant of Tasks RCU enabled. Mar 29 15:37:40 volumio-pc kernel: Tracing variant of Tasks RCU enabled. Mar 29 15:37:40 volumio-pc kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Mar 29 15:37:40 volumio-pc kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Mar 29 15:37:40 volumio-pc kernel: NR_IRQS: 4352, nr_irqs: 1024, preallocated irqs: 16 Mar 29 15:37:40 volumio-pc kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Mar 29 15:37:40 volumio-pc kernel: Console: colour dummy device 80x25 Mar 29 15:37:40 volumio-pc kernel: printk: console [tty0] enabled Mar 29 15:37:40 volumio-pc kernel: ACPI: Core revision 20230628 Mar 29 15:37:40 volumio-pc kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 99544814920 ns Mar 29 15:37:40 volumio-pc kernel: APIC: Switch to symmetric I/O mode setup Mar 29 15:37:40 volumio-pc kernel: x2apic: IRQ remapping doesn't support X2APIC mode Mar 29 15:37:40 volumio-pc kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Mar 29 15:37:40 volumio-pc kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x159647815e3, max_idle_ns: 440795269835 ns Mar 29 15:37:40 volumio-pc kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2995.20 BogoMIPS (lpj=5990400) Mar 29 15:37:40 volumio-pc kernel: CPU0: Thermal monitoring enabled (TM1) Mar 29 15:37:40 volumio-pc kernel: Last level iTLB entries: 4KB 48, 2MB 0, 4MB 0 Mar 29 15:37:40 volumio-pc kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Mar 29 15:37:40 volumio-pc kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Mar 29 15:37:40 volumio-pc kernel: Spectre V2 : Mitigation: Retpolines Mar 29 15:37:40 volumio-pc kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Mar 29 15:37:40 volumio-pc kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Mar 29 15:37:40 volumio-pc kernel: Speculative Store Bypass: Vulnerable Mar 29 15:37:40 volumio-pc kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Mar 29 15:37:40 volumio-pc kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Mar 29 15:37:40 volumio-pc kernel: x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers' Mar 29 15:37:40 volumio-pc kernel: x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR' Mar 29 15:37:40 volumio-pc kernel: x86/fpu: xstate_offset[3]: 576, xstate_sizes[3]: 64 Mar 29 15:37:40 volumio-pc kernel: x86/fpu: xstate_offset[4]: 640, xstate_sizes[4]: 64 Mar 29 15:37:40 volumio-pc kernel: x86/fpu: Enabled xstate features 0x1b, context size is 704 bytes, using 'compacted' format. Mar 29 15:37:40 volumio-pc kernel: Freeing SMP alternatives memory: 32K Mar 29 15:37:40 volumio-pc kernel: pid_max: default: 32768 minimum: 301 Mar 29 15:37:40 volumio-pc kernel: LSM: initializing lsm=capability,yama,integrity Mar 29 15:37:40 volumio-pc kernel: Yama: becoming mindful. Mar 29 15:37:40 volumio-pc kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: smpboot: CPU0: Intel(R) Pentium(R) CPU J4205 @ 1.50GHz (family: 0x6, model: 0x5c, stepping: 0x9) Mar 29 15:37:40 volumio-pc kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Mar 29 15:37:40 volumio-pc kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Mar 29 15:37:40 volumio-pc kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Mar 29 15:37:40 volumio-pc kernel: Performance Events: PEBS fmt3+, Goldmont events, 32-deep LBR, full-width counters, Intel PMU driver. Mar 29 15:37:40 volumio-pc kernel: ... version: 4 Mar 29 15:37:40 volumio-pc kernel: ... bit width: 48 Mar 29 15:37:40 volumio-pc kernel: ... generic registers: 4 Mar 29 15:37:40 volumio-pc kernel: ... value mask: 0000ffffffffffff Mar 29 15:37:40 volumio-pc kernel: ... max period: 00007fffffffffff Mar 29 15:37:40 volumio-pc kernel: ... fixed-purpose events: 3 Mar 29 15:37:40 volumio-pc kernel: ... event mask: 000000070000000f Mar 29 15:37:40 volumio-pc kernel: signal: max sigframe size: 2032 Mar 29 15:37:40 volumio-pc kernel: Estimated ratio of average max frequency by base frequency (times 1024): 1774 Mar 29 15:37:40 volumio-pc kernel: rcu: Hierarchical SRCU implementation. Mar 29 15:37:40 volumio-pc kernel: rcu: Max phase no-delay instances is 1000. Mar 29 15:37:40 volumio-pc kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. Mar 29 15:37:40 volumio-pc kernel: smp: Bringing up secondary CPUs ... Mar 29 15:37:40 volumio-pc kernel: smpboot: x86: Booting SMP configuration: Mar 29 15:37:40 volumio-pc kernel: .... node #0, CPUs: #1 #2 #3 Mar 29 15:37:40 volumio-pc kernel: smp: Brought up 1 node, 4 CPUs Mar 29 15:37:40 volumio-pc kernel: smpboot: Max logical packages: 1 Mar 29 15:37:40 volumio-pc kernel: smpboot: Total of 4 processors activated (11980.80 BogoMIPS) Mar 29 15:37:40 volumio-pc kernel: devtmpfs: initialized Mar 29 15:37:40 volumio-pc kernel: x86/mm: Memory block size: 128MB Mar 29 15:37:40 volumio-pc kernel: ACPI: PM: Registering ACPI NVS region [mem 0x6d6b1000-0x6d9d4fff] (3293184 bytes) Mar 29 15:37:40 volumio-pc kernel: ACPI: PM: Registering ACPI NVS region [mem 0x6e150000-0x6e150fff] (4096 bytes) Mar 29 15:37:40 volumio-pc kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Mar 29 15:37:40 volumio-pc kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: pinctrl core: initialized pinctrl subsystem Mar 29 15:37:40 volumio-pc kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Mar 29 15:37:40 volumio-pc kernel: audit: initializing netlink subsys (disabled) Mar 29 15:37:40 volumio-pc kernel: audit: type=2000 audit(1711723044.064:1): state=initialized audit_enabled=0 res=1 Mar 29 15:37:40 volumio-pc kernel: thermal_sys: Registered thermal governor 'fair_share' Mar 29 15:37:40 volumio-pc kernel: thermal_sys: Registered thermal governor 'bang_bang' Mar 29 15:37:40 volumio-pc kernel: thermal_sys: Registered thermal governor 'step_wise' Mar 29 15:37:40 volumio-pc kernel: thermal_sys: Registered thermal governor 'user_space' Mar 29 15:37:40 volumio-pc kernel: EISA bus registered Mar 29 15:37:40 volumio-pc kernel: cpuidle: using governor ladder Mar 29 15:37:40 volumio-pc kernel: cpuidle: using governor menu Mar 29 15:37:40 volumio-pc kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Mar 29 15:37:40 volumio-pc kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Mar 29 15:37:40 volumio-pc kernel: PCI: not using MMCONFIG Mar 29 15:37:40 volumio-pc kernel: PCI: Using configuration type 1 for base access Mar 29 15:37:40 volumio-pc kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Mar 29 15:37:40 volumio-pc kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Mar 29 15:37:40 volumio-pc kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Mar 29 15:37:40 volumio-pc kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Mar 29 15:37:40 volumio-pc kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Mar 29 15:37:40 volumio-pc kernel: ACPI: Added _OSI(Module Device) Mar 29 15:37:40 volumio-pc kernel: ACPI: Added _OSI(Processor Device) Mar 29 15:37:40 volumio-pc kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Mar 29 15:37:40 volumio-pc kernel: ACPI: Added _OSI(Processor Aggregator Device) Mar 29 15:37:40 volumio-pc kernel: ACPI: 8 ACPI AML tables successfully acquired and loaded Mar 29 15:37:40 volumio-pc kernel: ACPI: Dynamic OEM Table Load: Mar 29 15:37:40 volumio-pc kernel: ACPI: SSDT 0xFFFF888100BD4000 000102 (v02 PmRef Cpu0Cst 00003001 INTL 20120913) Mar 29 15:37:40 volumio-pc kernel: ACPI: Dynamic OEM Table Load: Mar 29 15:37:40 volumio-pc kernel: ACPI: SSDT 0xFFFF888100BD4200 00015F (v02 PmRef ApIst 00003000 INTL 20120913) Mar 29 15:37:40 volumio-pc kernel: ACPI: Dynamic OEM Table Load: Mar 29 15:37:40 volumio-pc kernel: ACPI: SSDT 0xFFFF8881009DB000 00008D (v02 PmRef ApCst 00003000 INTL 20120913) Mar 29 15:37:40 volumio-pc kernel: ACPI: _OSC evaluated successfully for all CPUs Mar 29 15:37:40 volumio-pc kernel: ACPI: Interpreter enabled Mar 29 15:37:40 volumio-pc kernel: ACPI: PM: (supports S0 S3 S4 S5) Mar 29 15:37:40 volumio-pc kernel: ACPI: Using IOAPIC for interrupt routing Mar 29 15:37:40 volumio-pc kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Mar 29 15:37:40 volumio-pc kernel: PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved as ACPI motherboard resource Mar 29 15:37:40 volumio-pc kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Mar 29 15:37:40 volumio-pc kernel: PCI: Using E820 reservations for host bridge windows Mar 29 15:37:40 volumio-pc kernel: ACPI: Enabled 8 GPEs in block 00 to 7F Mar 29 15:37:40 volumio-pc kernel: ACPI: \_TZ_.FN00: New power resource Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Mar 29 15:37:40 volumio-pc kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Mar 29 15:37:40 volumio-pc kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug SHPCHotplug PME AER PCIeCapability LTR] Mar 29 15:37:40 volumio-pc kernel: PCI host bridge to bus 0000:00 Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: root bus resource [io 0x0070-0x0077] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x006f window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: root bus resource [io 0x0078-0x0cf7 window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000fffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: root bus resource [mem 0x70000001-0x7fffffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: root bus resource [mem 0x6f800001-0x6fffffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xcfffffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: root bus resource [mem 0xe0000000-0xefffffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:00.0: [8086:5af0] type 00 class 0x060000 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:02.0: [8086:5a84] type 00 class 0x030000 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:02.0: reg 0x10: [mem 0x90000000-0x90ffffff 64bit] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:02.0: reg 0x18: [mem 0x80000000-0x8fffffff 64bit pref] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:02.0: reg 0x20: [io 0xf000-0xf03f] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:02.0: BAR 2: assigned to efifb Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:0e.0: [8086:5a98] type 00 class 0x040300 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:0e.0: reg 0x10: [mem 0x91310000-0x91313fff 64bit] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:0e.0: reg 0x20: [mem 0x91000000-0x910fffff 64bit] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:0e.0: PME# supported from D0 D3hot D3cold Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:0f.0: [8086:5a9a] type 00 class 0x078000 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:0f.0: reg 0x10: [mem 0x9131b000-0x9131bfff 64bit] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:0f.0: PME# supported from D3hot Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:12.0: [8086:5ae3] type 00 class 0x010601 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:12.0: reg 0x10: [mem 0x91314000-0x91315fff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:12.0: reg 0x14: [mem 0x91318000-0x913180ff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:12.0: reg 0x18: [io 0xf090-0xf097] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:12.0: reg 0x1c: [io 0xf080-0xf083] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:12.0: reg 0x20: [io 0xf060-0xf07f] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:12.0: reg 0x24: [mem 0x91317000-0x913177ff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:12.0: PME# supported from D3hot Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.0: [8086:5ad8] type 01 class 0x060400 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.0: PME# supported from D0 D3hot D3cold Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.1: [8086:5ad9] type 01 class 0x060400 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.1: PME# supported from D0 D3hot D3cold Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.2: [8086:5ada] type 01 class 0x060400 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.2: PME# supported from D0 D3hot D3cold Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.3: [8086:5adb] type 01 class 0x060400 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.3: PME# supported from D0 D3hot D3cold Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:15.0: [8086:5aa8] type 00 class 0x0c0330 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:15.0: reg 0x10: [mem 0x91300000-0x9130ffff 64bit] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:15.0: PME# supported from D3hot D3cold Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:1f.0: [8086:5ae8] type 00 class 0x060100 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:1f.1: [8086:5ad4] type 00 class 0x0c0500 Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:1f.1: reg 0x10: [mem 0x91316000-0x913160ff 64bit] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:1f.1: reg 0x20: [io 0xf040-0xf05f] Mar 29 15:37:40 volumio-pc kernel: pci 0000:01:00.0: [10ec:8168] type 00 class 0x020000 Mar 29 15:37:40 volumio-pc kernel: pci 0000:01:00.0: reg 0x10: [io 0xe000-0xe0ff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:01:00.0: reg 0x18: [mem 0x91204000-0x91204fff 64bit] Mar 29 15:37:40 volumio-pc kernel: pci 0000:01:00.0: reg 0x20: [mem 0x91200000-0x91203fff 64bit pref] Mar 29 15:37:40 volumio-pc kernel: pci 0000:01:00.0: Upstream bridge's Max Payload Size set to 128 (was 256, max 256) Mar 29 15:37:40 volumio-pc kernel: pci 0000:01:00.0: Max Payload Size set to 128 (was 128, max 128) Mar 29 15:37:40 volumio-pc kernel: pci 0000:01:00.0: supports D1 D2 Mar 29 15:37:40 volumio-pc kernel: pci 0000:01:00.0: PME# supported from D0 D1 D2 D3hot D3cold Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.0: PCI bridge to [bus 01] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.0: bridge window [io 0xe000-0xefff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.0: bridge window [mem 0x91200000-0x912fffff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.1: PCI bridge to [bus 02] Mar 29 15:37:40 volumio-pc kernel: pci 0000:03:00.0: [1b21:0612] type 00 class 0x010601 Mar 29 15:37:40 volumio-pc kernel: pci 0000:03:00.0: reg 0x10: [io 0xd050-0xd057] Mar 29 15:37:40 volumio-pc kernel: pci 0000:03:00.0: reg 0x14: [io 0xd040-0xd043] Mar 29 15:37:40 volumio-pc kernel: pci 0000:03:00.0: reg 0x18: [io 0xd030-0xd037] Mar 29 15:37:40 volumio-pc kernel: pci 0000:03:00.0: reg 0x1c: [io 0xd020-0xd023] Mar 29 15:37:40 volumio-pc kernel: pci 0000:03:00.0: reg 0x20: [io 0xd000-0xd01f] Mar 29 15:37:40 volumio-pc kernel: pci 0000:03:00.0: reg 0x24: [mem 0x91100000-0x911001ff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.2: PCI bridge to [bus 03] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.2: bridge window [io 0xd000-0xdfff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.2: bridge window [mem 0x91100000-0x911fffff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.3: PCI bridge to [bus 04] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: on NUMA node 0 Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 15 Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKA disabled Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 15 Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKB disabled Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 15 Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKC disabled Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 15 Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKD disabled Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 15 Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKE disabled Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 15 Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKF disabled Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 15 Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKG disabled Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 15 Mar 29 15:37:40 volumio-pc kernel: ACPI: PCI: Interrupt link LNKH disabled Mar 29 15:37:40 volumio-pc kernel: iommu: Default domain type: Translated Mar 29 15:37:40 volumio-pc kernel: iommu: DMA domain TLB invalidation policy: lazy mode Mar 29 15:37:40 volumio-pc kernel: SCSI subsystem initialized Mar 29 15:37:40 volumio-pc kernel: libata version 3.00 loaded. Mar 29 15:37:40 volumio-pc kernel: ACPI: bus type USB registered Mar 29 15:37:40 volumio-pc kernel: usbcore: registered new interface driver usbfs Mar 29 15:37:40 volumio-pc kernel: usbcore: registered new interface driver hub Mar 29 15:37:40 volumio-pc kernel: usbcore: registered new device driver usb Mar 29 15:37:40 volumio-pc kernel: efivars: Registered efivars operations Mar 29 15:37:40 volumio-pc kernel: PCI: Using ACPI for IRQ routing Mar 29 15:37:40 volumio-pc kernel: PCI: pci_cache_line_size set to 64 bytes Mar 29 15:37:40 volumio-pc kernel: e820: reserve RAM buffer [mem 0x0003f000-0x0003ffff] Mar 29 15:37:40 volumio-pc kernel: e820: reserve RAM buffer [mem 0x0009f000-0x0009ffff] Mar 29 15:37:40 volumio-pc kernel: e820: reserve RAM buffer [mem 0x69980000-0x6bffffff] Mar 29 15:37:40 volumio-pc kernel: e820: reserve RAM buffer [mem 0x6b4e1000-0x6bffffff] Mar 29 15:37:40 volumio-pc kernel: e820: reserve RAM buffer [mem 0x6d6b1000-0x6fffffff] Mar 29 15:37:40 volumio-pc kernel: e820: reserve RAM buffer [mem 0x6e150000-0x6fffffff] Mar 29 15:37:40 volumio-pc kernel: e820: reserve RAM buffer [mem 0x6e756000-0x6fffffff] Mar 29 15:37:40 volumio-pc kernel: e820: reserve RAM buffer [mem 0x6f000000-0x6fffffff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:02.0: vgaarb: bridge control possible Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Mar 29 15:37:40 volumio-pc kernel: vgaarb: loaded Mar 29 15:37:40 volumio-pc kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0 Mar 29 15:37:40 volumio-pc kernel: hpet0: 8 comparators, 64-bit 19.200000 MHz counter Mar 29 15:37:40 volumio-pc kernel: clocksource: Switched to clocksource tsc-early Mar 29 15:37:40 volumio-pc kernel: VFS: Disk quotas dquot_6.6.0 Mar 29 15:37:40 volumio-pc kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Mar 29 15:37:40 volumio-pc kernel: pnp: PnP ACPI init Mar 29 15:37:40 volumio-pc kernel: system 00:00: [io 0x0280-0x028f] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:00: [io 0x0290-0x029f] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:00: [io 0x02a0-0x02af] has been reserved Mar 29 15:37:40 volumio-pc kernel: pnp 00:01: [dma 0 disabled] Mar 29 15:37:40 volumio-pc kernel: system 00:03: [io 0x0680-0x069f] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:03: [io 0x0400-0x047f] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:03: [io 0x0500-0x05fe] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:04: [mem 0xe0000000-0xefffffff] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:04: [mem 0xfea00000-0xfeafffff] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:04: [mem 0xfed01000-0xfed01fff] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:04: [mem 0xfed03000-0xfed03fff] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:04: [mem 0xfed06000-0xfed06fff] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:04: [mem 0xfed08000-0xfed09fff] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:04: [mem 0xfed80000-0xfedbffff] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:04: [mem 0xfed1c000-0xfed1cfff] has been reserved Mar 29 15:37:40 volumio-pc kernel: system 00:04: [mem 0xfee00000-0xfeefffff] could not be reserved Mar 29 15:37:40 volumio-pc kernel: pnp: PnP ACPI: found 6 devices Mar 29 15:37:40 volumio-pc kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Mar 29 15:37:40 volumio-pc kernel: NET: Registered PF_INET protocol family Mar 29 15:37:40 volumio-pc kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: TCP: Hash tables configured (established 65536 bind 65536) Mar 29 15:37:40 volumio-pc kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) Mar 29 15:37:40 volumio-pc kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.0: PCI bridge to [bus 01] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.0: bridge window [io 0xe000-0xefff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.0: bridge window [mem 0x91200000-0x912fffff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.1: PCI bridge to [bus 02] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.2: PCI bridge to [bus 03] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.2: bridge window [io 0xd000-0xdfff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.2: bridge window [mem 0x91100000-0x911fffff] Mar 29 15:37:40 volumio-pc kernel: pci 0000:00:13.3: PCI bridge to [bus 04] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: resource 4 [io 0x0070-0x0077] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: resource 5 [io 0x0000-0x006f window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: resource 6 [io 0x0078-0x0cf7 window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: resource 7 [io 0x0d00-0xffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: resource 8 [mem 0x000a0000-0x000fffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: resource 9 [mem 0x70000001-0x7fffffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: resource 10 [mem 0x6f800001-0x6fffffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: resource 11 [mem 0x80000000-0xcfffffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:00: resource 12 [mem 0xe0000000-0xefffffff window] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:01: resource 0 [io 0xe000-0xefff] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:01: resource 1 [mem 0x91200000-0x912fffff] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:03: resource 0 [io 0xd000-0xdfff] Mar 29 15:37:40 volumio-pc kernel: pci_bus 0000:03: resource 1 [mem 0x91100000-0x911fffff] Mar 29 15:37:40 volumio-pc kernel: PCI: CLS 0 bytes, default 64 Mar 29 15:37:40 volumio-pc kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Mar 29 15:37:40 volumio-pc kernel: software IO TLB: mapped [mem 0x0000000062add000-0x0000000066add000] (64MB) Mar 29 15:37:40 volumio-pc kernel: Trying to unpack rootfs image as initramfs... Mar 29 15:37:40 volumio-pc kernel: RAPL PMU: API unit is 2^-32 Joules, 4 fixed counters, 655360 ms ovfl timer Mar 29 15:37:40 volumio-pc kernel: RAPL PMU: hw unit of domain pp0-core 2^-14 Joules Mar 29 15:37:40 volumio-pc kernel: RAPL PMU: hw unit of domain package 2^-14 Joules Mar 29 15:37:40 volumio-pc kernel: RAPL PMU: hw unit of domain dram 2^-14 Joules Mar 29 15:37:40 volumio-pc kernel: RAPL PMU: hw unit of domain pp1-gpu 2^-14 Joules Mar 29 15:37:40 volumio-pc kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x159647815e3, max_idle_ns: 440795269835 ns Mar 29 15:37:40 volumio-pc kernel: clocksource: Switched to clocksource tsc Mar 29 15:37:40 volumio-pc kernel: Initialise system trusted keyrings Mar 29 15:37:40 volumio-pc kernel: workingset: timestamp_bits=46 max_order=21 bucket_order=0 Mar 29 15:37:40 volumio-pc kernel: zbud: loaded Mar 29 15:37:40 volumio-pc kernel: Key type asymmetric registered Mar 29 15:37:40 volumio-pc kernel: Asymmetric key parser 'x509' registered Mar 29 15:37:40 volumio-pc kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) Mar 29 15:37:40 volumio-pc kernel: io scheduler mq-deadline registered Mar 29 15:37:40 volumio-pc kernel: io scheduler kyber registered Mar 29 15:37:40 volumio-pc kernel: pcieport 0000:00:13.0: PME: Signaling with IRQ 120 Mar 29 15:37:40 volumio-pc kernel: pcieport 0000:00:13.1: PME: Signaling with IRQ 121 Mar 29 15:37:40 volumio-pc kernel: pcieport 0000:00:13.2: PME: Signaling with IRQ 122 Mar 29 15:37:40 volumio-pc kernel: pcieport 0000:00:13.3: PME: Signaling with IRQ 123 Mar 29 15:37:40 volumio-pc kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Mar 29 15:37:40 volumio-pc kernel: efifb: probing for efifb Mar 29 15:37:40 volumio-pc kernel: efifb: framebuffer at 0x80000000, using 8128k, total 8128k Mar 29 15:37:40 volumio-pc kernel: efifb: mode is 1920x1080x32, linelength=7680, pages=1 Mar 29 15:37:40 volumio-pc kernel: efifb: scrolling: redraw Mar 29 15:37:40 volumio-pc kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Mar 29 15:37:40 volumio-pc kernel: Console: switching to colour frame buffer device 240x67 Mar 29 15:37:40 volumio-pc kernel: fb0: EFI VGA frame buffer device Mar 29 15:37:40 volumio-pc kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Mar 29 15:37:40 volumio-pc kernel: ACPI: button: Power Button [PWRB] Mar 29 15:37:40 volumio-pc kernel: thermal LNXTHERM:00: registered as thermal_zone0 Mar 29 15:37:40 volumio-pc kernel: ACPI: thermal: Thermal Zone [TZ01] (37 C) Mar 29 15:37:40 volumio-pc kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Mar 29 15:37:40 volumio-pc kernel: 00:01: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Mar 29 15:37:40 volumio-pc kernel: Linux agpgart interface v0.103 Mar 29 15:37:40 volumio-pc kernel: xhci_hcd 0000:00:15.0: xHCI Host Controller Mar 29 15:37:40 volumio-pc kernel: xhci_hcd 0000:00:15.0: new USB bus registered, assigned bus number 1 Mar 29 15:37:40 volumio-pc kernel: xhci_hcd 0000:00:15.0: hcc params 0x200077c1 hci version 0x100 quirks 0x0000000081109810 Mar 29 15:37:40 volumio-pc kernel: xhci_hcd 0000:00:15.0: xHCI Host Controller Mar 29 15:37:40 volumio-pc kernel: xhci_hcd 0000:00:15.0: new USB bus registered, assigned bus number 2 Mar 29 15:37:40 volumio-pc kernel: xhci_hcd 0000:00:15.0: Host supports USB 3.0 SuperSpeed Mar 29 15:37:40 volumio-pc kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Mar 29 15:37:40 volumio-pc kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 29 15:37:40 volumio-pc kernel: usb usb1: Product: xHCI Host Controller Mar 29 15:37:40 volumio-pc kernel: usb usb1: Manufacturer: Linux 6.6.7-volumio xhci-hcd Mar 29 15:37:40 volumio-pc kernel: usb usb1: SerialNumber: 0000:00:15.0 Mar 29 15:37:40 volumio-pc kernel: hub 1-0:1.0: USB hub found Mar 29 15:37:40 volumio-pc kernel: hub 1-0:1.0: 8 ports detected Mar 29 15:37:40 volumio-pc kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Mar 29 15:37:40 volumio-pc kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 29 15:37:40 volumio-pc kernel: usb usb2: Product: xHCI Host Controller Mar 29 15:37:40 volumio-pc kernel: usb usb2: Manufacturer: Linux 6.6.7-volumio xhci-hcd Mar 29 15:37:40 volumio-pc kernel: usb usb2: SerialNumber: 0000:00:15.0 Mar 29 15:37:40 volumio-pc kernel: hub 2-0:1.0: USB hub found Mar 29 15:37:40 volumio-pc kernel: hub 2-0:1.0: 7 ports detected Mar 29 15:37:40 volumio-pc kernel: i8042: PNP: No PS/2 controller found. Mar 29 15:37:40 volumio-pc kernel: mousedev: PS/2 mouse device common for all mice Mar 29 15:37:40 volumio-pc kernel: rtc_cmos 00:05: RTC can wake from S4 Mar 29 15:37:40 volumio-pc kernel: rtc_cmos 00:05: registered as rtc0 Mar 29 15:37:40 volumio-pc kernel: rtc_cmos 00:05: setting system clock to 2024-03-29T14:37:24 UTC (1711723044) Mar 29 15:37:40 volumio-pc kernel: rtc_cmos 00:05: alarms up to one month, y3k, 242 bytes nvram Mar 29 15:37:40 volumio-pc kernel: i2c_dev: i2c /dev entries driver Mar 29 15:37:40 volumio-pc kernel: platform eisa.0: Probing EISA bus 0 Mar 29 15:37:40 volumio-pc kernel: platform eisa.0: EISA: Cannot allocate resource for mainboard Mar 29 15:37:40 volumio-pc kernel: intel_pstate: Intel P-state driver initializing Mar 29 15:37:40 volumio-pc kernel: ledtrig-cpu: registered to indicate activity on CPUs Mar 29 15:37:40 volumio-pc kernel: NET: Registered PF_INET6 protocol family Mar 29 15:37:40 volumio-pc kernel: Segment Routing with IPv6 Mar 29 15:37:40 volumio-pc kernel: In-situ OAM (IOAM) with IPv6 Mar 29 15:37:40 volumio-pc kernel: mip6: Mobile IPv6 Mar 29 15:37:40 volumio-pc kernel: NET: Registered PF_PACKET protocol family Mar 29 15:37:40 volumio-pc kernel: mpls_gso: MPLS GSO support Mar 29 15:37:40 volumio-pc kernel: mce: [Hardware Error]: Machine check events logged Mar 29 15:37:40 volumio-pc kernel: mce: [Hardware Error]: CPU 0: Machine Check: 0 Bank 4: a600000000020408 Mar 29 15:37:40 volumio-pc kernel: mce: [Hardware Error]: TSC 0 ADDR fef13b80 Mar 29 15:37:40 volumio-pc kernel: mce: [Hardware Error]: PROCESSOR 0:506c9 TIME 1711723044 SOCKET 0 APIC 0 microcode 1e Mar 29 15:37:40 volumio-pc kernel: microcode: Microcode Update Driver: v2.2. Mar 29 15:37:40 volumio-pc kernel: IPI shorthand broadcast: enabled Mar 29 15:37:40 volumio-pc kernel: sched_clock: Marking stable (384007261, 551079)->(388845867, -4287527) Mar 29 15:37:40 volumio-pc kernel: Loading compiled-in X.509 certificates Mar 29 15:37:40 volumio-pc kernel: clk: Disabling unused clocks Mar 29 15:37:40 volumio-pc kernel: usb 1-5: new high-speed USB device number 2 using xhci_hcd Mar 29 15:37:40 volumio-pc kernel: usb 1-5: New USB device found, idVendor=1a40, idProduct=0101, bcdDevice= 1.11 Mar 29 15:37:40 volumio-pc kernel: usb 1-5: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Mar 29 15:37:40 volumio-pc kernel: usb 1-5: Product: USB 2.0 Hub Mar 29 15:37:40 volumio-pc kernel: hub 1-5:1.0: USB hub found Mar 29 15:37:40 volumio-pc kernel: hub 1-5:1.0: 4 ports detected Mar 29 15:37:40 volumio-pc kernel: usb 1-5.2: new full-speed USB device number 3 using xhci_hcd Mar 29 15:37:40 volumio-pc kernel: usb 1-5.2: language id specifier not provided by device, defaulting to English Mar 29 15:37:40 volumio-pc kernel: usb 1-5.2: New USB device found, idVendor=0c45, idProduct=7403, bcdDevice= 0.01 Mar 29 15:37:40 volumio-pc kernel: usb 1-5.2: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Mar 29 15:37:40 volumio-pc kernel: Freeing initrd memory: 67448K Mar 29 15:37:40 volumio-pc kernel: Freeing unused kernel image (initmem) memory: 2960K Mar 29 15:37:40 volumio-pc kernel: Write protecting the kernel read-only data: 20480k Mar 29 15:37:40 volumio-pc kernel: Freeing unused kernel image (rodata/data gap) memory: 1512K Mar 29 15:37:40 volumio-pc kernel: Run /init as init process Mar 29 15:37:40 volumio-pc kernel: with arguments: Mar 29 15:37:40 volumio-pc kernel: /init Mar 29 15:37:40 volumio-pc kernel: splash Mar 29 15:37:40 volumio-pc kernel: with environment: Mar 29 15:37:40 volumio-pc kernel: HOME=/ Mar 29 15:37:40 volumio-pc kernel: TERM=linux Mar 29 15:37:40 volumio-pc kernel: BOOT_IMAGE=/vmlinuz Mar 29 15:37:40 volumio-pc kernel: biosdevname=0 Mar 29 15:37:40 volumio-pc kernel: imgpart=UUID=f9f7c575-874e-43ef-a723-80ec9af506d0 Mar 29 15:37:40 volumio-pc kernel: bootpart=UUID=6F6B-311A Mar 29 15:37:40 volumio-pc kernel: datapart=UUID=5e594c75-cc80-4bc2-957a-50cc329bdaa4 Mar 29 15:37:40 volumio-pc kernel: imgfile=/volumio_current.sqsh Mar 29 15:37:40 volumio-pc kernel: use_kmsg=yes Mar 29 15:37:40 volumio-pc kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 29 15:37:40 volumio-pc kernel: fuse: init (API version 7.39) Mar 29 15:37:40 volumio-pc kernel: sdhci: Secure Digital Host Controller Interface driver Mar 29 15:37:40 volumio-pc kernel: sdhci: Copyright(c) Pierre Ossman Mar 29 15:37:40 volumio-pc kernel: hid: raw HID events driver (C) Jiri Kosina Mar 29 15:37:40 volumio-pc kernel: usbcore: registered new interface driver usbhid Mar 29 15:37:40 volumio-pc kernel: usbhid: USB HID core driver Mar 29 15:37:40 volumio-pc kernel: input: HID 0c45:7403 as /devices/pci0000:00/0000:00:15.0/usb1/1-5/1-5.2/1-5.2:1.0/0003:0C45:7403.0001/input/input1 Mar 29 15:37:40 volumio-pc kernel: hid-generic 0003:0C45:7403.0001: input,hidraw0: USB HID v1.00 Keyboard [HID 0c45:7403] on usb-0000:00:15.0-5.2/input0 Mar 29 15:37:40 volumio-pc kernel: input: HID 0c45:7403 as /devices/pci0000:00/0000:00:15.0/usb1/1-5/1-5.2/1-5.2:1.1/0003:0C45:7403.0002/input/input2 Mar 29 15:37:40 volumio-pc kernel: hid-generic 0003:0C45:7403.0002: input,hidraw1: USB HID v1.10 Mouse [HID 0c45:7403] on usb-0000:00:15.0-5.2/input1 Mar 29 15:37:40 volumio-pc kernel: loop: module loaded Mar 29 15:37:40 volumio-pc kernel: usbcore: registered new interface driver usb-storage Mar 29 15:37:40 volumio-pc kernel: usbcore: registered new interface driver uas Mar 29 15:37:40 volumio-pc kernel: ahci 0000:00:12.0: version 3.0 Mar 29 15:37:40 volumio-pc kernel: ahci 0000:00:12.0: AHCI 0001.0301 32 slots 2 ports 6 Gbps 0x3 impl SATA mode Mar 29 15:37:40 volumio-pc kernel: ahci 0000:00:12.0: flags: 64bit ncq sntf clo only pmp pio slum part deso sadm sds apst Mar 29 15:37:40 volumio-pc kernel: scsi host0: ahci Mar 29 15:37:40 volumio-pc kernel: scsi host1: ahci Mar 29 15:37:40 volumio-pc kernel: ata1: SATA max UDMA/133 abar m2048@0x91317000 port 0x91317100 irq 125 Mar 29 15:37:40 volumio-pc kernel: ata2: SATA max UDMA/133 abar m2048@0x91317000 port 0x91317180 irq 125 Mar 29 15:37:40 volumio-pc kernel: ahci 0000:03:00.0: SSS flag set, parallel bus scan disabled Mar 29 15:37:40 volumio-pc kernel: ahci 0000:03:00.0: AHCI 0001.0200 32 slots 2 ports 6 Gbps 0x3 impl SATA mode Mar 29 15:37:40 volumio-pc kernel: ahci 0000:03:00.0: flags: 64bit ncq sntf stag led clo pmp pio slum part ccc Mar 29 15:37:40 volumio-pc kernel: scsi host2: ahci Mar 29 15:37:40 volumio-pc kernel: scsi host3: ahci Mar 29 15:37:40 volumio-pc kernel: ata3: SATA max UDMA/133 abar m512@0x91100000 port 0x91100100 irq 126 Mar 29 15:37:40 volumio-pc kernel: ata4: SATA max UDMA/133 abar m512@0x91100000 port 0x91100180 irq 126 Mar 29 15:37:40 volumio-pc kernel: ata2: SATA link down (SStatus 4 SControl 300) Mar 29 15:37:40 volumio-pc kernel: ata3: SATA link down (SStatus 0 SControl 300) Mar 29 15:37:40 volumio-pc kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) Mar 29 15:37:40 volumio-pc kernel: ata1.00: ATA-9: Dogfish SSD 32GB, S0221A0, max UDMA/133 Mar 29 15:37:40 volumio-pc kernel: ata1.00: 62533296 sectors, multi 1: LBA48 NCQ (depth 32), AA Mar 29 15:37:40 volumio-pc kernel: ata1.00: configured for UDMA/133 Mar 29 15:37:40 volumio-pc kernel: scsi 0:0:0:0: Direct-Access ATA Dogfish SSD 32GB 1A0 PQ: 0 ANSI: 5 Mar 29 15:37:40 volumio-pc kernel: sd 0:0:0:0: [sda] 62533296 512-byte logical blocks: (32.0 GB/29.8 GiB) Mar 29 15:37:40 volumio-pc kernel: sd 0:0:0:0: [sda] Write Protect is off Mar 29 15:37:40 volumio-pc kernel: sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 Mar 29 15:37:40 volumio-pc kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Mar 29 15:37:40 volumio-pc kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 512 bytes Mar 29 15:37:40 volumio-pc kernel: sda: sda1 sda2 sda3 Mar 29 15:37:40 volumio-pc kernel: sd 0:0:0:0: [sda] Attached SCSI disk Mar 29 15:37:40 volumio-pc kernel: ata4: SATA link down (SStatus 0 SControl 300) Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: IMGPART=/dev/sda2 Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: IMGFILE=/volumio_current.sqsh Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: BOOTPART=/dev/sda1 Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: DATAPART=/dev/sda3 Mar 29 15:37:40 volumio-pc kernel: EXT4-fs (sda2): recovery complete Mar 29 15:37:40 volumio-pc kernel: EXT4-fs (sda2): mounted filesystem f9f7c575-874e-43ef-a723-80ec9af506d0 r/w with ordered data mode. Quota mode: none. Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: GPTSIZEMISMATCH: Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: Doing a 5 second delay here to give kernel load a headstart Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: Checking for a volumio rootfs update on a USB device Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: Checking for factory reset on a USB device Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: Checking for factory or user-data reset on boot device Mar 29 15:37:40 volumio-pc kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Mar 29 15:37:40 volumio-pc kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Mar 29 15:37:40 volumio-pc kernel: loop0: detected capacity change from 0 to 1658552 Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: Volumio version 3.634 Mar 29 15:37:40 volumio-pc kernel: EXT4-fs (sda3): recovery complete Mar 29 15:37:40 volumio-pc kernel: EXT4-fs (sda3): mounted filesystem 5e594c75-cc80-4bc2-957a-50cc329bdaa4 r/w with ordered data mode. Quota mode: none. Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: Checking if fstab needs to be updated.. Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: Current /dev/sda1 - UUID=6F6B-311A Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: Current fstb \boot Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: Volumio: 3.634 Mar 29 15:37:40 volumio-pc unknown: [i] initramfs: Finishing initramfs, switching rootfs and starting the boot process... Mar 29 15:37:40 volumio-pc systemd[1]: Inserted module 'autofs4' Mar 29 15:37:40 volumio-pc 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) Mar 29 15:37:40 volumio-pc systemd[1]: Detected architecture x86-64. Mar 29 15:37:40 volumio-pc systemd[1]: Set hostname to . Mar 29 15:37:40 volumio-pc 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. Mar 29 15:37:40 volumio-pc systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Mar 29 15:37:40 volumio-pc 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. Mar 29 15:37:40 volumio-pc systemd[1]: Started Forward Password Requests to Wall Directory Watch. Mar 29 15:37:40 volumio-pc systemd[1]: Created slice User and Session Slice. Mar 29 15:37:40 volumio-pc systemd[1]: Listening on udev Kernel Socket. Mar 29 15:37:40 volumio-pc systemd[1]: Listening on udev Control Socket. Mar 29 15:37:40 volumio-pc systemd-journald[251]: Journal started Mar 29 15:37:40 volumio-pc systemd-journald[251]: Runtime journal (/run/log/journal/e00814cb18d0b3744782912965e231f1) is 3.7M, max 30.0M, 26.2M free. Mar 29 15:37:40 volumio-pc fake-hwclock[246]: Current system time: 2024-03-29 14:37:40 Mar 29 15:37:40 volumio-pc fake-hwclock[246]: fake-hwclock saved clock information is in the past: 2024-03-29 14:37:11 Mar 29 15:37:40 volumio-pc fake-hwclock[246]: To set system time to this saved clock anyway, use "force" Mar 29 15:37:40 volumio-pc systemd[1]: dynamicswap.service: Succeeded. Mar 29 15:37:40 volumio-pc systemd[1]: Started Load/Save Random Seed. Mar 29 15:37:41 volumio-pc systemd[1]: Started Create System Users. Mar 29 15:37:41 volumio-pc kernel: RPC: Registered named UNIX socket transport module. Mar 29 15:37:41 volumio-pc kernel: RPC: Registered udp transport module. Mar 29 15:37:41 volumio-pc kernel: RPC: Registered tcp transport module. Mar 29 15:37:41 volumio-pc kernel: RPC: Registered tcp-with-tls transport module. Mar 29 15:37:41 volumio-pc kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Mar 29 15:37:41 volumio-pc systemd[1]: Starting Create Static Device Nodes in /dev... Mar 29 15:37:41 volumio-pc systemd[1]: Mounted RPC Pipe File System. Mar 29 15:37:41 volumio-pc systemd[1]: Started Create Static Device Nodes in /dev. Mar 29 15:37:41 volumio-pc systemd[1]: Reached target Local File Systems (Pre). Mar 29 15:37:41 volumio-pc systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Mar 29 15:37:41 volumio-pc systemd[1]: Mounting /tmp... Mar 29 15:37:41 volumio-pc systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Mar 29 15:37:41 volumio-pc systemd[1]: Mounting /var/log... Mar 29 15:37:41 volumio-pc systemd[1]: Mounting /var/spool/cups... Mar 29 15:37:41 volumio-pc systemd[1]: Starting udev Kernel Device Manager... Mar 29 15:37:41 volumio-pc systemd[1]: Started udev Coldplug all Devices. Mar 29 15:37:41 volumio-pc systemd[1]: Mounted /tmp. Mar 29 15:37:41 volumio-pc systemd[1]: Mounted /var/log. Mar 29 15:37:41 volumio-pc systemd[1]: Mounted /var/spool/cups. Mar 29 15:37:41 volumio-pc systemd[1]: Mounting /var/spool/cups/tmp... Mar 29 15:37:41 volumio-pc systemd[1]: Starting Flush Journal to Persistent Storage... Mar 29 15:37:41 volumio-pc systemd[1]: Starting Helper to synchronize boot up for ifupdown... Mar 29 15:37:41 volumio-pc systemd[1]: Mounted /var/spool/cups/tmp. Mar 29 15:37:41 volumio-pc systemd-udevd[277]: Network interface NamePolicy= disabled on kernel command line, ignoring. Mar 29 15:37:41 volumio-pc systemd[1]: Started Helper to synchronize boot up for ifupdown. Mar 29 15:37:41 volumio-pc systemd-journald[251]: Runtime journal (/run/log/journal/e00814cb18d0b3744782912965e231f1) is 3.7M, max 30.0M, 26.2M free. Mar 29 15:37:41 volumio-pc systemd[1]: Started Flush Journal to Persistent Storage. Mar 29 15:37:41 volumio-pc systemd[1]: Started udev Kernel Device Manager. Mar 29 15:37:41 volumio-pc systemd[1]: Starting Show Plymouth Boot Screen... Mar 29 15:37:41 volumio-pc systemd[1]: Received SIGRTMIN+20 from PID 294 (plymouthd). Mar 29 15:37:41 volumio-pc systemd[1]: Started Show Plymouth Boot Screen. Mar 29 15:37:41 volumio-pc systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Mar 29 15:37:41 volumio-pc systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 29 15:37:41 volumio-pc systemd[1]: Reached target Local Encrypted Volumes. Mar 29 15:37:41 volumio-pc systemd[1]: Reached target Paths. Mar 29 15:37:41 volumio-pc kernel: pstore: Using crash dump compression: deflate Mar 29 15:37:41 volumio-pc kernel: pstore: Registered efi_pstore as persistent store backend Mar 29 15:37:41 volumio-pc kernel: i801_smbus 0000:00:1f.1: can't derive routing for PCI INT A Mar 29 15:37:41 volumio-pc kernel: i801_smbus 0000:00:1f.1: PCI INT A: not connected Mar 29 15:37:41 volumio-pc kernel: i801_smbus 0000:00:1f.1: SPD Write Disable is set Mar 29 15:37:41 volumio-pc kernel: i801_smbus 0000:00:1f.1: SMBus using polling Mar 29 15:37:41 volumio-pc kernel: i2c i2c-0: 1/2 memory slots populated (from DMI) Mar 29 15:37:41 volumio-pc kernel: i2c i2c-0: Successfully instantiated SPD at 0x50 Mar 29 15:37:41 volumio-pc kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Mar 29 15:37:41 volumio-pc kernel: ACPI: bus type drm_connector registered Mar 29 15:37:41 volumio-pc systemd-udevd[322]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 29 15:37:41 volumio-pc kernel: r8169 0000:01:00.0 eth0: RTL8168g/8111g, 70:85:c2:43:c1:f5, XID 4c0, IRQ 128 Mar 29 15:37:41 volumio-pc kernel: r8169 0000:01:00.0 eth0: jumbo features [frames: 9194 bytes, tx checksumming: ko] Mar 29 15:37:41 volumio-pc kernel: cryptd: max_cpu_qlen set to 1000 Mar 29 15:37:41 volumio-pc kernel: usbcore: registered new interface driver usbkbd Mar 29 15:37:41 volumio-pc kernel: at24 0-0050: supply vcc not found, using dummy regulator Mar 29 15:37:41 volumio-pc kernel: at24 0-0050: 256 byte spd EEPROM, read-only Mar 29 15:37:41 volumio-pc kernel: usbcore: registered new interface driver usbmouse Mar 29 15:37:41 volumio-pc kernel: SSE version of gcm_enc/dec engaged. Mar 29 15:37:41 volumio-pc systemd-udevd[314]: Using default interface naming scheme 'v240'. Mar 29 15:37:41 volumio-pc systemd-udevd[314]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 29 15:37:41 volumio-pc systemd-udevd[289]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:41 volumio-pc systemd[1]: Found device Dogfish_SSD_32GB boot. Mar 29 15:37:41 volumio-pc systemd[1]: Condition check resulted in RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller (Motherboard (one of many)) being skipped. Mar 29 15:37:42 volumio-pc kernel: Console: switching to colour dummy device 80x25 Mar 29 15:37:42 volumio-pc kernel: i915 0000:00:02.0: vgaarb: deactivate vga console Mar 29 15:37:42 volumio-pc kernel: i915 0000:00:02.0: vgaarb: VGA decodes changed: olddecodes=io+mem,decodes=io+mem:owns=io+mem Mar 29 15:37:42 volumio-pc kernel: i915 0000:00:02.0: [drm] Finished loading DMC firmware i915/bxt_dmc_ver1_07.bin (v1.7) Mar 29 15:37:42 volumio-pc systemd[1]: Starting File System Check on /dev/disk/by-uuid/6F6B-311A... Mar 29 15:37:42 volumio-pc systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Mar 29 15:37:42 volumio-pc systemd[1]: Started File System Check Daemon to report status. Mar 29 15:37:42 volumio-pc systemd-fsck[431]: fsck.fat 4.1 (2017-01-24) Mar 29 15:37:42 volumio-pc systemd-fsck[431]: There are differences between boot sector and its backup. Mar 29 15:37:42 volumio-pc systemd-fsck[431]: This is mostly harmless. Differences: (offset:original/backup) Mar 29 15:37:42 volumio-pc systemd-fsck[431]: 3:53/6d, 4:59/6b, 5:53/66, 6:4c/73, 7:49/2e, 8:4e/66, 9:55/61, 10:58/74 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 90:fa/0e, 91:fc/1f, 92:31/be, 93:c9/77, 94:8e/7c, 95:d1/ac, 96:bc/22 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 97:76/c0, 98:7b/74, 99:52/0b, 100:06/56, 101:57/b4, 102:1e/0e, 103:56/bb Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 104:8e/07, 105:c1/00, 106:b1/cd, 107:26/10, 108:bf/5e, 109:78/eb Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 110:7b/f0, 111:f3/32, 112:a5/e4, 113:8e/cd, 114:d9/16, 115:bb/cd Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 116:78/19, 117:00/eb, 118:0f/fe, 119:b4/54, 120:37/68, 121:0f/69 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 122:a0/73, 123:56/20, 124:20/69, 125:d2/73, 126:78/20, 127:1b/6e Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 128:31/6f, 129:c0/74, 130:b1/20, 131:06/61, 132:89/20, 133:3f/62 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 134:89/6f, 135:47/6f, 136:02/74, 137:f3/61, 138:64/62, 139:a5/6c Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 140:8a/65, 141:0e/20, 142:18/64, 143:7c/69, 144:88/73, 145:4d/6b Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 146:f8/2e, 147:50/20, 148:50/20, 150:50/6c, 151:cd/65, 152:13/61 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 153:eb/73, 154:62/65, 155:8b/20, 156:55/69, 157:aa/6e, 158:8b/73 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 159:75/65, 160:a8/72, 161:c1/74, 162:ee/20, 163:04/61, 164:01/20 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 165:f2/62, 166:83/6f, 167:fa/6f, 168:4f/74, 169:76/61, 170:31/62 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 171:81/6c, 172:fa/65, 173:b2/20, 174:07/66, 175:73/6c, 176:2b/6f Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 177:f6/70, 178:45/70, 179:b4/79, 180:7f/20, 181:75/61, 182:25/6e Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 183:38/64, 184:4d/0d, 185:b8/0a, 186:74/70, 187:20/72, 188:66/65 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 189:3d/73, 190:21/73, 191:47/20, 192:50/61, 193:54/6e, 194:75/79 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 195:10/20, 196:80/6b, 197:7d/65, 198:b8/79, 199:ed/20, 200:75/74 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 201:0a/6f, 202:66/20, 203:ff/74, 204:75/72, 205:ec/79, 206:66/20 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 207:ff/61, 208:75/67, 209:e8/61, 210:eb/69, 211:0f/6e, 212:51/20 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 213:51/2e, 214:66/2e, 215:ff/2e, 216:75/20, 217:bc/0d, 218:eb/0a Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 219:07/00, 220:51/00, 221:51/00, 222:66/00, 223:ff/00, 224:36/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 225:1c/00, 226:7c/00, 227:b4/00, 228:08/00, 229:e8/00, 230:e9/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 232:72/00, 233:13/00, 234:20/00, 235:e4/00, 236:75/00, 237:0f/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 238:c1/00, 239:ea/00, 240:08/00, 241:42/00, 242:89/00, 243:16/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 244:1a/00, 245:7c/00, 246:83/00, 247:e1/00, 248:3f/00, 249:89/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 250:0e/00, 251:18/00, 252:7c/00, 253:fb/00, 254:bb/00, 255:aa/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 256:55/00, 257:b4/00, 258:41/00, 259:e8/00, 260:cb/00, 262:72/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 263:10/00, 264:81/00, 265:fb/00, 266:55/00, 267:aa/00, 268:75/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 269:0a/00, 270:f6/00, 271:c1/00, 272:01/00, 273:74/00, 274:05/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 275:c6/00, 276:06/00, 277:46/00, 278:7d/00, 280:66/00, 281:b8/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 282:2d/00, 283:15/00, 286:66/00, 287:ba/00, 292:bb/00, 294:80/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 295:e8/00, 296:0e/00, 298:66/00, 299:81/00, 300:3e/00, 301:1c/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 302:80/00, 303:d5/00, 304:cf/00, 305:c7/00, 306:62/00, 307:75/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 308:74/00, 309:e9/00, 310:f8/00, 311:02/00, 312:66/00, 313:03/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 314:06/00, 315:60/00, 316:7b/00, 317:66/00, 318:13/00, 319:16/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 320:64/00, 321:7b/00, 322:b9/00, 323:10/00, 325:eb/00, 326:2b/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 327:66/00, 328:52/00, 329:66/00, 330:50/00, 331:06/00, 332:53/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 333:6a/00, 334:01/00, 335:6a/00, 336:10/00, 337:89/00, 338:e6/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 339:66/00, 340:60/00, 341:b4/00, 342:42/00, 343:e8/00, 344:77/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 346:66/00, 347:61/00, 348:8d/00, 349:64/00, 350:10/00, 351:72/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 352:01/00, 353:c3/00, 354:66/00, 355:60/00, 356:31/00, 357:c0/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 358:e8/00, 359:68/00, 361:66/00, 362:61/00, 363:e2/00, 364:da/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 365:c6/00, 366:06/00, 367:46/00, 368:7d/00, 369:2b/00, 370:66/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 371:60/00, 372:66/00, 373:0f/00, 374:b7/00, 375:36/00, 376:18/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 377:7c/00, 378:66/00, 379:0f/00, 380:b7/00, 381:3e/00, 382:1a/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 383:7c/00, 384:66/00, 385:f7/00, 386:f6/00, 387:31/00, 388:c9/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 389:87/00, 390:ca/00, 391:66/00, 392:f7/00, 393:f7/00, 394:66/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 395:3d/00, 396:ff/00, 397:03/00, 400:77/00, 401:17/00, 402:c0/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 403:e4/00, 404:06/00, 405:41/00, 406:08/00, 407:e1/00, 408:88/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 409:c5/00, 410:88/00, 411:d6/00, 412:b8/00, 413:01/00, 414:02/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 415:e8/00, 416:2f/00, 418:66/00, 419:61/00, 420:72/00, 421:01/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 422:c3/00, 423:e2/00, 424:c9/00, 425:31/00, 426:f6/00, 427:8e/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 428:d6/00, 429:bc/00, 430:68/00, 431:7b/00, 432:8e/00, 433:de/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 434:66/00, 435:8f/00, 436:06/00, 437:78/00, 439:be/00, 440:da/00 Mar 29 15:37:42 volumio-pc systemd-udevd[316]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc systemd-udevd[308]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 441:7d/00, 442:ac/00, 443:20/00, 444:c0/00, 445:74/00, 446:09/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 447:b4/00, 448:0e/00, 449:bb/00, 450:07/00, 452:cd/00, 453:10/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 454:eb/00, 455:f2/00, 456:31/00, 457:c0/00, 458:cd/00, 459:16/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 460:cd/00, 461:19/00, 462:f4/00, 463:eb/00, 464:fd/00, 465:8a/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 466:16/00, 467:74/00, 468:7b/00, 469:06/00, 470:cd/00, 471:13/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 472:07/00, 473:c3/00, 474:42/00, 475:6f/00, 476:6f/00, 477:74/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 478:20/00, 479:65/00, 480:72/00, 481:72/00, 482:6f/00, 483:72/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 484:0d/00, 485:0a/00, 504:fe/00, 505:02/00, 506:b2/00, 507:3e/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: , 508:18/00, 509:37/00 Mar 29 15:37:42 volumio-pc systemd-fsck[431]: Not automatically fixing this. Mar 29 15:37:42 volumio-pc systemd-fsck[431]: /dev/sda1: 19 files, 158218/344788 clusters Mar 29 15:37:42 volumio-pc systemd[1]: Started File System Check on /dev/disk/by-uuid/6F6B-311A. Mar 29 15:37:42 volumio-pc systemd[1]: Mounting /boot... Mar 29 15:37:42 volumio-pc kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Mar 29 15:37:42 volumio-pc systemd[1]: Mounted /boot. Mar 29 15:37:42 volumio-pc systemd[1]: Reached target Local File Systems. Mar 29 15:37:42 volumio-pc systemd[1]: Starting Raise network interfaces... Mar 29 15:37:42 volumio-pc systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Mar 29 15:37:42 volumio-pc systemd[1]: Started ifup for eth0. Mar 29 15:37:42 volumio-pc systemd[1]: Starting Create Volatile Files and Directories... Mar 29 15:37:42 volumio-pc systemd[1]: Starting Preprocess NFS configuration... Mar 29 15:37:42 volumio-pc systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Mar 29 15:37:42 volumio-pc systemd[1]: Received SIGRTMIN+20 from PID 294 (plymouthd). Mar 29 15:37:42 volumio-pc systemd[1]: plymouth-read-write.service: Succeeded. Mar 29 15:37:42 volumio-pc systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Mar 29 15:37:42 volumio-pc kernel: [drm] Initialized i915 1.6.0 20201103 for 0000:00:02.0 on minor 0 Mar 29 15:37:42 volumio-pc kernel: ACPI: video: Video Device [GFX0] (multi-head: yes rom: no post: no) Mar 29 15:37:42 volumio-pc kernel: input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input3 Mar 29 15:37:42 volumio-pc kernel: snd_hda_intel 0000:00:0e.0: bound 0000:00:02.0 (ops i915_fence_ops [i915]) Mar 29 15:37:42 volumio-pc systemd[1]: nfs-config.service: Succeeded. Mar 29 15:37:42 volumio-pc systemd[1]: Started Preprocess NFS configuration. Mar 29 15:37:42 volumio-pc systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Mar 29 15:37:42 volumio-pc systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Mar 29 15:37:42 volumio-pc systemd[1]: Reached target NFS client services. Mar 29 15:37:42 volumio-pc systemd-udevd[298]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc systemd[1]: Started Create Volatile Files and Directories. Mar 29 15:37:42 volumio-pc systemd[1]: Starting RPC bind portmap service... Mar 29 15:37:42 volumio-pc systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Mar 29 15:37:42 volumio-pc systemd[1]: Starting Update UTMP about System Boot/Shutdown... Mar 29 15:37:42 volumio-pc kernel: fbcon: i915drmfb (fb0) is primary device Mar 29 15:37:42 volumio-pc kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Mar 29 15:37:42 volumio-pc systemd[1]: Started Update UTMP about System Boot/Shutdown. Mar 29 15:37:42 volumio-pc kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Mar 29 15:37:42 volumio-pc systemd-udevd[308]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc kernel: Console: switching to colour frame buffer device 240x67 Mar 29 15:37:42 volumio-pc systemd[1]: Started RPC bind portmap service. Mar 29 15:37:42 volumio-pc systemd[1]: Reached target Remote File Systems (Pre). Mar 29 15:37:42 volumio-pc systemd[1]: Reached target Remote File Systems. Mar 29 15:37:42 volumio-pc systemd[1]: Reached target RPC Port Mapper. Mar 29 15:37:42 volumio-pc systemd[1]: Reached target System Initialization. Mar 29 15:37:42 volumio-pc systemd[1]: Started Daily Cleanup of Temporary Directories. Mar 29 15:37:42 volumio-pc kernel: i915 0000:00:02.0: [drm] fb0: i915drmfb frame buffer device Mar 29 15:37:42 volumio-pc systemd[1]: Listening on triggerhappy.socket. Mar 29 15:37:42 volumio-pc systemd[1]: Started Daily man-db regeneration. Mar 29 15:37:42 volumio-pc systemd[1]: Started Volumio Splash. Mar 29 15:37:42 volumio-pc systemd[477]: volumiosplash.service: Failed to execute command: No such file or directory Mar 29 15:37:42 volumio-pc systemd[477]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory Mar 29 15:37:42 volumio-pc systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Mar 29 15:37:42 volumio-pc systemd[1]: Listening on D-Bus System Message Bus Socket. Mar 29 15:37:42 volumio-pc systemd[1]: Reached target Sockets. Mar 29 15:37:42 volumio-pc systemd[1]: Reached target Basic System. Mar 29 15:37:42 volumio-pc systemd[1]: Starting Wireless Services... Mar 29 15:37:42 volumio-pc systemd[1]: Started D-Bus System Message Bus. Mar 29 15:37:42 volumio-pc sh[445]: command failed: No such device (-19) Mar 29 15:37:42 volumio-pc systemd[1]: Starting WPA supplicant... Mar 29 15:37:42 volumio-pc ifup[442]: command failed: No such device (-19) Mar 29 15:37:42 volumio-pc systemd[1]: Started Volumio Log Rotation Service. Mar 29 15:37:42 volumio-pc systemd[1]: Started Volumio Iptables Module. Mar 29 15:37:42 volumio-pc systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Mar 29 15:37:42 volumio-pc systemd[1]: Starting Login Service... Mar 29 15:37:42 volumio-pc systemd[1]: Started UPnP Renderer front-end to MPD. Mar 29 15:37:42 volumio-pc systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Mar 29 15:37:42 volumio-pc systemd[1]: Starting DHCP Client Daemon... Mar 29 15:37:42 volumio-pc systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Mar 29 15:37:42 volumio-pc systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Mar 29 15:37:42 volumio-pc systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Mar 29 15:37:42 volumio-pc systemd[1]: Started Daily apt download activities. Mar 29 15:37:42 volumio-pc systemd[1]: Starting triggerhappy global hotkey daemon... Mar 29 15:37:42 volumio-pc systemd[1]: Started Daily apt upgrade and clean activities. Mar 29 15:37:42 volumio-pc systemd[1]: Reached target Timers. Mar 29 15:37:42 volumio-pc systemd[1]: Started volumio-remote-updater.service. Mar 29 15:37:42 volumio-pc systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC Mar 29 15:37:42 volumio-pc systemd[1]: volumiosplash.service: Failed with result 'exit-code'. Mar 29 15:37:42 volumio-pc thd[500]: Unable to parse trigger line: Mar 29 15:37:42 volumio-pc thd[500]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Mar 29 15:37:42 volumio-pc thd[500]: Unable to parse trigger line: Mar 29 15:37:42 volumio-pc thd[500]: Found socket passed from systemd Mar 29 15:37:42 volumio-pc systemd-logind[491]: New seat seat0. Mar 29 15:37:42 volumio-pc sh[445]: sending commands to master dhcpcd process Mar 29 15:37:42 volumio-pc dhcpcd[523]: sending commands to master dhcpcd process Mar 29 15:37:42 volumio-pc kernel: snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC892: line_outs=3 (0x14/0x15/0x16/0x0/0x0) type:line Mar 29 15:37:42 volumio-pc kernel: snd_hda_codec_realtek hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Mar 29 15:37:42 volumio-pc kernel: snd_hda_codec_realtek hdaudioC0D0: hp_outs=1 (0x1b/0x0/0x0/0x0/0x0) Mar 29 15:37:42 volumio-pc kernel: snd_hda_codec_realtek hdaudioC0D0: mono: mono_out=0x0 Mar 29 15:37:42 volumio-pc kernel: snd_hda_codec_realtek hdaudioC0D0: dig-out=0x1e/0x0 Mar 29 15:37:42 volumio-pc kernel: snd_hda_codec_realtek hdaudioC0D0: inputs: Mar 29 15:37:42 volumio-pc kernel: snd_hda_codec_realtek hdaudioC0D0: Front Mic=0x19 Mar 29 15:37:42 volumio-pc kernel: snd_hda_codec_realtek hdaudioC0D0: Rear Mic=0x18 Mar 29 15:37:42 volumio-pc kernel: snd_hda_codec_realtek hdaudioC0D0: Line=0x1a Mar 29 15:37:42 volumio-pc kernel: 8021q: 802.1Q VLAN Support v1.8 Mar 29 15:37:42 volumio-pc systemd-logind[491]: Watching system buttons on /dev/input/event0 (Power Button) Mar 29 15:37:42 volumio-pc systemd-logind[491]: Watching system buttons on /dev/input/event1 (HID 0c45:7403) Mar 29 15:37:42 volumio-pc ifup[442]: command failed: No such device (-19) Mar 29 15:37:42 volumio-pc avahi-daemon[499]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Mar 29 15:37:42 volumio-pc avahi-daemon[499]: Successfully dropped root privileges. Mar 29 15:37:42 volumio-pc avahi-daemon[499]: avahi-daemon 0.7 starting up. Mar 29 15:37:42 volumio-pc haveged[468]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K Mar 29 15:37:42 volumio-pc haveged[468]: haveged: cpu: (L4 VC); data: 24K (L4 V); inst: 32K (L4 V); idx: 24/40; sz: 31410/52825 Mar 29 15:37:42 volumio-pc haveged[468]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99617 Mar 29 15:37:42 volumio-pc haveged[468]: haveged: fills: 0, generated: 0 Mar 29 15:37:42 volumio-pc kernel: input: HDA Intel PCH Front Mic as /devices/pci0000:00/0000:00:0e.0/sound/card0/input4 Mar 29 15:37:42 volumio-pc kernel: input: HDA Intel PCH Rear Mic as /devices/pci0000:00/0000:00:0e.0/sound/card0/input5 Mar 29 15:37:42 volumio-pc kernel: input: HDA Intel PCH Line as /devices/pci0000:00/0000:00:0e.0/sound/card0/input6 Mar 29 15:37:42 volumio-pc kernel: input: HDA Intel PCH Line Out Front as /devices/pci0000:00/0000:00:0e.0/sound/card0/input7 Mar 29 15:37:42 volumio-pc kernel: input: HDA Intel PCH Line Out Surround as /devices/pci0000:00/0000:00:0e.0/sound/card0/input8 Mar 29 15:37:42 volumio-pc kernel: input: HDA Intel PCH Line Out CLFE as /devices/pci0000:00/0000:00:0e.0/sound/card0/input9 Mar 29 15:37:42 volumio-pc kernel: input: HDA Intel PCH Front Headphone as /devices/pci0000:00/0000:00:0e.0/sound/card0/input10 Mar 29 15:37:42 volumio-pc kernel: input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:0e.0/sound/card0/input11 Mar 29 15:37:42 volumio-pc kernel: input: HDA Intel PCH HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:0e.0/sound/card0/input12 Mar 29 15:37:42 volumio-pc kernel: input: HDA Intel PCH HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:0e.0/sound/card0/input13 Mar 29 15:37:42 volumio-pc systemd[1]: Started Login Service. Mar 29 15:37:42 volumio-pc systemd[1]: Started triggerhappy global hotkey daemon. Mar 29 15:37:42 volumio-pc wpa_supplicant[485]: Successfully initialized wpa_supplicant Mar 29 15:37:42 volumio-pc avahi-daemon[499]: Successfully called chroot(). Mar 29 15:37:42 volumio-pc avahi-daemon[499]: Successfully dropped remaining capabilities. Mar 29 15:37:42 volumio-pc avahi-daemon[499]: Loading service file /services/volumio.service. Mar 29 15:37:42 volumio-pc avahi-daemon[499]: Network interface enumeration completed. Mar 29 15:37:42 volumio-pc avahi-daemon[499]: Server startup complete. Host name is volumio-pc.local. Local service cookie is 4005297139. Mar 29 15:37:42 volumio-pc avahi-daemon[499]: Service "Volumio PC" (/services/volumio.service) successfully established. Mar 29 15:37:42 volumio-pc systemd-udevd[316]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc systemd-udevd[304]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc systemd-udevd[308]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc systemd-udevd[298]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc dhcpcd[495]: no interfaces have a carrier Mar 29 15:37:42 volumio-pc dhcpcd[495]: no interfaces have a carrier Mar 29 15:37:42 volumio-pc dhcpcd[495]: forked to background, child pid 616 Mar 29 15:37:42 volumio-pc dhcpcd[495]: forked to background, child pid 616 Mar 29 15:37:42 volumio-pc systemd-udevd[320]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc systemd-udevd[313]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc systemd-udevd[295]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc systemd-udevd[319]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc systemd-udevd[283]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc systemd-udevd[291]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 29 15:37:42 volumio-pc kernel: Generic FE-GE Realtek PHY r8169-0-100:00: attached PHY driver (mii_bus:phy_addr=r8169-0-100:00, irq=MAC) Mar 29 15:37:42 volumio-pc volumio-remote-updater[501]: Error: No active session Mar 29 15:37:42 volumio-pc systemd[1]: Started DHCP Client Daemon. Mar 29 15:37:42 volumio-pc volumio[493]: Could not open config: /tmp/upmpdcli.conf Mar 29 15:37:42 volumio-pc systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 29 15:37:42 volumio-pc systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 29 15:37:42 volumio-pc systemd[1]: Started Avahi mDNS/DNS-SD Stack. Mar 29 15:37:42 volumio-pc systemd[1]: Started WPA supplicant. Mar 29 15:37:42 volumio-pc sh[445]: eth0=eth0 Mar 29 15:37:42 volumio-pc systemd[1]: Started Manage Sound Card State (restore and store). Mar 29 15:37:42 volumio-pc alsactl[620]: alsactl 1.1.8 daemon started Mar 29 15:37:42 volumio-pc systemd[1]: Starting Save/Restore Sound Card State... Mar 29 15:37:42 volumio-pc systemd[1]: iptables.service: Succeeded. Mar 29 15:37:43 volumio-pc systemd[1]: Started Raise network interfaces. Mar 29 15:37:43 volumio-pc systemd[1]: Reached target Network. Mar 29 15:37:43 volumio-pc systemd[1]: Starting Network Time Service... Mar 29 15:37:43 volumio-pc systemd[1]: Starting OpenBSD Secure Shell server... Mar 29 15:37:43 volumio-pc systemd[1]: Reached target Network is Online. Mar 29 15:37:43 volumio-pc systemd[1]: Starting LSB: Brings up/down network automatically... Mar 29 15:37:43 volumio-pc systemd[1]: Starting Permit User Sessions... Mar 29 15:37:43 volumio-pc systemd[1]: Starting /etc/rc.local Compatibility... Mar 29 15:37:43 volumio-pc systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Mar 29 15:37:43 volumio-pc systemd[1]: Starting Samba NMB Daemon... Mar 29 15:37:43 volumio-pc systemd[1]: Started Permit User Sessions. Mar 29 15:37:43 volumio-pc systemd[1]: Started /etc/rc.local Compatibility. Mar 29 15:37:43 volumio-pc systemd[1]: Starting Hold until boot process finishes up... Mar 29 15:37:43 volumio-pc systemd[1]: Starting Terminate Plymouth Boot Screen... Mar 29 15:37:43 volumio-pc dhcpcd[616]: eth0: waiting for carrier Mar 29 15:37:43 volumio-pc dhcpcd[616]: eth0: carrier acquired Mar 29 15:37:43 volumio-pc volumio-remote-updater[501]: [2024-03-29 15:37:43] [info] asio async_connect error: system:111 (Connection refused) Mar 29 15:37:43 volumio-pc volumio-remote-updater[501]: [2024-03-29 15:37:43] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 29 15:37:43 volumio-pc kernel: r8169 0000:01:00.0 eth0: Link is Down Mar 29 15:37:43 volumio-pc dhcpcd[616]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09 Mar 29 15:37:43 volumio-pc dhcpcd[616]: eth0: IAID c2:43:c1:f5 Mar 29 15:37:43 volumio-pc dhcpcd[616]: eth0: adding address fe80::4c50:3030:249f:e89f Mar 29 15:37:43 volumio-pc dhcpcd[616]: ipv6_addaddr1: Permission denied Mar 29 15:37:43 volumio-pc dhcpcd[616]: control command: /sbin/dhcpcd eth0 Mar 29 15:37:43 volumio-pc dhcpcd[616]: eth0: carrier lost Mar 29 15:37:43 volumio-pc volumio-remote-updater[501]: [2024-03-29 15:37:43] [error] handle_connect error: Underlying Transport Error Mar 29 15:37:43 volumio-pc ntpd[651]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 29 15:37:43 volumio-pc ntpd[651]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 29 15:37:43 volumio-pc systemd[1]: Started Network Time Service. Mar 29 15:37:43 volumio-pc ntpd[682]: proto: precision = 0.082 usec (-23) Mar 29 15:37:43 volumio-pc ntpd[682]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 29 15:37:43 volumio-pc ntpd[682]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 29 15:37:43 volumio-pc ntpd[682]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 458 days ago Mar 29 15:37:43 volumio-pc ntpd[682]: Listen and drop on 0 v6wildcard [::]:123 Mar 29 15:37:43 volumio-pc ntpd[682]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 29 15:37:43 volumio-pc ntpd[682]: Listen normally on 2 lo 127.0.0.1:123 Mar 29 15:37:43 volumio-pc ntpd[682]: Listening on routing socket on fd #19 for interface updates Mar 29 15:37:43 volumio-pc ntpd[682]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 29 15:37:43 volumio-pc ntpd[682]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 29 15:37:43 volumio-pc sshd[683]: Server listening on 0.0.0.0 port 22. Mar 29 15:37:43 volumio-pc sshd[683]: Server listening on :: port 22. Mar 29 15:37:43 volumio-pc systemd[1]: Started OpenBSD Secure Shell server. Mar 29 15:37:43 volumio-pc kernel: alsactl[620]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Mar 29 15:37:43 volumio-pc systemd[1]: Started Save/Restore Sound Card State. Mar 29 15:37:43 volumio-pc systemd[1]: Reached target Sound Card. Mar 29 15:37:43 volumio-pc systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 29 15:37:43 volumio-pc systemd[1]: Received SIGRTMIN+21 from PID 294 (plymouthd). Mar 29 15:37:43 volumio-pc nmbd[665]: [2024/03/29 15:37:43.618121, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Mar 29 15:37:43 volumio-pc nmbd[665]: started asyncdns process 692 Mar 29 15:37:43 volumio-pc nmbd[665]: [2024/03/29 15:37:43.619182, 0] ../lib/util/become_daemon.c:149(daemon_status) Mar 29 15:37:43 volumio-pc nmbd[665]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Mar 29 15:37:43 volumio-pc nmbd[665]: [2024/03/29 15:37:43.619270, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Mar 29 15:37:43 volumio-pc nmbd[665]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Mar 29 15:37:43 volumio-pc ifplugd[653]: Network Interface Plugging Daemon...error: unexpectedly disconnected from boot status daemon Mar 29 15:37:43 volumio-pc systemd[1]: plymouth-quit-wait.service: Succeeded. Mar 29 15:37:43 volumio-pc loadcpufreq[497]: Loading cpufreq kernel modules...error: unexpectedly disconnected from boot status daemon Mar 29 15:37:43 volumio-pc systemd[1]: Started Hold until boot process finishes up. Mar 29 15:37:43 volumio-pc systemd[1]: plymouth-quit.service: Succeeded. Mar 29 15:37:43 volumio-pc systemd[1]: Started Terminate Plymouth Boot Screen. Mar 29 15:37:43 volumio-pc systemd[1]: Received SIGRTMIN+21 from PID 294 (plymouthd). Mar 29 15:37:43 volumio-pc wireless.js[481]: WIRELESS: No wireless interface, exiting Mar 29 15:37:43 volumio-pc ifplugd(eth0)[708]: ifplugd 0.28 initializing. Mar 29 15:37:43 volumio-pc ifplugd(eth0)[708]: Using interface eth0/70:85:C2:43:C1:F5 with driver (version: 6.6.7-volumio) Mar 29 15:37:43 volumio-pc systemd[1]: Started Getty on tty1. Mar 29 15:37:43 volumio-pc ifplugd(eth0)[708]: Using detection mode: SIOCETHTOOL Mar 29 15:37:43 volumio-pc ifplugd(eth0)[708]: Initialization complete, link beat not detected. Mar 29 15:37:43 volumio-pc systemd[1]: Reached target Login Prompts. Mar 29 15:37:43 volumio-pc systemd[1]: plymouth-start.service: Succeeded. Mar 29 15:37:43 volumio-pc iw[717]: command failed: No such device (-19) Mar 29 15:37:43 volumio-pc iwconfig[730]: Error for wireless request "Set Power Management" (8B2C) : Mar 29 15:37:43 volumio-pc iwconfig[730]: SET failed on device wlan0 ; No such device. Mar 29 15:37:43 volumio-pc systemd[1]: wireless.service: Succeeded. Mar 29 15:37:43 volumio-pc systemd[1]: Started Wireless Services. Mar 29 15:37:43 volumio-pc loadcpufreq[497]: done (acpi-cpufreq). Mar 29 15:37:43 volumio-pc systemd[1]: Started Volumio Backend Module. Mar 29 15:37:43 volumio-pc systemd[1]: Started Volumio Cpu Tweaker. Mar 29 15:37:43 volumio-pc systemd[1]: Started Intel SST and HDA soundcard init service. Mar 29 15:37:43 volumio-pc systemd[1]: Started Start Volumio Kiosk. Mar 29 15:37:43 volumio-pc systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Mar 29 15:37:43 volumio-pc systemd[1]: Starting LSB: set CPUFreq kernel parameters... Mar 29 15:37:43 volumio-pc ifplugd[653]: start eth0...done. Mar 29 15:37:43 volumio-pc systemd[1]: Started LSB: Brings up/down network automatically. Mar 29 15:37:43 volumio-pc volumio-cpu-tweak[743]: Setting RT Priority for mpd Mar 29 15:37:43 volumio-pc volumio-cpu-tweak[743]: pid 35's current scheduling policy: SCHED_FIFO Mar 29 15:37:43 volumio-pc volumio-cpu-tweak[743]: pid 35's current scheduling priority: 99 Mar 29 15:37:43 volumio-pc volumio-cpu-tweak[743]: Setting MPD Affinity Mar 29 15:37:43 volumio-pc volumio-cpu-tweak[743]: pid 3's current affinity mask: f Mar 29 15:37:43 volumio-pc volumio-cpu-tweak[743]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 29 15:37:43 volumio-pc cpufrequtils[757]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Mar 29 15:37:43 volumio-pc systemd[1]: Started LSB: set CPUFreq kernel parameters. Mar 29 15:37:43 volumio-pc systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 29 15:37:43 volumio-pc startx[745]: X.Org X Server 1.20.4 Mar 29 15:37:43 volumio-pc startx[745]: X Protocol Version 11, Revision 0 Mar 29 15:37:43 volumio-pc startx[745]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Mar 29 15:37:43 volumio-pc startx[745]: Current Operating System: Linux volumio-pc 6.6.7-volumio #2 SMP PREEMPT_DYNAMIC Mon Dec 18 16:22:28 CET 2023 x86_64 Mar 29 15:37:43 volumio-pc startx[745]: Kernel command line: BOOT_IMAGE=/vmlinuz biosdevname=0 splash plymouth.ignore-serial-consoles quiet ro rootwait imgpart=UUID=f9f7c575-874e-43ef-a723-80ec9af506d0 bootpart=UUID=6F6B-311A datapart=UUID=5e594c75-cc80-4bc2-957a-50cc329bdaa4 imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor use_kmsg=yes net.ifnames=0 loglevel=0 Mar 29 15:37:43 volumio-pc startx[745]: Build Date: 18 December 2021 09:05:36AM Mar 29 15:37:43 volumio-pc startx[745]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Mar 29 15:37:43 volumio-pc startx[745]: Current version of pixman: 0.36.0 Mar 29 15:37:43 volumio-pc startx[745]: Before reporting problems, check http://wiki.x.org Mar 29 15:37:43 volumio-pc startx[745]: to make sure that you have the latest version. Mar 29 15:37:43 volumio-pc startx[745]: Markers: (--) probed, (**) from config file, (==) default setting, Mar 29 15:37:43 volumio-pc startx[745]: (++) from command line, (!!) notice, (II) informational, Mar 29 15:37:43 volumio-pc startx[745]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Mar 29 15:37:43 volumio-pc startx[745]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Mar 29 15:37:43 2024 Mar 29 15:37:43 volumio-pc startx[745]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Mar 29 15:37:44 volumio-pc kernel: broken atomic modeset userspace detected, disabling atomic Mar 29 15:37:44 volumio-pc ntpd[682]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Simple mixer control 'Surround',0 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Capabilities: pvolume pswitch Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Playback channels: Front Left - Front Right Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Limits: Playback 0 - 64 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Mono: Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Front Left: Playback 64 [100%] [0.00dB] [off] Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Front Right: Playback 64 [100%] [0.00dB] [off] Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Simple mixer control 'Center',0 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Capabilities: pvolume pvolume-joined pswitch pswitch-joined Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Playback channels: Mono Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Limits: Playback 0 - 64 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Mono: Playback 64 [100%] [0.00dB] [off] Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Simple mixer control 'LFE',0 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Capabilities: pvolume pvolume-joined pswitch pswitch-joined Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Playback channels: Mono Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Limits: Playback 0 - 64 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Mono: Playback 64 [100%] [0.00dB] [off] Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Simple mixer control 'IEC958',16 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Capabilities: pswitch pswitch-joined Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Playback channels: Mono Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Mono: Playback [on] Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Simple mixer control 'Front',0 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Capabilities: pvolume pswitch Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Playback channels: Front Left - Front Right Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Limits: Playback 0 - 64 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Mono: Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Front Left: Playback 59 [92%] [-5.00dB] [on] Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Front Right: Playback 59 [92%] [-5.00dB] [on] Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Simple mixer control 'Headphone',0 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Capabilities: pvolume pswitch Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Playback channels: Front Left - Front Right Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Limits: Playback 0 - 64 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Mono: Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Front Left: Playback 59 [92%] [-5.00dB] [on] Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Front Right: Playback 59 [92%] [-5.00dB] [on] Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Simple mixer control 'Master',0 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Capabilities: pvolume pvolume-joined pswitch pswitch-joined Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Playback channels: Mono Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Limits: Playback 0 - 64 Mar 29 15:37:44 volumio-pc soundcard-init.sh[744]: Mono: Playback 48 [75%] [-16.00dB] [on] Mar 29 15:37:44 volumio-pc systemd[1]: soundcard-init.service: Succeeded. Mar 29 15:37:44 volumio-pc startx[745]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Mar 29 15:37:45 volumio-pc volumio[740]: info: ------------------------------------------- Mar 29 15:37:45 volumio-pc volumio[740]: info: ----- Volumio3 ---- Mar 29 15:37:45 volumio-pc volumio[740]: info: ------------------------------------------- Mar 29 15:37:45 volumio-pc volumio[740]: info: ----- System startup ---- Mar 29 15:37:45 volumio-pc volumio[740]: info: ------------------------------------------- Mar 29 15:37:45 volumio-pc ntpd[682]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 29 15:37:45 volumio-pc dhcpcd[616]: eth0: carrier acquired Mar 29 15:37:45 volumio-pc kernel: r8169 0000:01:00.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx Mar 29 15:37:45 volumio-pc dhcpcd[616]: eth0: IAID c2:43:c1:f5 Mar 29 15:37:45 volumio-pc ifplugd(eth0)[708]: Link beat detected. Mar 29 15:37:45 volumio-pc ifplugd(eth0)[708]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Mar 29 15:37:45 volumio-pc ifplugd(eth0)[708]: client: ifup: interface eth0 already configured Mar 29 15:37:45 volumio-pc ifplugd(eth0)[708]: Program executed successfully. Mar 29 15:37:46 volumio-pc volumio[740]: info: MYVOLUMIO Environment detected Mar 29 15:37:46 volumio-pc ntpd[682]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 29 15:37:46 volumio-pc dhcpcd[616]: eth0: soliciting an IPv6 router Mar 29 15:37:46 volumio-pc dhcpcd[616]: eth0: rebinding lease of 192.168.188.71 Mar 29 15:37:46 volumio-pc volumio[740]: info: Plugin folders cleanup Mar 29 15:37:46 volumio-pc volumio[740]: info: Scanning into folder /volumio/app/plugins/ Mar 29 15:37:46 volumio-pc volumio[740]: info: Scanning category audio_interface Mar 29 15:37:46 volumio-pc volumio[740]: info: Scanning category miscellanea Mar 29 15:37:46 volumio-pc volumio[740]: info: Scanning category music_service Mar 29 15:37:46 volumio-pc volumio[740]: info: Scanning category plugins.json Mar 29 15:37:46 volumio-pc volumio[740]: info: Scanning category system_controller Mar 29 15:37:46 volumio-pc volumio[740]: info: Scanning category user_interface Mar 29 15:37:46 volumio-pc volumio[740]: info: Scanning into folder /data/plugins/ Mar 29 15:37:46 volumio-pc volumio[740]: info: Scanning category music_service Mar 29 15:37:46 volumio-pc volumio[740]: info: Plugin folders cleanup completed Mar 29 15:37:46 volumio-pc volumio[740]: info: ------------------------------------------- Mar 29 15:37:46 volumio-pc volumio[740]: info: ----- Core plugins startup ---- Mar 29 15:37:46 volumio-pc volumio[740]: info: ------------------------------------------- Mar 29 15:37:46 volumio-pc volumio[740]: info: Loading plugins from folder /volumio/app/plugins/ Mar 29 15:37:46 volumio-pc volumio[740]: info: Adding plugin upnp to MyMusic Plugins Mar 29 15:37:46 volumio-pc volumio[740]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 29 15:37:46 volumio-pc volumio[740]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 29 15:37:46 volumio-pc volumio[740]: info: Loading plugins from folder /data/plugins/ Mar 29 15:37:46 volumio-pc volumio[740]: info: Loading plugin "system"... Mar 29 15:37:46 volumio-pc volumio[740]: info: Loading plugin "appearance"... Mar 29 15:37:47 volumio-pc ntpd[682]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 29 15:37:47 volumio-pc volumio[740]: info: Loading plugin "network"... Mar 29 15:37:47 volumio-pc volumio[740]: info: Refreshing Cached IP Addresses Mar 29 15:37:47 volumio-pc volumio[740]: info: Loading plugin "services"... Mar 29 15:37:47 volumio-pc volumio[740]: info: Loading plugin "alsa_controller"... Mar 29 15:37:47 volumio-pc sudo[981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 29 15:37:47 volumio-pc sudo[985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 29 15:37:47 volumio-pc sudo[985]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:47 volumio-pc sudo[983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 29 15:37:47 volumio-pc sudo[983]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:47 volumio-pc sudo[981]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:47 volumio-pc sudo[981]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:47 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 29 15:37:47 volumio-pc volumio[740]: info: Loading plugin "wizard"... Mar 29 15:37:47 volumio-pc sudo[983]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:47 volumio-pc sudo[985]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:47 volumio-pc volumio[740]: info: Loading plugin "networkfs"... Mar 29 15:37:47 volumio-pc volumio[740]: info: Starting Udev Watcher for removable devices Mar 29 15:37:47 volumio-pc sudo[999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=wolfgang,password=Anja6536$,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.188.138/Musik /mnt/NAS/Musik Mar 29 15:37:47 volumio-pc sudo[999]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:47 volumio-pc sudo[1001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.188.71\INTERNAL/Test /mnt/NAS/Intern Mar 29 15:37:47 volumio-pc sudo[1001]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:47 volumio-pc volumio[740]: info: Ignoring mount for partition: boot Mar 29 15:37:47 volumio-pc volumio[740]: info: Ignoring mount for partition: volumio Mar 29 15:37:47 volumio-pc volumio[740]: info: Ignoring mount for partition: volumio_data Mar 29 15:37:47 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 29 15:37:47 volumio-pc volumio[740]: info: Loading plugin "volumio_command_line_client"... Mar 29 15:37:47 volumio-pc volumio[740]: info: Loading plugin "upnp"... Mar 29 15:37:47 volumio-pc volumio[740]: info: [1711723067579] Starting Upmpd Daemon Mar 29 15:37:47 volumio-pc kernel: FS-Cache: Loaded Mar 29 15:37:47 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 29 15:37:47 volumio-pc volumio[740]: info: Loading plugin "my_music"... Mar 29 15:37:47 volumio-pc kernel: Key type dns_resolver registered Mar 29 15:37:47 volumio-pc volumio[740]: info: Loading plugin "mpd"... Mar 29 15:37:47 volumio-pc dbus-daemon[483]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.6' (uid=0 pid=936 comm="/usr/lib/chromium/chromium --show-component-extens") Mar 29 15:37:47 volumio-pc kernel: Key type cifs.spnego registered Mar 29 15:37:47 volumio-pc kernel: Key type cifs.idmap registered Mar 29 15:37:47 volumio-pc 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. Mar 29 15:37:47 volumio-pc kernel: CIFS: Attempting to mount //192.168.188.71/INTERNAL/Test Mar 29 15:37:47 volumio-pc kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Mar 29 15:37:47 volumio-pc kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Mar 29 15:37:47 volumio-pc kernel: CIFS: Attempting to mount //192.168.188.138/Musik Mar 29 15:37:47 volumio-pc kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Mar 29 15:37:47 volumio-pc kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Mar 29 15:37:47 volumio-pc sudo[1001]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:47 volumio-pc sudo[999]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:47 volumio-pc systemd[1]: Starting Bluetooth service... Mar 29 15:37:47 volumio-pc bluetoothd[1019]: Bluetooth daemon 5.50 Mar 29 15:37:47 volumio-pc kernel: Bluetooth: Core ver 2.22 Mar 29 15:37:47 volumio-pc kernel: NET: Registered PF_BLUETOOTH protocol family Mar 29 15:37:47 volumio-pc kernel: Bluetooth: HCI device and connection manager initialized Mar 29 15:37:47 volumio-pc kernel: Bluetooth: HCI socket layer initialized Mar 29 15:37:47 volumio-pc kernel: Bluetooth: L2CAP socket layer initialized Mar 29 15:37:47 volumio-pc kernel: Bluetooth: SCO socket layer initialized Mar 29 15:37:47 volumio-pc bluetoothd[1019]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Mar 29 15:37:47 volumio-pc dbus-daemon[483]: [system] Successfully activated service 'org.bluez' Mar 29 15:37:47 volumio-pc systemd[1]: Started Bluetooth service. Mar 29 15:37:47 volumio-pc bluetoothd[1019]: Starting SDP server Mar 29 15:37:47 volumio-pc bluetoothd[1019]: Excluding (cli) sap Mar 29 15:37:47 volumio-pc kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Mar 29 15:37:47 volumio-pc kernel: Bluetooth: BNEP filters: protocol multicast Mar 29 15:37:47 volumio-pc kernel: Bluetooth: BNEP socket layer initialized Mar 29 15:37:47 volumio-pc bluetoothd[1019]: Bluetooth management interface 1.22 initialized Mar 29 15:37:47 volumio-pc dbus-daemon[483]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.7' (uid=0 pid=1019 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Mar 29 15:37:47 volumio-pc volumio[740]: info: Loading plugin "upnp_browser"... Mar 29 15:37:47 volumio-pc systemd[1]: Starting Hostname Service... Mar 29 15:37:48 volumio-pc dbus-daemon[483]: [system] Successfully activated service 'org.freedesktop.hostname1' Mar 29 15:37:48 volumio-pc systemd[1]: Started Hostname Service. Mar 29 15:37:48 volumio-pc volumio-remote-updater[501]: [2024-03-29 15:37:48] [connect] Successful connection Mar 29 15:37:48 volumio-pc volumio[740]: info: Loading plugin "alarm-clock"... Mar 29 15:37:48 volumio-pc volumio[740]: info: Loading plugin "airplay_emulation"... Mar 29 15:37:48 volumio-pc volumio[740]: info: Starting Shairport Sync Mar 29 15:37:48 volumio-pc volumio[740]: info: Loading plugin "last_100"... Mar 29 15:37:48 volumio-pc volumio[740]: info: Loading plugin "webradio"... Mar 29 15:37:48 volumio-pc volumio[740]: info: Loading plugin "i2s_dacs"... Mar 29 15:37:48 volumio-pc volumio[740]: info: I2S DAC not set, start Auto-detection Mar 29 15:37:48 volumio-pc volumio[740]: info: Loading plugin "volumiodiscovery"... Mar 29 15:37:48 volumio-pc volumio[740]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 29 15:37:48 volumio-pc node[740]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 29 15:37:48 volumio-pc volumio[740]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 29 15:37:48 volumio-pc volumio[740]: *** WARNING *** For more information see Mar 29 15:37:48 volumio-pc volumio[740]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 29 15:37:48 volumio-pc volumio[740]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 29 15:37:48 volumio-pc node[740]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 29 15:37:48 volumio-pc volumio[740]: *** WARNING *** For more information see Mar 29 15:37:48 volumio-pc node[740]: *** WARNING *** For more information see Mar 29 15:37:48 volumio-pc node[740]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 29 15:37:48 volumio-pc node[740]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 29 15:37:48 volumio-pc node[740]: *** WARNING *** For more information see Mar 29 15:37:48 volumio-pc volumio[740]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 29 15:37:48 volumio-pc volumio[740]: info: Discovery: Started advertising with name: Volumio PC Mar 29 15:37:48 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 29 15:37:48 volumio-pc volumio[740]: info: Loading plugin "spop"... Mar 29 15:37:49 volumio-pc volumio[740]: info: Loading plugin "outputs"... Mar 29 15:37:49 volumio-pc volumio[740]: info: Loading plugin "albumart"... Mar 29 15:37:49 volumio-pc volumio[740]: info: Plugin example_plugin is not enabled Mar 29 15:37:49 volumio-pc volumio[740]: info: Loading plugin "inputs"... Mar 29 15:37:49 volumio-pc volumio[740]: info: Loading plugin "updater_comm"... Mar 29 15:37:49 volumio-pc volumio[740]: Forking 3 albumart workers Mar 29 15:37:49 volumio-pc volumio[740]: info: Plugin mpdemulation is not enabled Mar 29 15:37:49 volumio-pc volumio[740]: info: Loading plugin "rest_api"... Mar 29 15:37:49 volumio-pc volumio[740]: info: Loading plugin "websocket"... Mar 29 15:37:49 volumio-pc volumio[740]: info: Loading plugin "radio_paradise"... Mar 29 15:37:49 volumio-pc volumio[740]: info: Applying required configuration parameters for plugin radio_paradise Mar 29 15:37:49 volumio-pc volumio[740]: info: [1711723069655] [RadioParadise] API delay: 5 Mar 29 15:37:49 volumio-pc volumio[740]: info: Loading i18n strings for locale de Mar 29 15:37:49 volumio-pc volumio[740]: Updating browse sources language Mar 29 15:37:49 volumio-pc volumio[740]: Starting albumart workers Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 15:37:49 volumio-pc volumio[740]: Starting albumart workers Mar 29 15:37:49 volumio-pc volumio[740]: Starting albumart workers Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::initPlayerControls Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 15:37:49 volumio-pc volumio[740]: Express server listening on port 3000 Mar 29 15:37:49 volumio-pc volumio[740]: [Metrics] WebUI: 5s 224.50ms Mar 29 15:37:49 volumio-pc volumio[740]: info: Setting Device type: x86 Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreStateMachine::resetVolumioState Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreStateMachine::getcurrentVolume Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::volumioRetrievevolume Mar 29 15:37:49 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:37:49 volumio-pc volumio[740]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Mar 29 15:37:49 volumio-pc volumio[740]: info: Completed loading Core Plugins Mar 29 15:37:49 volumio-pc volumio[740]: info: Preparing to generate the ALSA configuration file Mar 29 15:37:49 volumio-pc volumio[740]: info: Cannot read play queue from file Mar 29 15:37:49 volumio-pc volumio[740]: info: Cannot mount NAS Intern at system boot, trial number 1 ,retrying in 5 seconds Mar 29 15:37:49 volumio-pc volumio[740]: info: Cannot mount NAS Musik at system boot, trial number 1 ,retrying in 5 seconds Mar 29 15:37:49 volumio-pc volumio[740]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Mar 29 15:37:49 volumio-pc volumio[740]: wlan0 Interface doesn't support scanning. Mar 29 15:37:49 volumio-pc volumio[740]: info: Cannot use regular scanning, forcing with ap-force Mar 29 15:37:49 volumio-pc sudo[1172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Mar 29 15:37:49 volumio-pc sudo[1172]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:49 volumio-pc sudo[1172]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:49 volumio-pc volumio[740]: command failed: No such device (-19) Mar 29 15:37:49 volumio-pc volumio[740]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Mar 29 15:37:49 volumio-pc volumio[740]: command failed: No such device (-19) Mar 29 15:37:49 volumio-pc volumio[740]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Mar 29 15:37:50 volumio-pc volumio-remote-updater[501]: [2024-03-29 15:37:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1711723068 101 Mar 29 15:37:50 volumio-pc volumio[740]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Mar 29 15:37:50 volumio-pc volumio[740]: info: VolumeController:: Volume=50 Mute =false Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreStateMachine::pushState Mar 29 15:37:50 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::volumioPushState Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreStateMachine::updateTrackBlock Mar 29 15:37:50 volumio-pc volumio[740]: info: CorePlayQueue::getTrackBlock Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::volumioRetrievevolume Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreStateMachine::setRepeat null single undefined Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreStateMachine::pushState Mar 29 15:37:50 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::volumioPushState Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreStateMachine::setRandom null Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreStateMachine::pushState Mar 29 15:37:50 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::volumioPushState Mar 29 15:37:50 volumio-pc volumio[740]: info: Asound.conf file written Mar 29 15:37:50 volumio-pc sudo[1188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 29 15:37:50 volumio-pc sudo[1188]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:50 volumio-pc sudo[1188]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:50 volumio-pc volumio[740]: info: Output device has changed, restarting MPD Mar 29 15:37:50 volumio-pc sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 29 15:37:50 volumio-pc sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:50 volumio-pc volumio[740]: info: Output device has changed, restarting Shairport Sync Mar 29 15:37:50 volumio-pc sudo[1193]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:37:50 volumio-pc sudo[1196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 29 15:37:50 volumio-pc sudo[1196]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:50 volumio-pc systemd[1]: Listening on mpd.socket. Mar 29 15:37:50 volumio-pc volumio[740]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 29 15:37:50 volumio-pc volumio[740]: info: ___________ START PLUGINS ___________ Mar 29 15:37:50 volumio-pc volumio[740]: info: ControllerMpd::onStart: Initializing MPD Mar 29 15:37:50 volumio-pc volumio[740]: info: Creating MPD Configuration file Mar 29 15:37:50 volumio-pc sudo[1203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 29 15:37:50 volumio-pc sudo[1203]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:50 volumio-pc systemd[1]: Starting Music Player Daemon... Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 15:37:50 volumio-pc volumio[740]: info: [1711723070253] CoreMusicLibrary::Adding element Medienserver Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 15:37:50 volumio-pc sudo[1203]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:50 volumio-pc sudo[1206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 29 15:37:50 volumio-pc sudo[1206]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:37:50 volumio-pc systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 29 15:37:50 volumio-pc systemd[1]: mpd.service: Succeeded. Mar 29 15:37:50 volumio-pc systemd[1]: Stopped Music Player Daemon. Mar 29 15:37:50 volumio-pc systemd[1]: Starting Music Player Daemon... Mar 29 15:37:50 volumio-pc volumio[740]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 15:37:50 volumio-pc volumio[740]: info: [1711723070311] CoreMusicLibrary::Adding element Last_100 Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 15:37:50 volumio-pc volumio[740]: info: [1711723070313] CoreMusicLibrary::Adding element Webradio Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 29 15:37:50 volumio-pc volumio[740]: info: Creating Spotify config file Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 15:37:50 volumio-pc volumio[740]: info: [1711723070367] CoreMusicLibrary::Adding element Radio Paradise Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 15:37:50 volumio-pc volumio[740]: Cannot find translation for source Radio Paradise Mar 29 15:37:50 volumio-pc volumio[740]: info: Volumio Calling Home Mar 29 15:37:50 volumio-pc dhcpcd[616]: eth0: probing address 192.168.188.71/24 Mar 29 15:37:50 volumio-pc volumio[740]: Unhandled rejection Error: No sockets available, cannot start. Mar 29 15:37:50 volumio-pc volumio[740]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Mar 29 15:37:50 volumio-pc volumio[740]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Mar 29 15:37:50 volumio-pc volumio[740]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Mar 29 15:37:50 volumio-pc volumio[740]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Mar 29 15:37:50 volumio-pc volumio[740]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Mar 29 15:37:50 volumio-pc volumio[740]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Mar 29 15:37:50 volumio-pc volumio[740]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Mar 29 15:37:50 volumio-pc volumio[740]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Mar 29 15:37:50 volumio-pc volumio[740]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Mar 29 15:37:50 volumio-pc volumio[740]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Mar 29 15:37:50 volumio-pc volumio[740]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Mar 29 15:37:50 volumio-pc volumio[740]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Mar 29 15:37:50 volumio-pc volumio[740]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Mar 29 15:37:50 volumio-pc volumio[740]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Mar 29 15:37:50 volumio-pc volumio[740]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Mar 29 15:37:50 volumio-pc volumio[740]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Mar 29 15:37:50 volumio-pc volumio[740]: info: An error occurred while refreshing Spotify Token Error: getaddrinfo EBUSY oauth-performer.dfs.volumio.org Mar 29 15:37:50 volumio-pc volumio[740]: info: MPD Permissions set Mar 29 15:37:50 volumio-pc volumio[740]: info: MPD Permissions set Mar 29 15:37:50 volumio-pc volumio[740]: info: VolumeController:: Volume=50 Mute =false Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreStateMachine::pushState Mar 29 15:37:50 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::volumioPushState Mar 29 15:37:50 volumio-pc volumio[740]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Mar 29 15:37:50 volumio-pc volumio[740]: info: Spotify config file written Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc sudo[1219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Mar 29 15:37:50 volumio-pc sudo[1219]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 29 15:37:50 volumio-pc systemd[1]: Started go-librespot Daemon. Mar 29 15:37:50 volumio-pc go-librespot[1226]: Librespot-go daemon starting... Mar 29 15:37:50 volumio-pc sudo[1219]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:37:50 volumio-pc volumio[740]: info: Starting Shairport Sync Mar 29 15:37:50 volumio-pc volumio[740]: info: Starting Shairport Sync Mar 29 15:37:50 volumio-pc go-librespot[1226]: time="2024-03-29T15:37:50+01:00" level=info msg="generated new device id: 69ac0c10e55ae60006a837aa709a41b282d297d0" Mar 29 15:37:50 volumio-pc go-librespot[1226]: time="2024-03-29T15:37:50+01:00" level=debug msg="stored credentials found for mp37529a3pljrc6fal7ljsdbw" Mar 29 15:37:50 volumio-pc sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 29 15:37:50 volumio-pc sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:50 volumio-pc volumio[740]: info: Starting Shairport Sync Mar 29 15:37:50 volumio-pc go-librespot[1226]: time="2024-03-29T15:37:50+01:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Mar 29 15:37:50 volumio-pc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 29 15:37:50 volumio-pc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 29 15:37:50 volumio-pc sudo[1244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 29 15:37:50 volumio-pc sudo[1244]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:50 volumio-pc systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 29 15:37:50 volumio-pc systemd[1]: shairport-sync.service: Succeeded. Mar 29 15:37:50 volumio-pc systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 29 15:37:50 volumio-pc systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 29 15:37:50 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:37:50 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:50 volumio-pc sudo[1244]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:50 volumio-pc sudo[1242]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:50 volumio-pc sudo[1248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 29 15:37:50 volumio-pc sudo[1248]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:50 volumio-pc volumio[740]: info: Shairport-Sync Started Mar 29 15:37:50 volumio-pc systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 29 15:37:50 volumio-pc systemd[1]: shairport-sync.service: Succeeded. Mar 29 15:37:50 volumio-pc systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 29 15:37:50 volumio-pc volumio[740]: Error adding Membership: Error: addMembership EINVAL Mar 29 15:37:50 volumio-pc volumio[740]: info: Shairport-Sync Started Mar 29 15:37:50 volumio-pc systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 29 15:37:50 volumio-pc sudo[1248]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:50 volumio-pc volumio[740]: info: Shairport-Sync Started Mar 29 15:37:51 volumio-pc mpd[1211]: Mar 29 15:37 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 29 15:37:51 volumio-pc volumio[740]: 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 Total Clients: 3 Mar 29 15:37:52 volumio-pc volumio[740]: 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 Total Clients: 4 Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 29 15:37:52 volumio-pc systemd[1]: Started Music Player Daemon. Mar 29 15:37:52 volumio-pc sudo[1206]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:52 volumio-pc sudo[1196]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:52 volumio-pc volumio[740]: info: Completed starting Core Plugins Mar 29 15:37:52 volumio-pc volumio[740]: info: ------------------------------------------- Mar 29 15:37:52 volumio-pc volumio[740]: info: ----- MyVolumio plugins startup ---- Mar 29 15:37:52 volumio-pc volumio[740]: info: ------------------------------------------- Mar 29 15:37:52 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 29 15:37:52 volumio-pc volumio[740]: error: MPD error: The expression evaluated to a falsy value: Mar 29 15:37:52 volumio-pc volumio[740]: assert.ok(self.idling) Mar 29 15:37:52 volumio-pc volumio[740]: error: The expression evaluated to a falsy value: Mar 29 15:37:52 volumio-pc volumio[740]: assert.ok(self.idling) Mar 29 15:37:52 volumio-pc volumio[740]: info: MPD running with PID1211 Mar 29 15:37:52 volumio-pc volumio[740]: ,establishing connection Mar 29 15:37:52 volumio-pc volumio[740]: error: updateQueue error: null Mar 29 15:37:52 volumio-pc volumio[740]: error: updateQueue error: null Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetVisibleSources Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:37:52 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 29 15:37:52 volumio-pc volumio[740]: info: Received Get System Info Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 15:37:52 volumio-pc volumio[740]: info: Discovery: Getting this device information Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:37:52 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:37:52 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:52 volumio-pc volumio[740]: info: Listing playlists Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 29 15:37:52 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 29 15:37:53 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:37:53 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:53 volumio-pc volumio[740]: info: go-librespot daemon successfully initialized Mar 29 15:37:53 volumio-pc systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 29 15:37:53 volumio-pc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Mar 29 15:37:53 volumio-pc systemd[1]: Stopped go-librespot Daemon. Mar 29 15:37:53 volumio-pc systemd[1]: Started go-librespot Daemon. Mar 29 15:37:53 volumio-pc go-librespot[1260]: Librespot-go daemon starting... Mar 29 15:37:53 volumio-pc go-librespot[1260]: time="2024-03-29T15:37:53+01:00" level=info msg="generated new device id: 2eaf6734b180c23b0b318049445e7a1a63932cc8" Mar 29 15:37:53 volumio-pc go-librespot[1260]: time="2024-03-29T15:37:53+01:00" level=debug msg="stored credentials found for mp37529a3pljrc6fal7ljsdbw" Mar 29 15:37:53 volumio-pc go-librespot[1260]: time="2024-03-29T15:37:53+01:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Mar 29 15:37:53 volumio-pc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 29 15:37:53 volumio-pc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 15:37:54 volumio-pc volumio[740]: info: Received Get System Info Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 15:37:54 volumio-pc volumio[740]: info: Discovery: Getting this device information Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:37:54 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 15:37:54 volumio-pc dhcpcd[616]: eth0: leased 192.168.188.71 for 864000 seconds Mar 29 15:37:54 volumio-pc avahi-daemon[499]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.188.71. Mar 29 15:37:54 volumio-pc avahi-daemon[499]: New relevant interface eth0.IPv4 for mDNS. Mar 29 15:37:54 volumio-pc avahi-daemon[499]: Registering new address record for 192.168.188.71 on eth0.IPv4. Mar 29 15:37:54 volumio-pc dhcpcd[616]: eth0: adding route to 192.168.188.0/24 Mar 29 15:37:54 volumio-pc dhcpcd[616]: eth0: adding default route via 192.168.188.1 Mar 29 15:37:54 volumio-pc volumio[740]: verbose: New Socket.io Connection to 192.168.188.71 from 192.168.188.138 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 5 Mar 29 15:37:54 volumio-pc volumio[740]: verbose: New Socket.io Connection to 192.168.188.71 from 192.168.188.138 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 6 Mar 29 15:37:54 volumio-pc volumio[740]: verbose: New Socket.io Connection to 192.168.188.71 from 192.168.188.138 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 7 Mar 29 15:37:54 volumio-pc volumio[740]: verbose: New Socket.io Connection to 192.168.188.71 from 192.168.188.138 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 8 Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetVisibleSources Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:37:54 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:37:54 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 29 15:37:54 volumio-pc volumio[740]: info: Received Get System Info Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 15:37:54 volumio-pc volumio[740]: info: Discovery: Getting this device information Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:37:54 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:37:54 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:54 volumio-pc volumio[740]: info: Listing playlists Mar 29 15:37:54 volumio-pc ntpd[682]: ntpd exiting on signal 15 (Terminated) Mar 29 15:37:54 volumio-pc systemd[1]: Stopping Network Time Service... Mar 29 15:37:54 volumio-pc systemd[1]: ntp.service: Succeeded. Mar 29 15:37:54 volumio-pc systemd[1]: Stopped Network Time Service. Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetQueue Mar 29 15:37:54 volumio-pc volumio[740]: info: CoreStateMachine::getQueue Mar 29 15:37:54 volumio-pc volumio[740]: info: CorePlayQueue::getQueue Mar 29 15:37:54 volumio-pc systemd[1]: Starting Network Time Service... Mar 29 15:37:54 volumio-pc ntpd[1301]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 29 15:37:54 volumio-pc ntpd[1301]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 29 15:37:54 volumio-pc systemd[1]: Started Network Time Service. Mar 29 15:37:54 volumio-pc ntpd[1308]: proto: precision = 0.081 usec (-23) Mar 29 15:37:54 volumio-pc ntpd[1308]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 29 15:37:54 volumio-pc ntpd[1308]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 29 15:37:54 volumio-pc ntpd[1308]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 458 days ago Mar 29 15:37:54 volumio-pc ntpd[1308]: Listen and drop on 0 v6wildcard [::]:123 Mar 29 15:37:54 volumio-pc ntpd[1308]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 29 15:37:54 volumio-pc ntpd[1308]: Listen normally on 2 lo 127.0.0.1:123 Mar 29 15:37:54 volumio-pc ntpd[1308]: Listen normally on 3 eth0 192.168.188.71:123 Mar 29 15:37:54 volumio-pc ntpd[1308]: Listening on routing socket on fd #20 for interface updates Mar 29 15:37:54 volumio-pc ntpd[1308]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 29 15:37:54 volumio-pc ntpd[1308]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 29 15:37:54 volumio-pc sudo[1310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.188.71\INTERNAL/Test /mnt/NAS/Intern Mar 29 15:37:54 volumio-pc sudo[1310]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:54 volumio-pc sudo[1310]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:54 volumio-pc kernel: CIFS: Attempting to mount //192.168.188.71/INTERNAL/Test Mar 29 15:37:54 volumio-pc kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Mar 29 15:37:54 volumio-pc kernel: CIFS: VFS: cifs_mount failed w/return code = -111 Mar 29 15:37:54 volumio-pc sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=wolfgang,password=Anja6536$,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.188.138/Musik /mnt/NAS/Musik Mar 29 15:37:54 volumio-pc sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:54 volumio-pc kernel: CIFS: Attempting to mount //192.168.188.138/Musik Mar 29 15:37:55 volumio-pc volumio[740]: info: Cannot mount NAS Intern at system boot, trial number 2 ,retrying in 5 seconds Mar 29 15:37:55 volumio-pc sudo[1313]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:55 volumio-pc volumio[740]: info: Discovery: adding 34469f6c-43e2-491e-bf49-00ddd513b300 Mar 29 15:37:55 volumio-pc volumio[740]: info: Discovery: Found device Volumio Raspi P3 WZ Mar 29 15:37:55 volumio-pc volumio[740]: info: Discovery: Connecting to remote: 192.168.188.28 Mar 29 15:37:55 volumio-pc volumio[740]: info: Discovery: Connected to remote: 192.168.188.28 Mar 29 15:37:55 volumio-pc volumio[740]: info: Discovery: adding 91dc7bc3-0c07-4074-afdb-cfffe209e1f2 Mar 29 15:37:55 volumio-pc volumio[740]: info: Discovery: Found device Volumio PC Mar 29 15:37:55 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:37:55 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:37:55 volumio-pc ntpd[1308]: Soliciting pool server 162.159.200.1 Mar 29 15:37:56 volumio-pc volumio[740]: info: Initializing connection to go-librespot Websocket Mar 29 15:37:56 volumio-pc volumio[740]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 29 15:37:56 volumio-pc ntpd[1308]: Soliciting pool server 91.107.199.28 Mar 29 15:37:56 volumio-pc ntpd[1308]: Soliciting pool server 80.153.195.191 Mar 29 15:37:57 volumio-pc systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 29 15:37:57 volumio-pc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Mar 29 15:37:57 volumio-pc systemd[1]: Stopped go-librespot Daemon. Mar 29 15:37:57 volumio-pc systemd[1]: Started go-librespot Daemon. Mar 29 15:37:57 volumio-pc go-librespot[1343]: Librespot-go daemon starting... Mar 29 15:37:57 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:57+01:00" level=info msg="generated new device id: b0f14874b76e99c53811a2ad9c9c44cb602682b5" Mar 29 15:37:57 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:57+01:00" level=debug msg="stored credentials found for mp37529a3pljrc6fal7ljsdbw" Mar 29 15:37:57 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:57+01:00" level=debug msg="obtained new client token: AADg/qyK/aGhrXEd/cI6PbR1EL3kpI2/iFgd7Z9o/tLcQn2n5gUqP0bE9ADD8jCUqKrof4ezS5XcW1+g4ouL1OJyPWNeRJ3lchMQcZg0qHRzFkZ2GqYg4bQ2CGLVaQpZ/4wyLdH7/Wts7A5OblUuNVbauXgEXTZ6EqXH7pjmZUseVEX1v93Fwu83uAkiQyFb511Ck5BA8yinxPlkcPXo8/505lP3CEVJ4bMcAMHiM6i4Updp9bLHSCmU60g39CmS" Mar 29 15:37:57 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:57+01:00" 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]" Mar 29 15:37:57 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:57+01:00" level=debug msg="completed keyexchange" Mar 29 15:37:57 volumio-pc sudo[1358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 29 15:37:57 volumio-pc sudo[1358]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:57 volumio-pc sudo[1358]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:57 volumio-pc sudo[1361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 29 15:37:57 volumio-pc sudo[1361]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:57 volumio-pc sudo[1361]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:57 volumio-pc sudo[1366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 29 15:37:57 volumio-pc sudo[1366]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:37:57 volumio-pc systemd[1]: Started UPnP Renderer front-end to MPD. Mar 29 15:37:57 volumio-pc sudo[1366]: pam_unix(sudo:session): session closed for user root Mar 29 15:37:57 volumio-pc volumio[740]: info: Upmpdcli Daemon Started Mar 29 15:37:57 volumio-pc volumio[1368]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 29 15:37:57 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:57+01:00" level=debug msg="completed challenge" Mar 29 15:37:57 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:57+01:00" level=debug msg="authenticated as mp37529a3pljrc6fal7ljsdbw" Mar 29 15:37:57 volumio-pc ntpd[1308]: Soliciting pool server 213.239.234.28 Mar 29 15:37:57 volumio-pc ntpd[1308]: Soliciting pool server 88.198.34.135 Mar 29 15:37:57 volumio-pc volumio[1368]: ......................++++ Mar 29 15:37:57 volumio-pc ntpd[1308]: Soliciting pool server 90.187.112.137 Mar 29 15:37:58 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:58+01:00" level=debug msg="authenticated as mp37529a3pljrc6fal7ljsdbw" Mar 29 15:37:58 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:58+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Mar 29 15:37:58 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:58+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 29 15:37:58 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:58+01:00" level=debug msg="dealer connection opened" Mar 29 15:37:58 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:58+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 29 15:37:58 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:58+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 29 15:37:58 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:58+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 29 15:37:58 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:58+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 29 15:37:58 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:58+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Mar 29 15:37:58 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:58+01:00" level=debug msg="received connection id: NmRhMWZhOGQtYjczOC00MTA1LTk3OGMtZTE2NWMyOWMyYWFkK2RlYWxlcit0Y3A6Ly9nZXc0LWRlYWxlci1hLWw1OHEuZ2V3NC5zcG90aWZ5Lm5ldDo1NzAwKzhCNURCMTQ2NDAyNTFBRDdGNzFBN0U1NEY3MTUyNEU2N0Y2NzIyNzUwNkQzNDQ2Q0EyQTJEQTUzNjg1MkEzNUY=" Mar 29 15:37:58 volumio-pc volumio[740]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 29 15:37:58 volumio-pc go-librespot[1343]: time="2024-03-29T15:37:58+01:00" level=debug msg="put connect state because NEW_DEVICE" Mar 29 15:37:58 volumio-pc nmbd[665]: [2024/03/29 15:37:58.626399, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 29 15:37:58 volumio-pc nmbd[665]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 29 15:37:58 volumio-pc systemd[1]: Started Samba NMB Daemon. Mar 29 15:37:58 volumio-pc nmbd[665]: [2024/03/29 15:37:58.636223, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Mar 29 15:37:58 volumio-pc nmbd[665]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.188.71 for name WORKGROUP<1d>. Mar 29 15:37:58 volumio-pc nmbd[665]: This response was from IP 192.168.188.58, reporting an IP address of 192.168.188.58. Mar 29 15:37:58 volumio-pc systemd[1]: Starting Samba Winbind Daemon... Mar 29 15:37:58 volumio-pc winbindd[1384]: [2024/03/29 15:37:58.803108, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 29 15:37:58 volumio-pc winbindd[1384]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 29 15:37:58 volumio-pc winbindd[1384]: [2024/03/29 15:37:58.810751, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 29 15:37:58 volumio-pc winbindd[1384]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 29 15:37:58 volumio-pc systemd[1]: Started Samba Winbind Daemon. Mar 29 15:37:58 volumio-pc systemd[1]: Starting Samba SMB Daemon... Mar 29 15:37:58 volumio-pc ntpd[1308]: Soliciting pool server 176.9.44.212 Mar 29 15:37:58 volumio-pc ntpd[1308]: Soliciting pool server 162.159.200.123 Mar 29 15:37:58 volumio-pc ntpd[1308]: Soliciting pool server 85.214.133.14 Mar 29 15:37:58 volumio-pc ntpd[1308]: Soliciting pool server 178.63.52.50 Mar 29 15:37:59 volumio-pc smbd[1389]: [2024/03/29 15:37:59.048546, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 29 15:37:59 volumio-pc smbd[1389]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 29 15:37:59 volumio-pc systemd[1]: Started Samba SMB Daemon. Mar 29 15:37:59 volumio-pc systemd[1]: Reached target Multi-User System. Mar 29 15:37:59 volumio-pc systemd[1]: Reached target Graphical Interface. Mar 29 15:37:59 volumio-pc systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 29 15:37:59 volumio-pc systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 29 15:37:59 volumio-pc systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 29 15:37:59 volumio-pc systemd[1]: Startup finished in 6.494s (firmware) + 3.378s (loader) + 16.267s (kernel) + 18.714s (userspace) = 44.855s. Mar 29 15:37:59 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 15:37:59 volumio-pc volumio[1368]: ................................................................................................................................................................++++ Mar 29 15:37:59 volumio-pc volumio[1368]: e is 65537 (0x010001) Mar 29 15:37:59 volumio-pc volumio[1368]: writing RSA key Mar 29 15:37:59 volumio-pc volumio[740]: info: Initializing connection to go-librespot Websocket Mar 29 15:37:59 volumio-pc ntpd[1308]: Soliciting pool server 144.91.116.85 Mar 29 15:37:59 volumio-pc ntpd[1308]: Soliciting pool server 116.202.118.202 Mar 29 15:37:59 volumio-pc ntpd[1308]: Soliciting pool server 178.63.166.157 Mar 29 15:38:00 volumio-pc volumio[740]: info: Received Get System Info Mar 29 15:38:00 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 15:38:00 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 15:38:00 volumio-pc volumio[740]: info: Discovery: Getting this device information Mar 29 15:38:00 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:38:00 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:00 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 15:38:00 volumio-pc sudo[1588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.188.71\INTERNAL/Test /mnt/NAS/Intern Mar 29 15:38:00 volumio-pc sudo[1588]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:00 volumio-pc kernel: CIFS: Attempting to mount //192.168.188.71/INTERNAL/Test Mar 29 15:38:00 volumio-pc smbd[1593]: [2024/03/29 15:38:00.097147, 0] ../source3/param/loadparm.c:3364(process_usershare_file) Mar 29 15:38:00 volumio-pc smbd[1593]: process_usershare_file: stat of /var/lib/samba/usershares/internal failed. Permission denied Mar 29 15:38:00 volumio-pc smbd[1593]: [2024/03/29 15:38:00.097806, 0] ../source3/param/loadparm.c:3364(process_usershare_file) Mar 29 15:38:00 volumio-pc smbd[1593]: process_usershare_file: stat of /var/lib/samba/usershares/internal failed. No such file or directory Mar 29 15:38:00 volumio-pc sudo[1588]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:00 volumio-pc kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.188.71\INTERNAL Mar 29 15:38:00 volumio-pc kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Mar 29 15:38:00 volumio-pc go-librespot[1343]: time="2024-03-29T15:38:00+01:00" level=debug msg="new websocket client" Mar 29 15:38:00 volumio-pc volumio[740]: info: Cannot mount NAS Intern at system boot, trial number 3 ,retrying in 5 seconds Mar 29 15:38:00 volumio-pc volumio[740]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.634&uuid=48ccbd74a51267d6160b97a81734114a" http://updates.volumio.org/downloader-v1/track-device Mar 29 15:38:00 volumio-pc volumio[740]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 29 15:38:00 volumio-pc volumio[740]: Dload Upload Total Spent Left Speed Mar 29 15:38:00 volumio-pc volumio[740]: [132B blob data] Mar 29 15:38:00 volumio-pc volumio[740]: retrying in 5 seconds, trial 0 Mar 29 15:38:00 volumio-pc volumio[740]: info: Volumio Calling Home Mar 29 15:38:00 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 29 15:38:00 volumio-pc volumio[740]: info: Connection to go-librespot Websocket established Mar 29 15:38:00 volumio-pc ntpd[1308]: Soliciting pool server 136.243.202.118 Mar 29 15:38:00 volumio-pc ntpd[1308]: Soliciting pool server 217.197.91.176 Mar 29 15:38:01 volumio-pc volumio[740]: info: Volumio called home Mar 29 15:38:01 volumio-pc ntpd[1308]: Soliciting pool server 2a02:8106:21:9400::1 Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 29 15:38:04 volumio-pc volumio[740]: info: Adding plugin bluetooth to MyMusic Plugins Mar 29 15:38:04 volumio-pc volumio[740]: info: Adding plugin multiroom to MyMusic Plugins Mar 29 15:38:04 volumio-pc volumio[740]: info: Adding plugin metavolumio to MyMusic Plugins Mar 29 15:38:04 volumio-pc volumio[740]: info: Adding plugin cd_controller to MyMusic Plugins Mar 29 15:38:04 volumio-pc volumio[740]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 29 15:38:04 volumio-pc volumio[740]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 29 15:38:04 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:04 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:04 volumio-pc volumio[740]: info: Starting MyVolumio Remote Streaming Endpoints Mar 29 15:38:04 volumio-pc volumio[740]: info: MyVolumio login type: Token Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 29 15:38:04 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 29 15:38:05 volumio-pc volumio[740]: info: Starting Streaming Service Transparent Proxy Mar 29 15:38:05 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 29 15:38:05 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 29 15:38:05 volumio-pc volumio[740]: info: Streaming services startup Mar 29 15:38:05 volumio-pc volumio[740]: info: Starting Streaming Daemon Mar 29 15:38:05 volumio-pc sudo[1605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 29 15:38:05 volumio-pc sudo[1605]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:05 volumio-pc sudo[1605]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:05 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 29 15:38:05 volumio-pc volumio[740]: info: Getting Spotify volume Mar 29 15:38:05 volumio-pc volumio[740]: STREAMING PROXY: Starting server on port 3245 Mar 29 15:38:05 volumio-pc volumio[740]: Node JS runtime: 14 Mar 29 15:38:06 volumio-pc volumio[740]: Cannot compose Albumart path Mar 29 15:38:12 volumio-pc systemd[1]: systemd-fsckd.service: Succeeded. Mar 29 15:38:12 volumio-pc volumio[740]: Cannot compose Albumart path Mar 29 15:38:13 volumio-pc volumio[740]: error: Cannot start Volumio Streaming Daemon Mar 29 15:38:13 volumio-pc volumio[740]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 29 15:38:13 volumio-pc volumio[740]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 29 15:38:13 volumio-pc sudo[1612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.188.71\INTERNAL/Test /mnt/NAS/Intern Mar 29 15:38:13 volumio-pc sudo[1612]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:13 volumio-pc kernel: CIFS: Attempting to mount //192.168.188.71/INTERNAL/Test Mar 29 15:38:13 volumio-pc smbd[1617]: [2024/03/29 15:38:13.319892, 0] ../source3/param/loadparm.c:3364(process_usershare_file) Mar 29 15:38:13 volumio-pc smbd[1617]: process_usershare_file: stat of /var/lib/samba/usershares/internal failed. Permission denied Mar 29 15:38:13 volumio-pc smbd[1617]: [2024/03/29 15:38:13.321465, 0] ../source3/param/loadparm.c:3364(process_usershare_file) Mar 29 15:38:13 volumio-pc smbd[1617]: process_usershare_file: stat of /var/lib/samba/usershares/internal failed. No such file or directory Mar 29 15:38:13 volumio-pc sudo[1612]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:13 volumio-pc kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.188.71\INTERNAL Mar 29 15:38:13 volumio-pc kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:13 volumio-pc volumio[740]: info: Retrieving Cloud Streaming UI Mar 29 15:38:13 volumio-pc volumio[740]: info: Spotify volume: 100 Mar 29 15:38:13 volumio-pc volumio[740]: verbose: New Socket.io Connection to 192.168.188.71:3000 from 192.168.188.28 UA: node-XMLHttpRequest Total Clients: 9 Mar 29 15:38:13 volumio-pc volumio[740]: verbose: New Socket.io Connection to 192.168.188.71:3000 from 192.168.188.28 UA: node-XMLHttpRequest Total Clients: 10 Mar 29 15:38:13 volumio-pc volumio[740]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 11 Mar 29 15:38:13 volumio-pc volumio[740]: info: Cannot mount NAS Intern at system boot, trial number 4 ,retrying in 5 seconds Mar 29 15:38:13 volumio-pc volumio[740]: info: Getting Tidal Cloud Configuration Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:13 volumio-pc volumio[740]: info: Getting Qobuz Cloud Configuration Mar 29 15:38:13 volumio-pc volumio[740]: info: Asking plugin for UI Config Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:13 volumio-pc volumio[740]: info: Getting Spotify Cloud Configuration Mar 29 15:38:13 volumio-pc volumio[740]: info: Asking plugin for UI Config Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:13 volumio-pc volumio[740]: info: Saving Spotify Acccount Mar 29 15:38:13 volumio-pc volumio[740]: info: Got Tidal Cloud Configuration Mar 29 15:38:13 volumio-pc volumio[740]: info: Got it Mar 29 15:38:13 volumio-pc volumio[740]: info: Got it Mar 29 15:38:13 volumio-pc volumio[740]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:13 volumio-pc volumio[740]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Mar 29 15:38:13 volumio-pc volumio[740]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:38:13 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:38:13 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:13 volumio-pc volumio[740]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Mar 29 15:38:13 volumio-pc volumio[740]: SPOTIFY: SPOTIFY VOLUME 100 Mar 29 15:38:13 volumio-pc volumio[740]: SPOTIFY: VOLUMIO VOLUME 50 Mar 29 15:38:13 volumio-pc volumio[740]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 29 15:38:13 volumio-pc volumio[740]: info: Setting Spotify Volume from Volumio: 50 Mar 29 15:38:13 volumio-pc volumio[740]: info: Received Get System Version Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetBrowseSources Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetBrowseSources Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetBrowseSources Mar 29 15:38:13 volumio-pc volumio[740]: info: Received Get System Info Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 15:38:13 volumio-pc volumio[740]: info: Discovery: Getting this device information Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:38:13 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 15:38:13 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:38:13 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:13 volumio-pc volumio[740]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 29 15:38:14 volumio-pc volumio[740]: info: MyVolumio token set successfully Mar 29 15:38:14 volumio-pc volumio[740]: info: MYVOLUMIO: Adding device Mar 29 15:38:14 volumio-pc volumio[740]: info: MYVOLUMIO: Evaluating Server Mar 29 15:38:14 volumio-pc volumio[740]: info: MyVolumio Plan changed: premium Mar 29 15:38:14 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Mar 29 15:38:14 volumio-pc volumio[740]: info: Removing browser output: myVolumio user plan is not superstar Mar 29 15:38:14 volumio-pc volumio[740]: info: Removing audio output: Mar 29 15:38:14 volumio-pc volumio[740]: info: MYVOLUMIO: Adding device Mar 29 15:38:14 volumio-pc volumio[740]: info: MYVOLUMIO: Evaluating Server Mar 29 15:38:14 volumio-pc volumio[740]: info: Remote config written successfully Mar 29 15:38:14 volumio-pc volumio[740]: info: Starting Tunnel 1 Mar 29 15:38:14 volumio-pc volumio[740]: info: Starting Tunnel Connection Checker Mar 29 15:38:14 volumio-pc volumio[740]: info: Completed starting MyVolumio Plugin Mar 29 15:38:15 volumio-pc volumio[740]: SPOTIFY: SETTING SPOTIFY VOLUME 50 Mar 29 15:38:15 volumio-pc volumio[740]: info: Sending Spotify command with payload to local API: /player/volume Mar 29 15:38:15 volumio-pc volumio[740]: info: MYVolumio Device enabled Mar 29 15:38:15 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Mar 29 15:38:15 volumio-pc volumio[740]: info: MyVolumio status changed Mar 29 15:38:15 volumio-pc volumio[740]: info: Streaming services startup Mar 29 15:38:15 volumio-pc volumio[740]: info: Starting Streaming Daemon Mar 29 15:38:15 volumio-pc volumio[740]: info: Setting Geolocation for MyVolumio to eu6 Mar 29 15:38:15 volumio-pc sudo[1652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 29 15:38:15 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:15 volumio-pc sudo[1652]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:15 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:15 volumio-pc go-librespot[1343]: time="2024-03-29T15:38:15+01:00" level=debug msg="update volume to 32767/65535" Mar 29 15:38:15 volumio-pc sudo[1652]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:15 volumio-pc volumio[740]: error: Cannot start Volumio Streaming Daemon Mar 29 15:38:15 volumio-pc volumio[740]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 29 15:38:15 volumio-pc volumio[740]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 29 15:38:15 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Mar 29 15:38:15 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Mar 29 15:38:15 volumio-pc volumio[740]: info: [1711723095247] Starting BluetoothController Mar 29 15:38:15 volumio-pc go-librespot[1343]: time="2024-03-29T15:38:15+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Mar 29 15:38:15 volumio-pc go-librespot[1343]: time="2024-03-29T15:38:15+01:00" level=trace msg="emitting websocket event: volume" Mar 29 15:38:15 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Mar 29 15:38:16 volumio-pc sudo[1655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Mar 29 15:38:16 volumio-pc sudo[1655]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:16 volumio-pc sudo[1655]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: MultiRoom plugin initialized Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: STOPPING SNAPCLIENT Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: Snap server stop Mar 29 15:38:16 volumio-pc sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Mar 29 15:38:16 volumio-pc sudo[1671]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: STOPPING volumioStreaming Mar 29 15:38:16 volumio-pc sudo[1671]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:16 volumio-pc sudo[1674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Mar 29 15:38:16 volumio-pc sudo[1674]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:16 volumio-pc sudo[1674]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:16 volumio-pc sudo[1677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 29 15:38:16 volumio-pc sudo[1677]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Mar 29 15:38:16 volumio-pc sudo[1677]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:16 volumio-pc sudo[1680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 29 15:38:16 volumio-pc sudo[1680]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:16 volumio-pc sudo[1680]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Mar 29 15:38:16 volumio-pc volumio[740]: info: Preparing to generate the ALSA configuration file Mar 29 15:38:16 volumio-pc volumio[740]: info: Updating MyVolumio device info Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 29 15:38:16 volumio-pc volumio[740]: info: Reading ALSA contributions from plugins. Mar 29 15:38:16 volumio-pc volumio[740]: SPOTIFY: received: {"type":"volume","data":{"value":50,"max":100}} Mar 29 15:38:16 volumio-pc volumio[740]: SPOTIFY: RECEIVED SPOTIFY VOLUME 50 Mar 29 15:38:16 volumio-pc volumio[740]: info: Setting Geolocation for MyVolumio to eu4 Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: Removed streaming files Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: volumioStreaming STOPPED Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: SNAPSERVER STOPPED Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: SNAPCLIENT STOPPED Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:16 volumio-pc volumio[740]: info: Retrieving Cloud Streaming UI Mar 29 15:38:16 volumio-pc volumio[740]: info: Getting Tidal Cloud Configuration Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:16 volumio-pc volumio[740]: info: Getting Qobuz Cloud Configuration Mar 29 15:38:16 volumio-pc volumio[740]: info: Asking plugin for UI Config Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:16 volumio-pc volumio[740]: info: Getting Spotify Cloud Configuration Mar 29 15:38:16 volumio-pc volumio[740]: info: Asking plugin for UI Config Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:16 volumio-pc volumio[740]: info: Saving Spotify Acccount Mar 29 15:38:16 volumio-pc volumio[740]: info: Got it Mar 29 15:38:16 volumio-pc volumio[740]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 29 15:38:16 volumio-pc volumio[740]: info: Got Tidal Cloud Configuration Mar 29 15:38:16 volumio-pc volumio[740]: info: Asound.conf file written Mar 29 15:38:16 volumio-pc sudo[1683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 29 15:38:16 volumio-pc sudo[1683]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:16 volumio-pc sudo[1683]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:16 volumio-pc volumio[740]: info: Output device has changed, restarting MPD Mar 29 15:38:16 volumio-pc sudo[1688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 29 15:38:16 volumio-pc sudo[1688]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:16 volumio-pc sudo[1688]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:16 volumio-pc volumio[740]: info: Output device has changed, restarting Shairport Sync Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:16 volumio-pc sudo[1691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 29 15:38:16 volumio-pc sudo[1691]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:16 volumio-pc systemd[1]: Stopping Music Player Daemon... Mar 29 15:38:16 volumio-pc volumio[740]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 29 15:38:16 volumio-pc systemd[1]: mpd.service: Succeeded. Mar 29 15:38:16 volumio-pc systemd[1]: Stopped Music Player Daemon. Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output for this device Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output Mar 29 15:38:16 volumio-pc sudo[1699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio PC Mar 29 15:38:16 volumio-pc sudo[1699]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding audio output: Mar 29 15:38:16 volumio-pc sudo[1699]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:16 volumio-pc systemd[1]: Starting Music Player Daemon... Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding METAVOLUMIO REST API Endpoints Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding Manifest REST API Endpoints Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Mar 29 15:38:16 volumio-pc volumio[740]: info: Preparing CD Folders Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding CD REST API Endpoints Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Mar 29 15:38:16 volumio-pc volumio[740]: info: Starting UDEV Watcher for CD Mar 29 15:38:16 volumio-pc volumio[740]: info: Detecting CD presence with UDEV Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding inputs REST Endpoints Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Mar 29 15:38:16 volumio-pc volumio[740]: info: Scanning Audio Inputs Mar 29 15:38:16 volumio-pc volumio[740]: info: Checking against Known Cards name Mar 29 15:38:16 volumio-pc volumio[740]: info: Checking against Known Cards name Mar 29 15:38:16 volumio-pc volumio[740]: info: Checking against Known Cards name Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding Server instance for streaming Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Mar 29 15:38:16 volumio-pc volumio[740]: error: Hi Res Audio Failed Login: Missing Login Data Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding HIGHRESAUDIO REST API Endpoints Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Mar 29 15:38:16 volumio-pc volumio[740]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Mar 29 15:38:16 volumio-pc sudo[1708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 29 15:38:16 volumio-pc sudo[1708]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:16 volumio-pc volumio[740]: info: Stopping AccessToken refresher cron Mar 29 15:38:16 volumio-pc sudo[1708]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:16 volumio-pc volumio[740]: info: AccessToken refresher cron started Mar 29 15:38:16 volumio-pc volumio[740]: info: Stopping AccessToken refresher cron for QOBUZ Mar 29 15:38:16 volumio-pc volumio[740]: info: AccessToken refresher cron started for QOBUZ Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding TIDAL REST API Endpoints Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding QOBUZ REST API Endpoints Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Mar 29 15:38:16 volumio-pc volumio[740]: info: Got it Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 15:38:16 volumio-pc volumio[740]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'Volumio PC' Mar 29 15:38:16 volumio-pc volumio[740]: Can't get device info: No such device Mar 29 15:38:16 volumio-pc volumio[740]: info: MPD Permissions set Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 29 15:38:16 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: Adding multiroomSync output Mar 29 15:38:16 volumio-pc volumio[740]: info: Adding audio output: Mar 29 15:38:16 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output Mar 29 15:38:16 volumio-pc volumio[740]: info: Starting Shairport Sync Mar 29 15:38:17 volumio-pc sudo[1720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 29 15:38:17 volumio-pc sudo[1720]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:17 volumio-pc volumio[740]: info: MRS: Found cast device: B8405-83295070e909c325cce0845157749b40 Mar 29 15:38:17 volumio-pc volumio[740]: info: Adding audio output: Mar 29 15:38:17 volumio-pc systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 29 15:38:17 volumio-pc systemd[1]: shairport-sync.service: Succeeded. Mar 29 15:38:17 volumio-pc systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetBrowseSources Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetBrowseSources Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetBrowseSources Mar 29 15:38:17 volumio-pc volumio[740]: info: MRS: Found cast device: TPM191E-012cfbfd74f63e765ed9fc81f32cce81 Mar 29 15:38:17 volumio-pc volumio[740]: info: Adding audio output: Mar 29 15:38:17 volumio-pc systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 29 15:38:17 volumio-pc sudo[1720]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:17 volumio-pc volumio[740]: info: Shairport-Sync Started Mar 29 15:38:17 volumio-pc volumio[740]: info: Successfully Added MyVolumio device Mar 29 15:38:17 volumio-pc volumio[740]: info: Successfully Updated MyVolumio device Mar 29 15:38:17 volumio-pc mpd[1700]: Mar 29 15:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 29 15:38:17 volumio-pc volumio[740]: info: Successfully Added MyVolumio device Mar 29 15:38:17 volumio-pc volumio[740]: info: Updating MyVolumio device info Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 29 15:38:17 volumio-pc volumio[740]: error: MPD error: Error: This socket has been ended by the other party Mar 29 15:38:17 volumio-pc volumio[740]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 29 15:38:17 volumio-pc volumio[740]: error: MPD error: Error: This socket has been ended by the other party Mar 29 15:38:17 volumio-pc volumio[740]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 29 15:38:17 volumio-pc volumio[740]: error: MPD error: Error: This socket has been ended by the other party Mar 29 15:38:17 volumio-pc volumio[740]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 29 15:38:17 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 29 15:38:17 volumio-pc volumio[740]: info: Successfully Updated MyVolumio device Mar 29 15:38:18 volumio-pc systemd[1]: systemd-hostnamed.service: Succeeded. Mar 29 15:38:18 volumio-pc sudo[1735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.188.71\INTERNAL/Test /mnt/NAS/Intern Mar 29 15:38:18 volumio-pc sudo[1735]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:18 volumio-pc kernel: CIFS: Attempting to mount //192.168.188.71/INTERNAL/Test Mar 29 15:38:18 volumio-pc smbd[1740]: [2024/03/29 15:38:18.457736, 0] ../source3/param/loadparm.c:3364(process_usershare_file) Mar 29 15:38:18 volumio-pc smbd[1740]: process_usershare_file: stat of /var/lib/samba/usershares/internal failed. Permission denied Mar 29 15:38:18 volumio-pc kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.188.71\INTERNAL Mar 29 15:38:18 volumio-pc kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Mar 29 15:38:18 volumio-pc smbd[1740]: [2024/03/29 15:38:18.458453, 0] ../source3/param/loadparm.c:3364(process_usershare_file) Mar 29 15:38:18 volumio-pc smbd[1740]: process_usershare_file: stat of /var/lib/samba/usershares/internal failed. No such file or directory Mar 29 15:38:18 volumio-pc sudo[1735]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:18 volumio-pc volumio[740]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Mar 29 15:38:18 volumio-pc systemd[1]: Started Music Player Daemon. Mar 29 15:38:18 volumio-pc sudo[1691]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:18 volumio-pc volumio[740]: error: updateQueue error: null Mar 29 15:38:19 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 29 15:38:19 volumio-pc sudo[1744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Mar 29 15:38:19 volumio-pc sudo[1744]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:19 volumio-pc volumio[740]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 12 Mar 29 15:38:19 volumio-pc systemd[1]: Started Volumio Bluetooth Module. Mar 29 15:38:19 volumio-pc sudo[1744]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:19 volumio-pc sudo[1748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Mar 29 15:38:19 volumio-pc sudo[1748]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:19 volumio-pc volumiobt[1746]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Mar 29 15:38:19 volumio-pc sudo[1748]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:19 volumio-pc volumio[740]: info: Volumio BT Module successfully started Mar 29 15:38:19 volumio-pc volumio[740]: info: TidalConnect service stoped! Mar 29 15:38:19 volumio-pc sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Mar 29 15:38:19 volumio-pc sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:19 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:38:19 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:19 volumio-pc systemd[1]: Started MyVolumio SSH Tunnel. Mar 29 15:38:19 volumio-pc sudo[1755]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:19 volumio-pc volumio[740]: info: Remote SSH Started Mar 29 15:38:19 volumio-pc autossh[1763]: port set to 0, monitoring disabled Mar 29 15:38:19 volumio-pc autossh[1763]: starting ssh (count 1) Mar 29 15:38:19 volumio-pc autossh[1763]: ssh child pid is 1769 Mar 29 15:38:19 volumio-pc volumio[740]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 29 15:38:19 volumio-pc volumio[740]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 29 15:38:19 volumio-pc volumio[740]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 Mar 29 15:38:20 volumio-pc sudo[1771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 29 15:38:20 volumio-pc sudo[1771]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetState Mar 29 15:38:20 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:20 volumio-pc systemd[1]: Started Volumio Tidal Connect Service. Mar 29 15:38:20 volumio-pc sudo[1771]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:20 volumio-pc volumio[740]: info: Executing endpoint tc_getconfig Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 29 15:38:20 volumio-pc vtcs[1773]: STARTING TidalConnect services, version: 1.3.0.19 Mar 29 15:38:20 volumio-pc vtcs[1773]: STARTED TidalConnect services. Mar 29 15:38:20 volumio-pc volumio[740]: info: Executing endpoint tc_connect Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 29 15:38:20 volumio-pc volumio[740]: info: Connecting to TidalConnect Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::servicePushState Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreStateMachine::pushState Mar 29 15:38:20 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::volumioPushState Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output update for this device Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output Mar 29 15:38:20 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:20 volumio-pc volumio[740]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Mar 29 15:38:20 volumio-pc volumio[740]: verbose: CURRENT POSITION 0 Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreStateMachine::syncState stateService stop Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreStateMachine::syncState currentStatus stop Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreStateMachine::pushState Mar 29 15:38:20 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::volumioPushState Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output update for this device Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output Mar 29 15:38:20 volumio-pc volumio[740]: info: No code Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreStateMachine::pushState Mar 29 15:38:20 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::volumioPushState Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output update for this device Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::servicePushState Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreStateMachine::pushState Mar 29 15:38:20 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::volumioPushState Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output update for this device Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output Mar 29 15:38:20 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:20 volumio-pc volumio[740]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Mar 29 15:38:20 volumio-pc volumio[740]: verbose: CURRENT POSITION 0 Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreStateMachine::syncState stateService stop Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreStateMachine::syncState currentStatus stop Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreStateMachine::pushState Mar 29 15:38:20 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::volumioPushState Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output update for this device Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output Mar 29 15:38:20 volumio-pc volumio[740]: info: No code Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreStateMachine::pushState Mar 29 15:38:20 volumio-pc volumio[740]: info: CorePlayQueue::getTrack 0 Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::volumioPushState Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output update for this device Mar 29 15:38:20 volumio-pc volumio[740]: info: MRS: Pushing multiroomSync output Mar 29 15:38:20 volumio-pc volumio[740]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Mar 29 15:38:20 volumio-pc volumiossh-tunnel[1758]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts. Mar 29 15:38:20 volumio-pc volumio[740]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Mar 29 15:38:20 volumio-pc volumio[740]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Mar 29 15:38:20 volumio-pc volumio[740]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 29 15:38:20 volumio-pc volumio-remote-updater[501]: No test mode Mar 29 15:38:20 volumio-pc volumio-remote-updater[501]: No alpha test mode Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 29 15:38:20 volumio-pc volumio[740]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 29 15:38:20 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 15:38:20 volumio-pc sudo[1794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Mar 29 15:38:20 volumio-pc sudo[1794]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 15:38:20 volumio-pc volumiobt[1746]: pulseaudio: no process found Mar 29 15:38:20 volumio-pc sudo[1794]: pam_unix(sudo:session): session closed for user root Mar 29 15:38:20 volumio-pc dbus-daemon[483]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.24' (uid=1000 pid=1798 comm="/usr/bin/pulseaudio --high-priority=true ") Mar 29 15:38:20 volumio-pc systemd[1]: Starting RealtimeKit Scheduling Policy Service... Mar 29 15:38:20 volumio-pc volumio[740]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 29 15:38:20 volumio-pc dbus-daemon[483]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Mar 29 15:38:20 volumio-pc systemd[1]: Started RealtimeKit Scheduling Policy Service. Mar 29 15:38:20 volumio-pc rtkit-daemon[1799]: Successfully called chroot. Mar 29 15:38:20 volumio-pc rtkit-daemon[1799]: Successfully dropped privileges. Mar 29 15:38:20 volumio-pc rtkit-daemon[1799]: Successfully limited resources. Mar 29 15:38:20 volumio-pc rtkit-daemon[1799]: Running. Mar 29 15:38:20 volumio-pc rtkit-daemon[1799]: Canary thread running. Mar 29 15:38:20 volumio-pc rtkit-daemon[1799]: Watchdog thread running. Mar 29 15:38:20 volumio-pc dbus-daemon[483]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.25' (uid=0 pid=1799 comm="/usr/lib/rtkit/rtkit-daemon ") Mar 29 15:38:20 volumio-pc systemd[1]: Starting Authorization Manager... Mar 29 15:38:20 volumio-pc volumio[740]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 29 15:38:20 volumio-pc polkitd[1802]: started daemon version 0.105 using authority implementation `local' version `0.105' Mar 29 15:38:20 volumio-pc dbus-daemon[483]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Mar 29 15:38:20 volumio-pc systemd[1]: Started Authorization Manager. Mar 29 15:38:21 volumio-pc pulseaudio[1798]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 29 15:38:21 volumio-pc pulseaudio[1798]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 29 15:38:21 volumio-pc pulseaudio[1798]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Mar 29 15:38:21 volumio-pc volumiobt[1746]: Applying permissions Mar 29 15:38:21 volumio-pc volumiobt[1746]: Setting BT discoverable and pairable Mar 29 15:38:21 volumio-pc volumiobt[1746]: Agent registered Mar 29 15:38:21 volumio-pc volumiobt[1746]: [bluetooth]# -e power on Mar 29 15:38:21 volumio-pc volumiobt[1746]: Invalid command in menu main: -e Mar 29 15:38:21 volumio-pc volumiobt[1746]: Mar 29 15:38:21 volumio-pc volumiobt[1746]: Use "help" for a list of available commands in a menu. Mar 29 15:38:21 volumio-pc volumiobt[1746]: Use "menu " if you want to enter any submenu. Mar 29 15:38:21 volumio-pc volumiobt[1746]: Use "back" if you want to return to menu main. Mar 29 15:38:21 volumio-pc volumiobt[1746]: [bluetooth]# agent on Mar 29 15:38:21 volumio-pc volumiobt[1746]: Agent is already registered Mar 29 15:38:21 volumio-pc volumiobt[1746]: [bluetooth]# discoverable on Mar 29 15:38:21 volumio-pc volumiobt[1746]: No default controller available Mar 29 15:38:21 volumio-pc volumiobt[1746]: [bluetooth]# pairable on Mar 29 15:38:21 volumio-pc volumiobt[1746]: No default controller available Mar 29 15:38:21 volumio-pc volumiobt[1746]: [bluetooth]# agent NoInputNoOutput Mar 29 15:38:21 volumio-pc volumiobt[1746]: Agent is already registered Mar 29 15:38:21 volumio-pc volumiobt[1746]: [bluetooth]# default-agent Mar 29 15:38:21 volumio-pc volumiobt[1746]: [bluetooth]# quit Mar 29 15:38:21 volumio-pc volumiobt[1746]: [59B blob data] Mar 29 15:38:21 volumio-pc volumio[740]: info: MRS: Getting audio outputs on start Mar 29 15:38:21 volumio-pc volumio[740]: info: MRS: Requesting all other devices output Mar 29 15:38:21 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 29 15:38:23 volumio-pc volumio[740]: info: TidalConnect service started! Mar 29 15:38:23 volumio-pc volumio[740]: info: BOOT COMPLETED Mar 29 15:38:23 volumio-pc volumio[740]: [Metrics] CommandRouter: 37s 902.63ms Mar 29 15:38:23 volumio-pc volumio[740]: info: CoreCommandRouter::volumiosetStartupVolume Mar 29 15:38:23 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:23 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 15:38:23 volumio-pc volumio[740]: info: CoreCommandRouter::Close All Modals sent Mar 29 15:38:23 volumio-pc volumio[740]: info: CoreCommandRouter::Close All Modals sent Mar 29 15:38:24 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 29 15:38:24 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 29 15:38:24 volumio-pc volumio[740]: No protocol specified Mar 29 15:38:24 volumio-pc volumio[740]: xcb_connection_has_error() returned true Mar 29 15:38:24 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 29 15:38:24 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:24 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 15:38:24 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 29 15:38:24 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 29 15:38:24 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 29 15:38:24 volumio-pc volumio[740]: info: CoreCommandRouter::volumioGetBrowseSources Mar 29 15:38:24 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 29 15:38:25 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 29 15:38:29 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 29 15:38:33 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Mar 29 15:38:33 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 29 15:38:34 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 29 15:38:37 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Mar 29 15:38:37 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Mar 29 15:38:37 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 29 15:38:39 volumio-pc volumio[740]: info: Error browsing device GBUE4K for shares : Error: Command failed: echo volumio | smbclient -L gbue4k.local. Mar 29 15:38:39 volumio-pc volumio[740]: Unable to initialize messaging context Mar 29 15:38:39 volumio-pc volumio[740]: info: Error browsing device 192-168-188-1 for shares : Error: Command failed: echo volumio | smbclient -L fritz.box. Mar 29 15:38:39 volumio-pc volumio[740]: Unable to initialize messaging context Mar 29 15:38:41 volumio-pc volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 29 15:38:42 volumio-pc volumiologrotate[487]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Mar 29 15:38:42 volumio-pc volumiologrotate[487]: ls: cannot access 'PC': No such file or directory Mar 29 15:38:43 volumio-pc volumio[740]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 15:38:43 volumio-pc volumio[740]: Error: dns service error: unknown Mar 29 15:38:43 volumio-pc volumio[740]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Mar 29 15:38:43 volumio-pc volumio[740]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Mar 29 15:38:43 volumio-pc volumio[740]: errorCode: -65537 Mar 29 15:38:43 volumio-pc volumio[740]: } Mar 29 15:38:43 volumio-pc volumio[740]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 15:38:43 volumio-pc sudo[1894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-29 15:37 Mar 29 15:38:43 volumio-pc sudo[1894]: 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="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET" VOLUMIO_VERSION="3.634" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"