-- Logs begin at Fri 2024-07-26 21:27:18 UTC, end at Sat 2024-07-27 05:27:08 UTC. --
Jul 27 05:26:51 hanvolumio kernel: Linux version 6.6.31-volumio (gkkpch@UbuntuVM24.04) (gcc (Ubuntu 13.2.0-23ubuntu4) 13.2.0, GNU ld (GNU Binutils for Ubuntu) 2.42) #2 SMP PREEMPT_DYNAMIC Fri May 17 18:26:28 CEST 2024
Jul 27 05:26:51 hanvolumio kernel: Command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=668afdde-eb8b-48b3-b8ac-1f0a643965c0 bootpart=UUID=9561-A5F0 datapart=UUID=0f08d23f-00cb-42b9-914c-9463e5fce58b hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no initrd=volumio.initrd
Jul 27 05:26:51 hanvolumio kernel: KERNEL supported cpus:
Jul 27 05:26:51 hanvolumio kernel: Intel GenuineIntel
Jul 27 05:26:51 hanvolumio kernel: AMD AuthenticAMD
Jul 27 05:26:51 hanvolumio kernel: Hygon HygonGenuine
Jul 27 05:26:51 hanvolumio kernel: Centaur CentaurHauls
Jul 27 05:26:51 hanvolumio kernel: zhaoxin Shanghai
Jul 27 05:26:51 hanvolumio kernel: BIOS-provided physical RAM map:
Jul 27 05:26:51 hanvolumio kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
Jul 27 05:26:51 hanvolumio kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
Jul 27 05:26:51 hanvolumio kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
Jul 27 05:26:51 hanvolumio kernel: BIOS-e820: [mem 0x0000000000100000-0x000000007ffeffff] usable
Jul 27 05:26:51 hanvolumio kernel: BIOS-e820: [mem 0x000000007fff0000-0x000000007fffffff] ACPI data
Jul 27 05:26:51 hanvolumio kernel: BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved
Jul 27 05:26:51 hanvolumio kernel: BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved
Jul 27 05:26:51 hanvolumio kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
Jul 27 05:26:51 hanvolumio kernel: NX (Execute Disable) protection: active
Jul 27 05:26:51 hanvolumio kernel: APIC: Static calls initialized
Jul 27 05:26:51 hanvolumio kernel: SMBIOS 2.5 present.
Jul 27 05:26:51 hanvolumio kernel: DMI: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006
Jul 27 05:26:51 hanvolumio kernel: Hypervisor detected: KVM
Jul 27 05:26:51 hanvolumio kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00
Jul 27 05:26:51 hanvolumio kernel: kvm-clock: using sched offset of 5403836095 cycles
Jul 27 05:26:51 hanvolumio kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
Jul 27 05:26:51 hanvolumio kernel: tsc: Detected 3417.598 MHz processor
Jul 27 05:26:51 hanvolumio kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Jul 27 05:26:51 hanvolumio kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
Jul 27 05:26:51 hanvolumio kernel: last_pfn = 0x7fff0 max_arch_pfn = 0x400000000
Jul 27 05:26:51 hanvolumio kernel: MTRRs disabled by BIOS
Jul 27 05:26:51 hanvolumio kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT
Jul 27 05:26:51 hanvolumio kernel: found SMP MP-table at [mem 0x0009fff0-0x0009ffff]
Jul 27 05:26:51 hanvolumio kernel: Incomplete global flushes, disabling PCID
Jul 27 05:26:51 hanvolumio kernel: RAMDISK: [mem 0x7bd6d000-0x7ffeffff]
Jul 27 05:26:51 hanvolumio kernel: ACPI: Early table checksum verification disabled
Jul 27 05:26:51 hanvolumio kernel: ACPI: RSDP 0x00000000000E0000 000024 (v02 VBOX )
Jul 27 05:26:51 hanvolumio kernel: ACPI: XSDT 0x000000007FFF0030 00003C (v01 VBOX VBOXXSDT 00000001 ASL 00000061)
Jul 27 05:26:51 hanvolumio kernel: ACPI: FACP 0x000000007FFF00F0 0000F4 (v04 VBOX VBOXFACP 00000001 ASL 00000061)
Jul 27 05:26:51 hanvolumio kernel: ACPI: DSDT 0x000000007FFF0610 002353 (v02 VBOX VBOXBIOS 00000002 INTL 20100528)
Jul 27 05:26:51 hanvolumio kernel: ACPI: FACS 0x000000007FFF0200 000040
Jul 27 05:26:51 hanvolumio kernel: ACPI: FACS 0x000000007FFF0200 000040
Jul 27 05:26:51 hanvolumio kernel: ACPI: APIC 0x000000007FFF0240 000054 (v02 VBOX VBOXAPIC 00000001 ASL 00000061)
Jul 27 05:26:51 hanvolumio kernel: ACPI: SSDT 0x000000007FFF02A0 00036C (v01 VBOX VBOXCPUT 00000002 INTL 20100528)
Jul 27 05:26:51 hanvolumio kernel: ACPI: Reserving FACP table memory at [mem 0x7fff00f0-0x7fff01e3]
Jul 27 05:26:51 hanvolumio kernel: ACPI: Reserving DSDT table memory at [mem 0x7fff0610-0x7fff2962]
Jul 27 05:26:51 hanvolumio kernel: ACPI: Reserving FACS table memory at [mem 0x7fff0200-0x7fff023f]
Jul 27 05:26:51 hanvolumio kernel: ACPI: Reserving FACS table memory at [mem 0x7fff0200-0x7fff023f]
Jul 27 05:26:51 hanvolumio kernel: ACPI: Reserving APIC table memory at [mem 0x7fff0240-0x7fff0293]
Jul 27 05:26:51 hanvolumio kernel: ACPI: Reserving SSDT table memory at [mem 0x7fff02a0-0x7fff060b]
Jul 27 05:26:51 hanvolumio kernel: Zone ranges:
Jul 27 05:26:51 hanvolumio kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff]
Jul 27 05:26:51 hanvolumio kernel: DMA32 [mem 0x0000000001000000-0x000000007ffeffff]
Jul 27 05:26:51 hanvolumio kernel: Normal empty
Jul 27 05:26:51 hanvolumio kernel: Movable zone start for each node
Jul 27 05:26:51 hanvolumio kernel: Early memory node ranges
Jul 27 05:26:51 hanvolumio kernel: node 0: [mem 0x0000000000001000-0x000000000009efff]
Jul 27 05:26:51 hanvolumio kernel: node 0: [mem 0x0000000000100000-0x000000007ffeffff]
Jul 27 05:26:51 hanvolumio kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffeffff]
Jul 27 05:26:51 hanvolumio kernel: On node 0, zone DMA: 1 pages in unavailable ranges
Jul 27 05:26:51 hanvolumio kernel: On node 0, zone DMA: 97 pages in unavailable ranges
Jul 27 05:26:51 hanvolumio kernel: On node 0, zone DMA32: 16 pages in unavailable ranges
Jul 27 05:26:51 hanvolumio kernel: ACPI: PM-Timer IO Port: 0x4008
Jul 27 05:26:51 hanvolumio kernel: IOAPIC[0]: apic_id 1, version 32, address 0xfec00000, GSI 0-23
Jul 27 05:26:51 hanvolumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
Jul 27 05:26:51 hanvolumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 low level)
Jul 27 05:26:51 hanvolumio kernel: ACPI: Using ACPI (MADT) for SMP configuration information
Jul 27 05:26:51 hanvolumio kernel: smpboot: Allowing 1 CPUs, 0 hotplug CPUs
Jul 27 05:26:51 hanvolumio kernel: PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
Jul 27 05:26:51 hanvolumio kernel: PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
Jul 27 05:26:51 hanvolumio kernel: PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000effff]
Jul 27 05:26:51 hanvolumio kernel: PM: hibernation: Registered nosave memory: [mem 0x000f0000-0x000fffff]
Jul 27 05:26:51 hanvolumio kernel: [mem 0x80000000-0xfebfffff] available for PCI devices
Jul 27 05:26:51 hanvolumio kernel: Booting paravirtualized kernel on KVM
Jul 27 05:26:51 hanvolumio kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
Jul 27 05:26:51 hanvolumio kernel: setup_percpu: NR_CPUS:8 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
Jul 27 05:26:51 hanvolumio kernel: percpu: Embedded 56 pages/cpu s191400 r8192 d29784 u2097152
Jul 27 05:26:51 hanvolumio kernel: pcpu-alloc: s191400 r8192 d29784 u2097152 alloc=1*2097152
Jul 27 05:26:51 hanvolumio kernel: pcpu-alloc: [0] 0
Jul 27 05:26:51 hanvolumio kernel: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=668afdde-eb8b-48b3-b8ac-1f0a643965c0 bootpart=UUID=9561-A5F0 datapart=UUID=0f08d23f-00cb-42b9-914c-9463e5fce58b hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no initrd=volumio.initrd
Jul 27 05:26:51 hanvolumio kernel: Unknown kernel command line parameters "splash BOOT_IMAGE=vmlinuz biosdevname=0 imgpart=UUID=668afdde-eb8b-48b3-b8ac-1f0a643965c0 bootpart=UUID=9561-A5F0 datapart=UUID=0f08d23f-00cb-42b9-914c-9463e5fce58b hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh use_kmsg=no", will be passed to user space.
Jul 27 05:26:51 hanvolumio kernel: random: crng init done
Jul 27 05:26:51 hanvolumio kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: Built 1 zonelists, mobility grouping on. Total pages: 515824
Jul 27 05:26:51 hanvolumio kernel: mem auto-init: stack:all(zero), heap alloc:off, heap free:off
Jul 27 05:26:51 hanvolumio kernel: Memory: 1964924K/2096696K available (14336K kernel code, 1878K rwdata, 4640K rodata, 2988K init, 1148K bss, 131516K reserved, 0K cma-reserved)
Jul 27 05:26:51 hanvolumio kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
Jul 27 05:26:51 hanvolumio kernel: ftrace: allocating 40432 entries in 158 pages
Jul 27 05:26:51 hanvolumio kernel: ftrace: allocated 158 pages with 5 groups
Jul 27 05:26:51 hanvolumio kernel: Dynamic Preempt: voluntary
Jul 27 05:26:51 hanvolumio kernel: rcu: Preemptible hierarchical RCU implementation.
Jul 27 05:26:51 hanvolumio kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=1.
Jul 27 05:26:51 hanvolumio kernel: Trampoline variant of Tasks RCU enabled.
Jul 27 05:26:51 hanvolumio kernel: Rude variant of Tasks RCU enabled.
Jul 27 05:26:51 hanvolumio kernel: Tracing variant of Tasks RCU enabled.
Jul 27 05:26:51 hanvolumio kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
Jul 27 05:26:51 hanvolumio kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
Jul 27 05:26:51 hanvolumio kernel: NR_IRQS: 4352, nr_irqs: 256, preallocated irqs: 16
Jul 27 05:26:51 hanvolumio kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
Jul 27 05:26:51 hanvolumio kernel: Console: colour VGA+ 80x25
Jul 27 05:26:51 hanvolumio kernel: printk: console [tty0] enabled
Jul 27 05:26:51 hanvolumio kernel: ACPI: Core revision 20230628
Jul 27 05:26:51 hanvolumio kernel: APIC: Switch to symmetric I/O mode setup
Jul 27 05:26:51 hanvolumio kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
Jul 27 05:26:51 hanvolumio kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x31433e83898, max_idle_ns: 440795269386 ns
Jul 27 05:26:51 hanvolumio kernel: Calibrating delay loop (skipped) preset value.. 6835.19 BogoMIPS (lpj=13670392)
Jul 27 05:26:51 hanvolumio kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
Jul 27 05:26:51 hanvolumio kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
Jul 27 05:26:51 hanvolumio kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
Jul 27 05:26:51 hanvolumio kernel: Spectre V2 : Spectre BHI mitigation: SW BHB clearing on vm exit
Jul 27 05:26:51 hanvolumio kernel: Spectre V2 : Spectre BHI mitigation: SW BHB clearing on syscall
Jul 27 05:26:51 hanvolumio kernel: Spectre V2 : Mitigation: Enhanced / Automatic IBRS
Jul 27 05:26:51 hanvolumio kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
Jul 27 05:26:51 hanvolumio kernel: Spectre V2 : Spectre v2 / PBRSB-eIBRS: Retire a single CALL on VMEXIT
Jul 27 05:26:51 hanvolumio kernel: RETBleed: Mitigation: Enhanced IBRS
Jul 27 05:26:51 hanvolumio kernel: Speculative Store Bypass: Vulnerable
Jul 27 05:26:51 hanvolumio kernel: Register File Data Sampling: Vulnerable: No microcode
Jul 27 05:26:51 hanvolumio kernel: x86/fpu: x87 FPU will use FXSAVE
Jul 27 05:26:51 hanvolumio kernel: Freeing SMP alternatives memory: 32K
Jul 27 05:26:51 hanvolumio kernel: pid_max: default: 32768 minimum: 301
Jul 27 05:26:51 hanvolumio kernel: LSM: initializing lsm=capability,yama,integrity
Jul 27 05:26:51 hanvolumio kernel: Yama: becoming mindful.
Jul 27 05:26:51 hanvolumio kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: APIC calibration not consistent with PM-Timer: 101ms instead of 100ms
Jul 27 05:26:51 hanvolumio kernel: APIC delta adjusted to PM-Timer: 6212714 (6278824)
Jul 27 05:26:51 hanvolumio kernel: smpboot: CPU0: 13th Gen Intel(R) Core(TM) i7-13700K (family: 0x6, model: 0xb7, stepping: 0x1)
Jul 27 05:26:51 hanvolumio kernel: RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1.
Jul 27 05:26:51 hanvolumio kernel: RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1.
Jul 27 05:26:51 hanvolumio kernel: RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1.
Jul 27 05:26:51 hanvolumio kernel: Performance Events: unsupported p6 CPU model 183 no PMU driver, software events only.
Jul 27 05:26:51 hanvolumio kernel: signal: max sigframe size: 1440
Jul 27 05:26:51 hanvolumio kernel: rcu: Hierarchical SRCU implementation.
Jul 27 05:26:51 hanvolumio kernel: rcu: Max phase no-delay instances is 1000.
Jul 27 05:26:51 hanvolumio kernel: NMI watchdog: Perf NMI watchdog permanently disabled
Jul 27 05:26:51 hanvolumio kernel: smp: Bringing up secondary CPUs ...
Jul 27 05:26:51 hanvolumio kernel: smp: Brought up 1 node, 1 CPU
Jul 27 05:26:51 hanvolumio kernel: smpboot: Max logical packages: 1
Jul 27 05:26:51 hanvolumio kernel: smpboot: Total of 1 processors activated (6835.19 BogoMIPS)
Jul 27 05:26:51 hanvolumio kernel: devtmpfs: initialized
Jul 27 05:26:51 hanvolumio kernel: x86/mm: Memory block size: 128MB
Jul 27 05:26:51 hanvolumio kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
Jul 27 05:26:51 hanvolumio kernel: futex hash table entries: 256 (order: 2, 16384 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: pinctrl core: initialized pinctrl subsystem
Jul 27 05:26:51 hanvolumio kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Jul 27 05:26:51 hanvolumio kernel: audit: initializing netlink subsys (disabled)
Jul 27 05:26:51 hanvolumio kernel: audit: type=2000 audit(1722029209.418:1): state=initialized audit_enabled=0 res=1
Jul 27 05:26:51 hanvolumio kernel: thermal_sys: Registered thermal governor 'fair_share'
Jul 27 05:26:51 hanvolumio kernel: thermal_sys: Registered thermal governor 'bang_bang'
Jul 27 05:26:51 hanvolumio kernel: thermal_sys: Registered thermal governor 'step_wise'
Jul 27 05:26:51 hanvolumio kernel: thermal_sys: Registered thermal governor 'user_space'
Jul 27 05:26:51 hanvolumio kernel: EISA bus registered
Jul 27 05:26:51 hanvolumio kernel: cpuidle: using governor ladder
Jul 27 05:26:51 hanvolumio kernel: cpuidle: using governor menu
Jul 27 05:26:51 hanvolumio kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Jul 27 05:26:51 hanvolumio kernel: PCI: Using configuration type 1 for base access
Jul 27 05:26:51 hanvolumio kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
Jul 27 05:26:51 hanvolumio kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
Jul 27 05:26:51 hanvolumio kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
Jul 27 05:26:51 hanvolumio kernel: ACPI: Added _OSI(Module Device)
Jul 27 05:26:51 hanvolumio kernel: ACPI: Added _OSI(Processor Device)
Jul 27 05:26:51 hanvolumio kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Jul 27 05:26:51 hanvolumio kernel: ACPI: Added _OSI(Processor Aggregator Device)
Jul 27 05:26:51 hanvolumio kernel: ACPI: 2 ACPI AML tables successfully acquired and loaded
Jul 27 05:26:51 hanvolumio kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC
Jul 27 05:26:51 hanvolumio kernel: ACPI: Interpreter enabled
Jul 27 05:26:51 hanvolumio kernel: ACPI: PM: (supports S0 S5)
Jul 27 05:26:51 hanvolumio kernel: ACPI: Using IOAPIC for interrupt routing
Jul 27 05:26:51 hanvolumio kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
Jul 27 05:26:51 hanvolumio kernel: PCI: Using E820 reservations for host bridge windows
Jul 27 05:26:51 hanvolumio kernel: ACPI: Enabled 2 GPEs in block 00 to 07
Jul 27 05:26:51 hanvolumio kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
Jul 27 05:26:51 hanvolumio kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3]
Jul 27 05:26:51 hanvolumio kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI]
Jul 27 05:26:51 hanvolumio kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge
Jul 27 05:26:51 hanvolumio kernel: PCI host bridge to bus 0000:00
Jul 27 05:26:51 hanvolumio kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
Jul 27 05:26:51 hanvolumio kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
Jul 27 05:26:51 hanvolumio kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
Jul 27 05:26:51 hanvolumio kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xfdffffff window]
Jul 27 05:26:51 hanvolumio kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:02.0: [15ad:0405] type 00 class 0x030000
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:02.0: reg 0x10: [io 0xd000-0xd00f]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:02.0: reg 0x14: [mem 0xe0000000-0xe7ffffff pref]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:02.0: reg 0x18: [mem 0xf0000000-0xf01fffff]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:03.0: reg 0x10: [mem 0xf0200000-0xf021ffff]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:03.0: reg 0x18: [io 0xd010-0xd017]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:04.0: [80ee:cafe] type 00 class 0x088000
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:04.0: reg 0x10: [io 0xd020-0xd03f]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:04.0: reg 0x14: [mem 0xf0400000-0xf07fffff]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:04.0: reg 0x18: [mem 0xf0800000-0xf0803fff pref]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:05.0: [8086:2668] type 00 class 0x040300
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:05.0: reg 0x10: [mem 0xf0804000-0xf0807fff]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:07.0: [8086:7113] type 00 class 0x068000
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:07.0: quirk: [io 0x4000-0x403f] claimed by PIIX4 ACPI
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:07.0: quirk: [io 0x4100-0x410f] claimed by PIIX4 SMB
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:0c.0: [8086:1e31] type 00 class 0x0c0330
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:0c.0: reg 0x10: [mem 0xf0810000-0xf081ffff]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:0d.0: [8086:2829] type 00 class 0x010601
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:0d.0: reg 0x10: [io 0xd040-0xd047]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:0d.0: reg 0x14: [io 0xd048-0xd04b]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:0d.0: reg 0x18: [io 0xd050-0xd057]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:0d.0: reg 0x1c: [io 0xd058-0xd05b]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:0d.0: reg 0x20: [io 0xd060-0xd06f]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:0d.0: reg 0x24: [mem 0xf0820000-0xf0821fff]
Jul 27 05:26:51 hanvolumio kernel: pci_bus 0000:00: on NUMA node 0
Jul 27 05:26:51 hanvolumio kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 11
Jul 27 05:26:51 hanvolumio kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10
Jul 27 05:26:51 hanvolumio kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 9
Jul 27 05:26:51 hanvolumio kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11
Jul 27 05:26:51 hanvolumio kernel: iommu: Default domain type: Translated
Jul 27 05:26:51 hanvolumio kernel: iommu: DMA domain TLB invalidation policy: lazy mode
Jul 27 05:26:51 hanvolumio kernel: SCSI subsystem initialized
Jul 27 05:26:51 hanvolumio kernel: libata version 3.00 loaded.
Jul 27 05:26:51 hanvolumio kernel: ACPI: bus type USB registered
Jul 27 05:26:51 hanvolumio kernel: usbcore: registered new interface driver usbfs
Jul 27 05:26:51 hanvolumio kernel: usbcore: registered new interface driver hub
Jul 27 05:26:51 hanvolumio kernel: usbcore: registered new device driver usb
Jul 27 05:26:51 hanvolumio kernel: PCI: Using ACPI for IRQ routing
Jul 27 05:26:51 hanvolumio kernel: PCI: pci_cache_line_size set to 64 bytes
Jul 27 05:26:51 hanvolumio kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
Jul 27 05:26:51 hanvolumio kernel: e820: reserve RAM buffer [mem 0x7fff0000-0x7fffffff]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:02.0: vgaarb: bridge control possible
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
Jul 27 05:26:51 hanvolumio kernel: vgaarb: loaded
Jul 27 05:26:51 hanvolumio kernel: clocksource: Switched to clocksource kvm-clock
Jul 27 05:26:51 hanvolumio kernel: VFS: Disk quotas dquot_6.6.0
Jul 27 05:26:51 hanvolumio kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Jul 27 05:26:51 hanvolumio kernel: pnp: PnP ACPI init
Jul 27 05:26:51 hanvolumio kernel: pnp: PnP ACPI: found 2 devices
Jul 27 05:26:51 hanvolumio kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
Jul 27 05:26:51 hanvolumio kernel: NET: Registered PF_INET protocol family
Jul 27 05:26:51 hanvolumio kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: TCP: Hash tables configured (established 16384 bind 16384)
Jul 27 05:26:51 hanvolumio kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear)
Jul 27 05:26:51 hanvolumio kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Jul 27 05:26:51 hanvolumio kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
Jul 27 05:26:51 hanvolumio kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
Jul 27 05:26:51 hanvolumio kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
Jul 27 05:26:51 hanvolumio kernel: pci_bus 0000:00: resource 7 [mem 0x80000000-0xfdffffff window]
Jul 27 05:26:51 hanvolumio kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers
Jul 27 05:26:51 hanvolumio kernel: PCI: CLS 0 bytes, default 64
Jul 27 05:26:51 hanvolumio kernel: Trying to unpack rootfs image as initramfs...
Jul 27 05:26:51 hanvolumio kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 335544320 ms ovfl timer
Jul 27 05:26:51 hanvolumio kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x31433e83898, max_idle_ns: 440795269386 ns
Jul 27 05:26:51 hanvolumio kernel: clocksource: Switched to clocksource tsc
Jul 27 05:26:51 hanvolumio kernel: platform rtc_cmos: registered platform RTC device (no PNP device found)
Jul 27 05:26:51 hanvolumio kernel: Initialise system trusted keyrings
Jul 27 05:26:51 hanvolumio kernel: workingset: timestamp_bits=46 max_order=19 bucket_order=0
Jul 27 05:26:51 hanvolumio kernel: zbud: loaded
Jul 27 05:26:51 hanvolumio kernel: Key type asymmetric registered
Jul 27 05:26:51 hanvolumio kernel: Asymmetric key parser 'x509' registered
Jul 27 05:26:51 hanvolumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Jul 27 05:26:51 hanvolumio kernel: io scheduler mq-deadline registered
Jul 27 05:26:51 hanvolumio kernel: io scheduler kyber registered
Jul 27 05:26:51 hanvolumio kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
Jul 27 05:26:51 hanvolumio kernel: ACPI: AC: AC Adapter [AC] (on-line)
Jul 27 05:26:51 hanvolumio kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
Jul 27 05:26:51 hanvolumio kernel: ACPI: button: Power Button [PWRF]
Jul 27 05:26:51 hanvolumio kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input1
Jul 27 05:26:51 hanvolumio kernel: ACPI: button: Sleep Button [SLPF]
Jul 27 05:26:51 hanvolumio kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
Jul 27 05:26:51 hanvolumio kernel: Linux agpgart interface v0.103
Jul 27 05:26:51 hanvolumio kernel: xhci_hcd 0000:00:0c.0: xHCI Host Controller
Jul 27 05:26:51 hanvolumio kernel: xhci_hcd 0000:00:0c.0: new USB bus registered, assigned bus number 1
Jul 27 05:26:51 hanvolumio kernel: xhci_hcd 0000:00:0c.0: hcc params 0x04000000 hci version 0x100 quirks 0x000000000000b930
Jul 27 05:26:51 hanvolumio kernel: xhci_hcd 0000:00:0c.0: xHCI Host Controller
Jul 27 05:26:51 hanvolumio kernel: xhci_hcd 0000:00:0c.0: new USB bus registered, assigned bus number 2
Jul 27 05:26:51 hanvolumio kernel: xhci_hcd 0000:00:0c.0: Host supports USB 3.0 SuperSpeed
Jul 27 05:26:51 hanvolumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06
Jul 27 05:26:51 hanvolumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jul 27 05:26:51 hanvolumio kernel: usb usb1: Product: xHCI Host Controller
Jul 27 05:26:51 hanvolumio kernel: usb usb1: Manufacturer: Linux 6.6.31-volumio xhci-hcd
Jul 27 05:26:51 hanvolumio kernel: usb usb1: SerialNumber: 0000:00:0c.0
Jul 27 05:26:51 hanvolumio kernel: hub 1-0:1.0: USB hub found
Jul 27 05:26:51 hanvolumio kernel: hub 1-0:1.0: 8 ports detected
Jul 27 05:26:51 hanvolumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06
Jul 27 05:26:51 hanvolumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jul 27 05:26:51 hanvolumio kernel: usb usb2: Product: xHCI Host Controller
Jul 27 05:26:51 hanvolumio kernel: usb usb2: Manufacturer: Linux 6.6.31-volumio xhci-hcd
Jul 27 05:26:51 hanvolumio kernel: usb usb2: SerialNumber: 0000:00:0c.0
Jul 27 05:26:51 hanvolumio kernel: hub 2-0:1.0: USB hub found
Jul 27 05:26:51 hanvolumio kernel: hub 2-0:1.0: 6 ports detected
Jul 27 05:26:51 hanvolumio kernel: i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f03:PS2M] at 0x60,0x64 irq 1,12
Jul 27 05:26:51 hanvolumio kernel: serio: i8042 KBD port at 0x60,0x64 irq 1
Jul 27 05:26:51 hanvolumio kernel: serio: i8042 AUX port at 0x60,0x64 irq 12
Jul 27 05:26:51 hanvolumio kernel: mousedev: PS/2 mouse device common for all mice
Jul 27 05:26:51 hanvolumio kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input2
Jul 27 05:26:51 hanvolumio kernel: rtc_cmos rtc_cmos: registered as rtc0
Jul 27 05:26:51 hanvolumio kernel: rtc_cmos rtc_cmos: setting system clock to 2024-07-27T05:26:43 UTC (1722058003)
Jul 27 05:26:51 hanvolumio kernel: rtc_cmos rtc_cmos: alarms up to one day, 114 bytes nvram
Jul 27 05:26:51 hanvolumio kernel: i2c_dev: i2c /dev entries driver
Jul 27 05:26:51 hanvolumio kernel: platform eisa.0: Probing EISA bus 0
Jul 27 05:26:51 hanvolumio kernel: platform eisa.0: EISA: Cannot allocate resource for mainboard
Jul 27 05:26:51 hanvolumio kernel: intel_pstate: CPU model not supported
Jul 27 05:26:51 hanvolumio kernel: ledtrig-cpu: registered to indicate activity on CPUs
Jul 27 05:26:51 hanvolumio kernel: NET: Registered PF_INET6 protocol family
Jul 27 05:26:51 hanvolumio kernel: Segment Routing with IPv6
Jul 27 05:26:51 hanvolumio kernel: In-situ OAM (IOAM) with IPv6
Jul 27 05:26:51 hanvolumio kernel: mip6: Mobile IPv6
Jul 27 05:26:51 hanvolumio kernel: NET: Registered PF_PACKET protocol family
Jul 27 05:26:51 hanvolumio kernel: mpls_gso: MPLS GSO support
Jul 27 05:26:51 hanvolumio kernel: IPI shorthand broadcast: enabled
Jul 27 05:26:51 hanvolumio kernel: sched_clock: Marking stable (516618444, 76695433)->(602190813, -8876936)
Jul 27 05:26:51 hanvolumio kernel: Loading compiled-in X.509 certificates
Jul 27 05:26:51 hanvolumio kernel: clk: Disabling unused clocks
Jul 27 05:26:51 hanvolumio kernel: usb 1-1: new full-speed USB device number 2 using xhci_hcd
Jul 27 05:26:51 hanvolumio kernel: usb 1-1: New USB device found, idVendor=80ee, idProduct=0021, bcdDevice= 1.00
Jul 27 05:26:51 hanvolumio kernel: usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=0
Jul 27 05:26:51 hanvolumio kernel: usb 1-1: Product: USB Tablet
Jul 27 05:26:51 hanvolumio kernel: usb 1-1: Manufacturer: VirtualBox
Jul 27 05:26:51 hanvolumio kernel: Freeing initrd memory: 68108K
Jul 27 05:26:51 hanvolumio kernel: Freeing unused kernel image (initmem) memory: 2988K
Jul 27 05:26:51 hanvolumio kernel: Write protecting the kernel read-only data: 20480k
Jul 27 05:26:51 hanvolumio kernel: Freeing unused kernel image (rodata/data gap) memory: 1504K
Jul 27 05:26:51 hanvolumio kernel: Run /init as init process
Jul 27 05:26:51 hanvolumio kernel: with arguments:
Jul 27 05:26:51 hanvolumio kernel: /init
Jul 27 05:26:51 hanvolumio kernel: splash
Jul 27 05:26:51 hanvolumio kernel: with environment:
Jul 27 05:26:51 hanvolumio kernel: HOME=/
Jul 27 05:26:51 hanvolumio kernel: TERM=linux
Jul 27 05:26:51 hanvolumio kernel: BOOT_IMAGE=vmlinuz
Jul 27 05:26:51 hanvolumio kernel: biosdevname=0
Jul 27 05:26:51 hanvolumio kernel: imgpart=UUID=668afdde-eb8b-48b3-b8ac-1f0a643965c0
Jul 27 05:26:51 hanvolumio kernel: bootpart=UUID=9561-A5F0
Jul 27 05:26:51 hanvolumio kernel: datapart=UUID=0f08d23f-00cb-42b9-914c-9463e5fce58b
Jul 27 05:26:51 hanvolumio kernel: hwdevice=x86
Jul 27 05:26:51 hanvolumio kernel: uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg
Jul 27 05:26:51 hanvolumio kernel: imgfile=/volumio_current.sqsh
Jul 27 05:26:51 hanvolumio kernel: use_kmsg=no
Jul 27 05:26:51 hanvolumio kernel: e1000: Intel(R) PRO/1000 Network Driver
Jul 27 05:26:51 hanvolumio kernel: e1000: Copyright (c) 1999-2006 Intel Corporation.
Jul 27 05:26:51 hanvolumio kernel: piix4_smbus 0000:00:07.0: SMBus Host Controller at 0x4100, revision 0
Jul 27 05:26:51 hanvolumio kernel: ACPI: video: Video Device [GFX0] (multi-head: yes rom: no post: no)
Jul 27 05:26:51 hanvolumio kernel: input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/LNXVIDEO:00/input/input4
Jul 27 05:26:51 hanvolumio kernel: ahci 0000:00:0d.0: version 3.0
Jul 27 05:26:51 hanvolumio kernel: ahci 0000:00:0d.0: SSS flag set, parallel bus scan disabled
Jul 27 05:26:51 hanvolumio kernel: ahci 0000:00:0d.0: AHCI 0001.0100 32 slots 3 ports 3 Gbps 0x7 impl SATA mode
Jul 27 05:26:51 hanvolumio kernel: ahci 0000:00:0d.0: flags: 64bit ncq stag only ccc
Jul 27 05:26:51 hanvolumio kernel: scsi host0: ahci
Jul 27 05:26:51 hanvolumio kernel: scsi host1: ahci
Jul 27 05:26:51 hanvolumio kernel: scsi host2: ahci
Jul 27 05:26:51 hanvolumio kernel: ata1: SATA max UDMA/133 abar m8192@0xf0820000 port 0xf0820100 irq 21
Jul 27 05:26:51 hanvolumio kernel: ata2: SATA max UDMA/133 abar m8192@0xf0820000 port 0xf0820180 irq 21
Jul 27 05:26:51 hanvolumio kernel: ata3: SATA max UDMA/133 abar m8192@0xf0820000 port 0xf0820200 irq 21
Jul 27 05:26:51 hanvolumio kernel: hid: raw HID events driver (C) Jiri Kosina
Jul 27 05:26:51 hanvolumio kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input5
Jul 27 05:26:51 hanvolumio kernel: ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Jul 27 05:26:51 hanvolumio kernel: ata1.00: ATA-6: VBOX HARDDISK, 1.0, max UDMA/133
Jul 27 05:26:51 hanvolumio kernel: ata1.00: 16777216 sectors, multi 128: LBA48 NCQ (depth 32)
Jul 27 05:26:51 hanvolumio kernel: ata1.00: configured for UDMA/133
Jul 27 05:26:51 hanvolumio kernel: scsi 0:0:0:0: Direct-Access ATA VBOX HARDDISK 1.0 PQ: 0 ANSI: 5
Jul 27 05:26:51 hanvolumio kernel: sd 0:0:0:0: [sda] 16777216 512-byte logical blocks: (8.59 GB/8.00 GiB)
Jul 27 05:26:51 hanvolumio kernel: sd 0:0:0:0: [sda] Write Protect is off
Jul 27 05:26:51 hanvolumio kernel: sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
Jul 27 05:26:51 hanvolumio kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Jul 27 05:26:51 hanvolumio kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 512 bytes
Jul 27 05:26:51 hanvolumio kernel: sda: sda1 sda2 sda3
Jul 27 05:26:51 hanvolumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Jul 27 05:26:51 hanvolumio kernel: ata2: SATA link down (SStatus 0 SControl 300)
Jul 27 05:26:51 hanvolumio kernel: e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 08:00:27:f1:fa:a3
Jul 27 05:26:51 hanvolumio kernel: e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection
Jul 27 05:26:51 hanvolumio kernel: ata3: SATA link down (SStatus 0 SControl 300)
Jul 27 05:26:51 hanvolumio kernel: usbcore: registered new interface driver usbhid
Jul 27 05:26:51 hanvolumio kernel: usbhid: USB HID core driver
Jul 27 05:26:51 hanvolumio kernel: input: VirtualBox USB Tablet as /devices/pci0000:00/0000:00:0c.0/usb1/1-1/1-1:1.0/0003:80EE:0021.0001/input/input6
Jul 27 05:26:51 hanvolumio kernel: hid-generic 0003:80EE:0021.0001: input,hidraw0: USB HID v1.10 Mouse [VirtualBox USB Tablet] on usb-0000:00:0c.0-1/input0
Jul 27 05:26:51 hanvolumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Jul 27 05:26:51 hanvolumio kernel: sdhci: Secure Digital Host Controller Interface driver
Jul 27 05:26:51 hanvolumio kernel: sdhci: Copyright(c) Pierre Ossman
Jul 27 05:26:51 hanvolumio kernel: fuse: init (API version 7.39)
Jul 27 05:26:51 hanvolumio kernel: usbcore: registered new interface driver usb-storage
Jul 27 05:26:51 hanvolumio kernel: usbcore: registered new interface driver uas
Jul 27 05:26:51 hanvolumio kernel: ACPI: bus type drm_connector registered
Jul 27 05:26:51 hanvolumio kernel: [drm] radeon kernel modesetting enabled.
Jul 27 05:26:51 hanvolumio kernel: scsi host3: pata_legacy
Jul 27 05:26:51 hanvolumio kernel: ata4: PATA max PIO4 cmd 0x1f0 ctl 0x3f6 irq 14
Jul 27 05:26:51 hanvolumio kernel: scsi host3: pata_legacy
Jul 27 05:26:51 hanvolumio kernel: ata5: PATA max PIO4 cmd 0x170 ctl 0x376 irq 15
Jul 27 05:26:51 hanvolumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Jul 27 05:26:51 hanvolumio kernel: EXT4-fs (sda2): recovery complete
Jul 27 05:26:51 hanvolumio kernel: EXT4-fs (sda2): mounted filesystem 668afdde-eb8b-48b3-b8ac-1f0a643965c0 r/w with ordered data mode. Quota mode: none.
Jul 27 05:26:51 hanvolumio kernel: loop: module loaded
Jul 27 05:26:51 hanvolumio kernel: block device autoloading is deprecated and will be removed.
Jul 27 05:26:51 hanvolumio kernel: loop0: detected capacity change from 0 to 1721400
Jul 27 05:26:51 hanvolumio kernel: EXT4-fs (sda3): recovery complete
Jul 27 05:26:51 hanvolumio kernel: EXT4-fs (sda3): mounted filesystem 0f08d23f-00cb-42b9-914c-9463e5fce58b r/w with ordered data mode. Quota mode: none.
Jul 27 05:26:51 hanvolumio systemd[1]: Inserted module 'autofs4'
Jul 27 05:26:51 hanvolumio 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)
Jul 27 05:26:51 hanvolumio systemd[1]: Detected virtualization oracle.
Jul 27 05:26:51 hanvolumio systemd[1]: Detected architecture x86-64.
Jul 27 05:26:51 hanvolumio systemd[1]: Set hostname to .
Jul 27 05:26:51 hanvolumio 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.
Jul 27 05:26:51 hanvolumio systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.)
Jul 27 05:26:51 hanvolumio 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.
Jul 27 05:26:51 hanvolumio systemd[1]: Created slice system-getty.slice.
Jul 27 05:26:51 hanvolumio systemd[1]: Listening on Journal Audit Socket.
Jul 27 05:26:51 hanvolumio systemd[1]: Listening on udev Kernel Socket.
Jul 27 05:26:51 hanvolumio systemd-journald[420]: Journal started
Jul 27 05:26:51 hanvolumio systemd-journald[420]: Runtime journal (/run/log/journal/0b2930d493c36928490994506425b530) is 3.7M, max 30.0M, 26.2M free.
Jul 27 05:26:51 hanvolumio fake-hwclock[408]: Current system time: 2024-07-27 05:26:51
Jul 27 05:26:51 hanvolumio fake-hwclock[408]: fake-hwclock saved clock information is in the past: 2024-07-26 21:18:24
Jul 27 05:26:51 hanvolumio fake-hwclock[408]: To set system time to this saved clock anyway, use "force"
Jul 27 05:26:51 hanvolumio systemd[1]: Started udev Coldplug all Devices.
Jul 27 05:26:51 hanvolumio systemd[1]: Started Apply Kernel Variables.
Jul 27 05:26:51 hanvolumio systemd[1]: Starting Helper to synchronize boot up for ifupdown...
Jul 27 05:26:51 hanvolumio systemd[1]: Started Load/Save Random Seed.
Jul 27 05:26:51 hanvolumio systemd[1]: Started Helper to synchronize boot up for ifupdown.
Jul 27 05:26:51 hanvolumio kernel: RPC: Registered named UNIX socket transport module.
Jul 27 05:26:51 hanvolumio kernel: RPC: Registered udp transport module.
Jul 27 05:26:51 hanvolumio kernel: RPC: Registered tcp transport module.
Jul 27 05:26:51 hanvolumio kernel: RPC: Registered tcp-with-tls transport module.
Jul 27 05:26:51 hanvolumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Jul 27 05:26:51 hanvolumio systemd[1]: Mounted RPC Pipe File System.
Jul 27 05:26:51 hanvolumio systemd[1]: dynamicswap.service: Succeeded.
Jul 27 05:26:51 hanvolumio systemd[1]: Started Create System Users.
Jul 27 05:26:51 hanvolumio systemd[1]: Starting Create Static Device Nodes in /dev...
Jul 27 05:26:51 hanvolumio systemd[1]: Started Create Static Device Nodes in /dev.
Jul 27 05:26:51 hanvolumio systemd[1]: Starting udev Kernel Device Manager...
Jul 27 05:26:51 hanvolumio systemd[1]: Reached target Local File Systems (Pre).
Jul 27 05:26:51 hanvolumio systemd[1]: Mounting /var/spool/cups...
Jul 27 05:26:51 hanvolumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
Jul 27 05:26:51 hanvolumio systemd[1]: Mounting /tmp...
Jul 27 05:26:51 hanvolumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway.
Jul 27 05:26:51 hanvolumio systemd-udevd[441]: Network interface NamePolicy= disabled on kernel command line, ignoring.
Jul 27 05:26:51 hanvolumio systemd[1]: Mounting /var/log...
Jul 27 05:26:51 hanvolumio systemd[1]: Mounted /var/spool/cups.
Jul 27 05:26:51 hanvolumio systemd[1]: Mounted /tmp.
Jul 27 05:26:51 hanvolumio systemd[1]: Mounting /var/spool/cups/tmp...
Jul 27 05:26:51 hanvolumio systemd[1]: Started udev Kernel Device Manager.
Jul 27 05:26:51 hanvolumio systemd[1]: Mounted /var/spool/cups/tmp.
Jul 27 05:26:51 hanvolumio systemd[1]: Starting Show Plymouth Boot Screen...
Jul 27 05:26:51 hanvolumio systemd[1]: Mounted /var/log.
Jul 27 05:26:51 hanvolumio systemd[1]: Starting Flush Journal to Persistent Storage...
Jul 27 05:26:51 hanvolumio systemd-journald[420]: Runtime journal (/run/log/journal/0b2930d493c36928490994506425b530) is 3.7M, max 30.0M, 26.2M free.
Jul 27 05:26:51 hanvolumio systemd[1]: plymouth-start.service: Succeeded.
Jul 27 05:26:51 hanvolumio systemd[1]: Started Show Plymouth Boot Screen.
Jul 27 05:26:51 hanvolumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch.
Jul 27 05:26:51 hanvolumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Jul 27 05:26:51 hanvolumio systemd[1]: Reached target Paths.
Jul 27 05:26:51 hanvolumio systemd[1]: Reached target Local Encrypted Volumes.
Jul 27 05:26:51 hanvolumio systemd[1]: Started Flush Journal to Persistent Storage.
Jul 27 05:26:51 hanvolumio systemd-udevd[449]: Using default interface naming scheme 'v240'.
Jul 27 05:26:51 hanvolumio systemd-udevd[449]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jul 27 05:26:51 hanvolumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Jul 27 05:26:51 hanvolumio systemd[1]: Found device VBOX_HARDDISK boot.
Jul 27 05:26:51 hanvolumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/9561-A5F0...
Jul 27 05:26:51 hanvolumio systemd-udevd[459]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:51 hanvolumio systemd-udevd[455]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:51 hanvolumio systemd-udevd[456]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:51 hanvolumio systemd-udevd[446]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:51 hanvolumio systemd[1]: Started File System Check Daemon to report status.
Jul 27 05:26:51 hanvolumio systemd-udevd[451]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: fsck.fat 4.1 (2017-01-24)
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: There are differences between boot sector and its backup.
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: This is mostly harmless. Differences: (offset:original/backup)
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: 3:53/6d, 4:59/6b, 5:53/66, 6:4c/73, 7:49/2e, 8:4e/66, 9:55/61, 10:58/74
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 90:fa/0e, 91:fc/1f, 92:31/be, 93:c9/77, 94:8e/7c, 95:d1/ac, 96:bc/22
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 97:76/c0, 98:7b/74, 99:52/0b, 100:06/56, 101:57/b4, 102:1e/0e, 103:56/bb
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 104:8e/07, 105:c1/00, 106:b1/cd, 107:26/10, 108:bf/5e, 109:78/eb
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 110:7b/f0, 111:f3/32, 112:a5/e4, 113:8e/cd, 114:d9/16, 115:bb/cd
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 116:78/19, 117:00/eb, 118:0f/fe, 119:b4/54, 120:37/68, 121:0f/69
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 122:a0/73, 123:56/20, 124:20/69, 125:d2/73, 126:78/20, 127:1b/6e
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 128:31/6f, 129:c0/74, 130:b1/20, 131:06/61, 132:89/20, 133:3f/62
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 134:89/6f, 135:47/6f, 136:02/74, 137:f3/61, 138:64/62, 139:a5/6c
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 140:8a/65, 141:0e/20, 142:18/64, 143:7c/69, 144:88/73, 145:4d/6b
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 146:f8/2e, 147:50/20, 148:50/20, 150:50/6c, 151:cd/65, 152:13/61
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 153:eb/73, 154:62/65, 155:8b/20, 156:55/69, 157:aa/6e, 158:8b/73
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 159:75/65, 160:a8/72, 161:c1/74, 162:ee/20, 163:04/61, 164:01/20
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 165:f2/62, 166:83/6f, 167:fa/6f, 168:4f/74, 169:76/61, 170:31/62
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 171:81/6c, 172:fa/65, 173:b2/20, 174:07/66, 175:73/6c, 176:2b/6f
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 177:f6/70, 178:45/70, 179:b4/79, 180:7f/20, 181:75/61, 182:25/6e
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 183:38/64, 184:4d/0d, 185:b8/0a, 186:74/70, 187:20/72, 188:66/65
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 189:3d/73, 190:21/73, 191:47/20, 192:50/61, 193:54/6e, 194:75/79
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 195:10/20, 196:80/6b, 197:7d/65, 198:b8/79, 199:ed/20, 200:75/74
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 201:0a/6f, 202:66/20, 203:ff/74, 204:75/72, 205:ec/79, 206:66/20
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 207:ff/61, 208:75/67, 209:e8/61, 210:eb/69, 211:0f/6e, 212:51/20
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 213:51/2e, 214:66/2e, 215:ff/2e, 216:75/20, 217:bc/0d, 218:eb/0a
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 219:07/00, 220:51/00, 221:51/00, 222:66/00, 223:ff/00, 224:36/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 225:1c/00, 226:7c/00, 227:b4/00, 228:08/00, 229:e8/00, 230:e9/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 232:72/00, 233:13/00, 234:20/00, 235:e4/00, 236:75/00, 237:0f/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 238:c1/00, 239:ea/00, 240:08/00, 241:42/00, 242:89/00, 243:16/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 244:1a/00, 245:7c/00, 246:83/00, 247:e1/00, 248:3f/00, 249:89/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 250:0e/00, 251:18/00, 252:7c/00, 253:fb/00, 254:bb/00, 255:aa/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 256:55/00, 257:b4/00, 258:41/00, 259:e8/00, 260:cb/00, 262:72/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 263:10/00, 264:81/00, 265:fb/00, 266:55/00, 267:aa/00, 268:75/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 269:0a/00, 270:f6/00, 271:c1/00, 272:01/00, 273:74/00, 274:05/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 275:c6/00, 276:06/00, 277:46/00, 278:7d/00, 280:66/00, 281:b8/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 282:2d/00, 283:15/00, 286:66/00, 287:ba/00, 292:bb/00, 294:80/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 295:e8/00, 296:0e/00, 298:66/00, 299:81/00, 300:3e/00, 301:1c/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 302:80/00, 303:d5/00, 304:cf/00, 305:c7/00, 306:62/00, 307:75/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 308:74/00, 309:e9/00, 310:f8/00, 311:02/00, 312:66/00, 313:03/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 314:06/00, 315:60/00, 316:7b/00, 317:66/00, 318:13/00, 319:16/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 320:64/00, 321:7b/00, 322:b9/00, 323:10/00, 325:eb/00, 326:2b/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 327:66/00, 328:52/00, 329:66/00, 330:50/00, 331:06/00, 332:53/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 333:6a/00, 334:01/00, 335:6a/00, 336:10/00, 337:89/00, 338:e6/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 339:66/00, 340:60/00, 341:b4/00, 342:42/00, 343:e8/00, 344:77/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 346:66/00, 347:61/00, 348:8d/00, 349:64/00, 350:10/00, 351:72/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 352:01/00, 353:c3/00, 354:66/00, 355:60/00, 356:31/00, 357:c0/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 358:e8/00, 359:68/00, 361:66/00, 362:61/00, 363:e2/00, 364:da/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 365:c6/00, 366:06/00, 367:46/00, 368:7d/00, 369:2b/00, 370:66/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 371:60/00, 372:66/00, 373:0f/00, 374:b7/00, 375:36/00, 376:18/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 377:7c/00, 378:66/00, 379:0f/00, 380:b7/00, 381:3e/00, 382:1a/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 383:7c/00, 384:66/00, 385:f7/00, 386:f6/00, 387:31/00, 388:c9/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 389:87/00, 390:ca/00, 391:66/00, 392:f7/00, 393:f7/00, 394:66/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 395:3d/00, 396:ff/00, 397:03/00, 400:77/00, 401:17/00, 402:c0/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 403:e4/00, 404:06/00, 405:41/00, 406:08/00, 407:e1/00, 408:88/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 409:c5/00, 410:88/00, 411:d6/00, 412:b8/00, 413:01/00, 414:02/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 415:e8/00, 416:2f/00, 418:66/00, 419:61/00, 420:72/00, 421:01/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 422:c3/00, 423:e2/00, 424:c9/00, 425:31/00, 426:f6/00, 427:8e/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 428:d6/00, 429:bc/00, 430:68/00, 431:7b/00, 432:8e/00, 433:de/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 434:66/00, 435:8f/00, 436:06/00, 437:78/00, 439:be/00, 440:da/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 441:7d/00, 442:ac/00, 443:20/00, 444:c0/00, 445:74/00, 446:09/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 447:b4/00, 448:0e/00, 449:bb/00, 450:07/00, 452:cd/00, 453:10/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 454:eb/00, 455:f2/00, 456:31/00, 457:c0/00, 458:cd/00, 459:16/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 460:cd/00, 461:19/00, 462:f4/00, 463:eb/00, 464:fd/00, 465:8a/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 466:16/00, 467:74/00, 468:7b/00, 469:06/00, 470:cd/00, 471:13/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 472:07/00, 473:c3/00, 474:42/00, 475:6f/00, 476:6f/00, 477:74/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 478:20/00, 479:65/00, 480:72/00, 481:72/00, 482:6f/00, 483:72/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 484:0d/00, 485:0a/00, 504:fe/00, 505:02/00, 506:b2/00, 507:3e/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: , 508:18/00, 509:37/00
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: Not automatically fixing this.
Jul 27 05:26:51 hanvolumio systemd-fsck[492]: /dev/sda1: 26 files, 161675/344788 clusters
Jul 27 05:26:51 hanvolumio systemd[1]: Started File System Check on /dev/disk/by-uuid/9561-A5F0.
Jul 27 05:26:51 hanvolumio systemd-udevd[459]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:51 hanvolumio systemd[1]: Mounting /boot...
Jul 27 05:26:51 hanvolumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Jul 27 05:26:51 hanvolumio systemd[1]: Mounted /boot.
Jul 27 05:26:51 hanvolumio systemd[1]: Reached target Local File Systems.
Jul 27 05:26:51 hanvolumio systemd[1]: Starting Preprocess NFS configuration...
Jul 27 05:26:51 hanvolumio systemd[1]: Starting Create Volatile Files and Directories...
Jul 27 05:26:51 hanvolumio systemd[1]: Starting Raise network interfaces...
Jul 27 05:26:51 hanvolumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Jul 27 05:26:51 hanvolumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Jul 27 05:26:51 hanvolumio systemd-udevd[457]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:51 hanvolumio systemd-udevd[450]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:51 hanvolumio kernel: cryptd: max_cpu_qlen set to 1000
Jul 27 05:26:51 hanvolumio kernel: SSE version of gcm_enc/dec engaged.
Jul 27 05:26:51 hanvolumio systemd[1]: nfs-config.service: Succeeded.
Jul 27 05:26:51 hanvolumio systemd[1]: Started Preprocess NFS configuration.
Jul 27 05:26:51 hanvolumio systemd[1]: Started Create Volatile Files and Directories.
Jul 27 05:26:51 hanvolumio systemd[1]: plymouth-read-write.service: Succeeded.
Jul 27 05:26:51 hanvolumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Jul 27 05:26:51 hanvolumio systemd[1]: Received SIGRTMIN+20 from PID 303 (plymouthd).
Jul 27 05:26:51 hanvolumio kernel: snd_hda_codec_idt hdaudioC0D0: autoconfig for STAC9221 A1: line_outs=3 (0xc/0xf/0xb/0x0/0x0) type:speaker
Jul 27 05:26:51 hanvolumio kernel: snd_hda_codec_idt hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
Jul 27 05:26:51 hanvolumio kernel: snd_hda_codec_idt hdaudioC0D0: hp_outs=1 (0xa/0x0/0x0/0x0/0x0)
Jul 27 05:26:51 hanvolumio kernel: snd_hda_codec_idt hdaudioC0D0: mono: mono_out=0x0
Jul 27 05:26:51 hanvolumio kernel: snd_hda_codec_idt hdaudioC0D0: dig-out=0x10/0x0
Jul 27 05:26:51 hanvolumio kernel: snd_hda_codec_idt hdaudioC0D0: inputs:
Jul 27 05:26:51 hanvolumio kernel: snd_hda_codec_idt hdaudioC0D0: Mic=0xd
Jul 27 05:26:51 hanvolumio kernel: snd_hda_codec_idt hdaudioC0D0: Line=0xe
Jul 27 05:26:51 hanvolumio kernel: snd_hda_codec_idt hdaudioC0D0: CD=0x15
Jul 27 05:26:51 hanvolumio kernel: snd_hda_codec_idt hdaudioC0D0: dig-in=0x11
Jul 27 05:26:51 hanvolumio systemd[1]: Found device 82540EM Gigabit Ethernet Controller (PRO/1000 MT Desktop Adapter).
Jul 27 05:26:51 hanvolumio systemd-udevd[451]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jul 27 05:26:52 hanvolumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Jul 27 05:26:52 hanvolumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Jul 27 05:26:52 hanvolumio kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Jul 27 05:26:52 hanvolumio kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
Jul 27 05:26:52 hanvolumio systemd[1]: Started ifup for eth0.
Jul 27 05:26:52 hanvolumio systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Jul 27 05:26:52 hanvolumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Jul 27 05:26:52 hanvolumio systemd[1]: Starting RPC bind portmap service...
Jul 27 05:26:52 hanvolumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Jul 27 05:26:52 hanvolumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Jul 27 05:26:52 hanvolumio systemd[1]: Reached target NFS client services.
Jul 27 05:26:52 hanvolumio ifup[507]: command failed: No such device (-19)
Jul 27 05:26:52 hanvolumio systemd[1]: Started Update UTMP about System Boot/Shutdown.
Jul 27 05:26:52 hanvolumio systemd[1]: Reached target System Initialization.
Jul 27 05:26:52 hanvolumio systemd[1]: Started Daily apt download activities.
Jul 27 05:26:52 hanvolumio systemd[1]: Started Daily Cleanup of Temporary Directories.
Jul 27 05:26:52 hanvolumio systemd[1]: Listening on triggerhappy.socket.
Jul 27 05:26:52 hanvolumio systemd[1]: Listening on D-Bus System Message Bus Socket.
Jul 27 05:26:52 hanvolumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Jul 27 05:26:52 hanvolumio systemd[1]: Reached target Sockets.
Jul 27 05:26:52 hanvolumio systemd[1]: Started Daily apt upgrade and clean activities.
Jul 27 05:26:52 hanvolumio systemd[1]: Started Daily man-db regeneration.
Jul 27 05:26:52 hanvolumio systemd[1]: Reached target Timers.
Jul 27 05:26:52 hanvolumio systemd[1]: Reached target Basic System.
Jul 27 05:26:52 hanvolumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Jul 27 05:26:52 hanvolumio systemd[1]: Starting Login Service...
Jul 27 05:26:52 hanvolumio systemd[1]: Started Volumio Log Rotation Service.
Jul 27 05:26:52 hanvolumio sh[544]: command failed: No such device (-19)
Jul 27 05:26:52 hanvolumio systemd[1]: Started Volumio Iptables Module.
Jul 27 05:26:52 hanvolumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Jul 27 05:26:52 hanvolumio systemd[1]: Started D-Bus System Message Bus.
Jul 27 05:26:52 hanvolumio systemd[1]: Starting WPA supplicant...
Jul 27 05:26:52 hanvolumio systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 27 05:26:52 hanvolumio systemd[1]: Starting triggerhappy global hotkey daemon...
Jul 27 05:26:52 hanvolumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Jul 27 05:26:52 hanvolumio systemd[1]: Starting DHCP Client Daemon...
Jul 27 05:26:52 hanvolumio systemd[1]: Started volumio-remote-updater.service.
Jul 27 05:26:52 hanvolumio systemd[1]: Starting Wireless Services...
Jul 27 05:26:52 hanvolumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Jul 27 05:26:52 hanvolumio thd[590]: Unable to parse trigger line:
Jul 27 05:26:52 hanvolumio thd[590]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Jul 27 05:26:52 hanvolumio thd[590]: Unable to parse trigger line:
Jul 27 05:26:52 hanvolumio thd[590]: Found socket passed from systemd
Jul 27 05:26:52 hanvolumio systemd-udevd[459]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:52 hanvolumio systemd-logind[566]: Watching system buttons on /dev/input/event0 (Power Button)
Jul 27 05:26:52 hanvolumio systemd-logind[566]: Watching system buttons on /dev/input/event1 (Sleep Button)
Jul 27 05:26:52 hanvolumio systemd-logind[566]: Watching system buttons on /dev/input/event2 (AT Translated Set 2 keyboard)
Jul 27 05:26:52 hanvolumio systemd-logind[566]: New seat seat0.
Jul 27 05:26:52 hanvolumio kernel: input: HDA Intel Mic as /devices/pci0000:00/0000:00:05.0/sound/card0/input7
Jul 27 05:26:52 hanvolumio kernel: input: HDA Intel Line as /devices/pci0000:00/0000:00:05.0/sound/card0/input8
Jul 27 05:26:52 hanvolumio kernel: input: HDA Intel Speaker Front as /devices/pci0000:00/0000:00:05.0/sound/card0/input9
Jul 27 05:26:52 hanvolumio kernel: input: HDA Intel Speaker CLFE as /devices/pci0000:00/0000:00:05.0/sound/card0/input10
Jul 27 05:26:52 hanvolumio kernel: input: HDA Intel Front Headphone as /devices/pci0000:00/0000:00:05.0/sound/card0/input11
Jul 27 05:26:52 hanvolumio kernel: input: HDA Intel SPDIF In as /devices/pci0000:00/0000:00:05.0/sound/card0/input12
Jul 27 05:26:52 hanvolumio ifup[507]: command failed: No such device (-19)
Jul 27 05:26:52 hanvolumio avahi-daemon[601]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113).
Jul 27 05:26:52 hanvolumio avahi-daemon[601]: Successfully dropped root privileges.
Jul 27 05:26:52 hanvolumio avahi-daemon[601]: avahi-daemon 0.7 starting up.
Jul 27 05:26:52 hanvolumio kernel: 8021q: 802.1Q VLAN Support v1.8
Jul 27 05:26:52 hanvolumio systemd-udevd[455]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:52 hanvolumio dhcpcd[593]: no interfaces have a carrier
Jul 27 05:26:52 hanvolumio dhcpcd[593]: no interfaces have a carrier
Jul 27 05:26:52 hanvolumio dhcpcd[593]: forked to background, child pid 679
Jul 27 05:26:52 hanvolumio dhcpcd[593]: forked to background, child pid 679
Jul 27 05:26:52 hanvolumio dbus-daemon[576]: [system] Successfully activated service 'org.freedesktop.systemd1'
Jul 27 05:26:52 hanvolumio systemd[1]: Started Login Service.
Jul 27 05:26:52 hanvolumio systemd[1]: Started triggerhappy global hotkey daemon.
Jul 27 05:26:52 hanvolumio wpa_supplicant[577]: Successfully initialized wpa_supplicant
Jul 27 05:26:52 hanvolumio avahi-daemon[601]: Successfully called chroot().
Jul 27 05:26:52 hanvolumio avahi-daemon[601]: Successfully dropped remaining capabilities.
Jul 27 05:26:52 hanvolumio avahi-daemon[601]: Loading service file /services/volumio.service.
Jul 27 05:26:52 hanvolumio systemd[1]: Started RPC bind portmap service.
Jul 27 05:26:52 hanvolumio systemd[1]: Started DHCP Client Daemon.
Jul 27 05:26:52 hanvolumio kernel: e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX
Jul 27 05:26:52 hanvolumio systemd-udevd[446]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:53 hanvolumio kernel: 8021q: adding VLAN 0 to HW filter on device eth0
Jul 27 05:26:53 hanvolumio haveged[552]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K
Jul 27 05:26:53 hanvolumio systemd-udevd[455]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:53 hanvolumio systemd-udevd[456]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:53 hanvolumio systemd[1]: Started WPA supplicant.
Jul 27 05:26:53 hanvolumio systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Jul 27 05:26:53 hanvolumio systemd[1]: Started Manage Sound Card State (restore and store).
Jul 27 05:26:53 hanvolumio systemd[1]: Starting Save/Restore Sound Card State...
Jul 27 05:26:53 hanvolumio systemd[1]: Reached target RPC Port Mapper.
Jul 27 05:26:53 hanvolumio systemd[1]: Reached target Remote File Systems (Pre).
Jul 27 05:26:53 hanvolumio systemd[1]: Reached target Remote File Systems.
Jul 27 05:26:53 hanvolumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Jul 27 05:26:53 hanvolumio systemd-udevd[449]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:53 hanvolumio systemd-udevd[459]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 27 05:26:53 hanvolumio alsactl[689]: alsactl 1.1.8 daemon started
Jul 27 05:26:53 hanvolumio avahi-daemon[601]: Network interface enumeration completed.
Jul 27 05:26:53 hanvolumio avahi-daemon[601]: Server startup complete. Host name is hanvolumio.local. Local service cookie is 3837176366.
Jul 27 05:26:53 hanvolumio avahi-daemon[601]: Service "han_Volumio" (/services/volumio.service) successfully established.
Jul 27 05:26:53 hanvolumio haveged[552]: haveged: cpu: (L4 VC); data: 32K (L4 V); inst: 64K (L4 V); idx: 39/40; sz: 52825/52825
Jul 27 05:26:53 hanvolumio haveged[552]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.9971
Jul 27 05:26:53 hanvolumio haveged[552]: haveged: fills: 0, generated: 0
Jul 27 05:26:53 hanvolumio sh[544]: eth0: waiting for carrier
Jul 27 05:26:53 hanvolumio sh[544]: eth0: carrier acquired
Jul 27 05:26:53 hanvolumio dhcpcd[600]: eth0: waiting for carrier
Jul 27 05:26:53 hanvolumio dhcpcd[600]: eth0: carrier acquired
Jul 27 05:26:53 hanvolumio systemd[1]: iptables.service: Succeeded.
Jul 27 05:26:53 hanvolumio sh[544]: DUID 00:04:c1:e7:37:75:b1:27:7c:47:9e:15:98:af:e7:2b:97:61
Jul 27 05:26:53 hanvolumio sh[544]: eth0: IAID 27:f1:fa:a3
Jul 27 05:26:53 hanvolumio dhcpcd[600]: DUID 00:04:c1:e7:37:75:b1:27:7c:47:9e:15:98:af:e7:2b:97:61
Jul 27 05:26:53 hanvolumio dhcpcd[600]: eth0: IAID 27:f1:fa:a3
Jul 27 05:26:53 hanvolumio sh[544]: eth0: adding address fe80::b1a6:16f7:4ac4:8bc6
Jul 27 05:26:53 hanvolumio sh[544]: ipv6_addaddr1: Permission denied
Jul 27 05:26:53 hanvolumio dhcpcd[600]: eth0: adding address fe80::b1a6:16f7:4ac4:8bc6
Jul 27 05:26:53 hanvolumio dhcpcd[600]: ipv6_addaddr1: Permission denied
Jul 27 05:26:53 hanvolumio dhcpcd[679]: eth0: waiting for carrier
Jul 27 05:26:53 hanvolumio dhcpcd[679]: eth0: carrier acquired
Jul 27 05:26:53 hanvolumio dhcpcd[679]: DUID 00:04:c1:e7:37:75:b1:27:7c:47:9e:15:98:af:e7:2b:97:61
Jul 27 05:26:53 hanvolumio dhcpcd[679]: eth0: IAID 27:f1:fa:a3
Jul 27 05:26:53 hanvolumio dhcpcd[679]: eth0: adding address fe80::b1a6:16f7:4ac4:8bc6
Jul 27 05:26:53 hanvolumio dhcpcd[679]: ipv6_addaddr1: Permission denied
Jul 27 05:26:53 hanvolumio systemd[1]: Started Raise network interfaces.
Jul 27 05:26:53 hanvolumio systemd[1]: Reached target Network.
Jul 27 05:26:53 hanvolumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Jul 27 05:26:53 hanvolumio systemd[1]: Starting Network Time Service...
Jul 27 05:26:53 hanvolumio systemd[1]: Starting Permit User Sessions...
Jul 27 05:26:53 hanvolumio systemd[1]: Reached target Network is Online.
Jul 27 05:26:53 hanvolumio systemd[1]: Starting /etc/rc.local Compatibility...
Jul 27 05:26:53 hanvolumio systemd[1]: Starting Samba NMB Daemon...
Jul 27 05:26:53 hanvolumio systemd[1]: Starting LSB: Brings up/down network automatically...
Jul 27 05:26:53 hanvolumio systemd[1]: Started /etc/rc.local Compatibility.
Jul 27 05:26:53 hanvolumio volumio-remote-updater[598]: Error: No active session
Jul 27 05:26:53 hanvolumio volumio-remote-updater[598]: [2024-07-27 05:26:53] [info] asio async_connect error: system:111 (Connection refused)
Jul 27 05:26:53 hanvolumio volumio-remote-updater[598]: [2024-07-27 05:26:53] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Jul 27 05:26:53 hanvolumio volumio-remote-updater[598]: [2024-07-27 05:26:53] [error] handle_connect error: Underlying Transport Error
Jul 27 05:26:53 hanvolumio systemd[1]: Started Permit User Sessions.
Jul 27 05:26:53 hanvolumio systemd[1]: Starting Hold until boot process finishes up...
Jul 27 05:26:53 hanvolumio dhcpcd[600]: eth0: soliciting an IPv6 router
Jul 27 05:26:53 hanvolumio sh[544]: eth0: soliciting an IPv6 router
Jul 27 05:26:53 hanvolumio systemd[1]: Starting Terminate Plymouth Boot Screen...
Jul 27 05:26:53 hanvolumio systemd[1]: Received SIGRTMIN+21 from PID 303 (n/a).
Jul 27 05:26:53 hanvolumio systemd[1]: plymouth-quit-wait.service: Succeeded.
Jul 27 05:26:53 hanvolumio systemd[1]: Started Hold until boot process finishes up.
Jul 27 05:26:53 hanvolumio systemd[1]: Started Getty on tty1.
Jul 27 05:26:53 hanvolumio systemd[1]: Reached target Login Prompts.
Jul 27 05:26:53 hanvolumio systemd[1]: plymouth-quit.service: Succeeded.
Jul 27 05:26:53 hanvolumio systemd[1]: Started Terminate Plymouth Boot Screen.
Jul 27 05:26:53 hanvolumio volumio[584]: Could not open config: /tmp/upmpdcli.conf
Jul 27 05:26:53 hanvolumio ifplugd(eth0)[769]: ifplugd 0.28 initializing.
Jul 27 05:26:53 hanvolumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Jul 27 05:26:53 hanvolumio ifplugd(eth0)[769]: Using interface eth0/08:00:27:F1:FA:A3 with driver (version: 6.6.31-volumio)
Jul 27 05:26:53 hanvolumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Jul 27 05:26:53 hanvolumio ifplugd(eth0)[769]: Using detection mode: SIOCETHTOOL
Jul 27 05:26:53 hanvolumio ifplugd(eth0)[769]: Initialization complete, link beat detected.
Jul 27 05:26:53 hanvolumio loadcpufreq[694]: Loading cpufreq kernel modules...failed.
Jul 27 05:26:53 hanvolumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Jul 27 05:26:53 hanvolumio ntpd[722]: ntpd 4.2.8p12@1.3728-o (1): Starting
Jul 27 05:26:53 hanvolumio ntpd[722]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Jul 27 05:26:53 hanvolumio systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Jul 27 05:26:53 hanvolumio systemd[1]: Started Network Time Service.
Jul 27 05:26:53 hanvolumio ntpd[777]: proto: precision = 0.037 usec (-25)
Jul 27 05:26:53 hanvolumio ntpd[777]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Jul 27 05:26:53 hanvolumio ntpd[777]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Jul 27 05:26:53 hanvolumio ntpd[777]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 578 days ago
Jul 27 05:26:53 hanvolumio ifplugd(eth0)[769]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Jul 27 05:26:53 hanvolumio cpufrequtils[776]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done.
Jul 27 05:26:53 hanvolumio systemd[1]: Started LSB: set CPUFreq kernel parameters.
Jul 27 05:26:53 hanvolumio ntpd[777]: Listen and drop on 0 v6wildcard [::]:123
Jul 27 05:26:53 hanvolumio ntpd[777]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Jul 27 05:26:53 hanvolumio ntpd[777]: Listen normally on 2 lo 127.0.0.1:123
Jul 27 05:26:53 hanvolumio ntpd[777]: Listening on routing socket on fd #19 for interface updates
Jul 27 05:26:53 hanvolumio ntpd[777]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jul 27 05:26:53 hanvolumio ntpd[777]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jul 27 05:26:53 hanvolumio ifplugd(eth0)[769]: client: ifup: waiting for lock on /run/network/ifstate.eth0
Jul 27 05:26:53 hanvolumio kernel: alsactl[675]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set
Jul 27 05:26:53 hanvolumio nmbd[730]: [2024/07/27 05:26:53.816296, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Jul 27 05:26:53 hanvolumio nmbd[730]: started asyncdns process 796
Jul 27 05:26:53 hanvolumio nmbd[730]: [2024/07/27 05:26:53.818224, 0] ../lib/util/become_daemon.c:149(daemon_status)
Jul 27 05:26:53 hanvolumio nmbd[730]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Jul 27 05:26:53 hanvolumio nmbd[730]: [2024/07/27 05:26:53.818306, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Jul 27 05:26:53 hanvolumio nmbd[730]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Jul 27 05:26:53 hanvolumio sh[544]: eth0: rebinding lease of 192.168.99.174
Jul 27 05:26:53 hanvolumio dhcpcd[600]: eth0: rebinding lease of 192.168.99.174
Jul 27 05:26:53 hanvolumio sh[544]: eth0: probing address 192.168.99.174/24
Jul 27 05:26:53 hanvolumio dhcpcd[600]: eth0: probing address 192.168.99.174/24
Jul 27 05:26:53 hanvolumio dhcpcd[679]: eth0: soliciting an IPv6 router
Jul 27 05:26:53 hanvolumio wireless.js[599]: WIRELESS: No wireless interface, exiting
Jul 27 05:26:53 hanvolumio dhcpcd[679]: eth0: rebinding lease of 192.168.99.174
Jul 27 05:26:53 hanvolumio iw[801]: command failed: No such device (-19)
Jul 27 05:26:53 hanvolumio iwconfig[804]: Error for wireless request "Set Power Management" (8B2C) :
Jul 27 05:26:53 hanvolumio iwconfig[804]: SET failed on device wlan0 ; No such device.
Jul 27 05:26:53 hanvolumio systemd[1]: wireless.service: Succeeded.
Jul 27 05:26:53 hanvolumio systemd[1]: Started Wireless Services.
Jul 27 05:26:53 hanvolumio systemd[1]: Started Volumio Backend Module.
Jul 27 05:26:53 hanvolumio systemd[1]: Started Intel SST and HDA soundcard init service.
Jul 27 05:26:53 hanvolumio systemd[1]: Started Volumio Cpu Tweaker.
Jul 27 05:26:53 hanvolumio systemd[1]: Started Start Volumio Kiosk.
Jul 27 05:26:54 hanvolumio dhcpcd[679]: eth0: probing address 192.168.99.174/24
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: Setting RT Priority for mpd
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: pid 35's current scheduling policy: SCHED_OTHER
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: pid 35's current scheduling priority: 0
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: Not enough cores to set MPD affinity
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: Error setting new values. Common errors:
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: - Do you have proper administration rights? (super-user?)
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: - Is the governor you requested available and modprobed?
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: - Trying to set an invalid policy?
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: - Trying to set a specific frequency, but userspace governor is not available,
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: for example because of hardware which cannot be set to a specific frequency
Jul 27 05:26:54 hanvolumio volumio-cpu-tweak[809]: or because the userspace governor isn't loaded?
Jul 27 05:26:54 hanvolumio systemd[1]: volumio_cpu_tweak.service: Succeeded.
Jul 27 05:26:54 hanvolumio startx[810]: hostname: System error
Jul 27 05:26:54 hanvolumio systemd[1]: Started Save/Restore Sound Card State.
Jul 27 05:26:54 hanvolumio systemd[1]: Reached target Sound Card.
Jul 27 05:26:54 hanvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 27 05:26:54 hanvolumio startx[810]: xauth: (stdin):1: bad display name "hanvolumio:0" in "add" command
Jul 27 05:26:54 hanvolumio ntpd[777]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Jul 27 05:26:54 hanvolumio startx[810]: X.Org X Server 1.20.4
Jul 27 05:26:54 hanvolumio startx[810]: X Protocol Version 11, Revision 0
Jul 27 05:26:54 hanvolumio startx[810]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian
Jul 27 05:26:54 hanvolumio startx[810]: Current Operating System: Linux hanvolumio 6.6.31-volumio #2 SMP PREEMPT_DYNAMIC Fri May 17 18:26:28 CEST 2024 x86_64
Jul 27 05:26:54 hanvolumio startx[810]: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=668afdde-eb8b-48b3-b8ac-1f0a643965c0 bootpart=UUID=9561-A5F0 datapart=UUID=0f08d23f-00cb-42b9-914c-9463e5fce58b hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no initrd=volumio.initrd
Jul 27 05:26:54 hanvolumio startx[810]: Build Date: 18 December 2021 09:05:36AM
Jul 27 05:26:54 hanvolumio startx[810]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support)
Jul 27 05:26:54 hanvolumio startx[810]: Current version of pixman: 0.36.0
Jul 27 05:26:54 hanvolumio startx[810]: Before reporting problems, check http://wiki.x.org
Jul 27 05:26:54 hanvolumio startx[810]: to make sure that you have the latest version.
Jul 27 05:26:54 hanvolumio startx[810]: Markers: (--) probed, (**) from config file, (==) default setting,
Jul 27 05:26:54 hanvolumio startx[810]: (++) from command line, (!!) notice, (II) informational,
Jul 27 05:26:54 hanvolumio startx[810]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Jul 27 05:26:54 hanvolumio startx[810]: (==) Log file: "/var/log/Xorg.0.log", Time: Sat Jul 27 05:26:54 2024
Jul 27 05:26:54 hanvolumio startx[810]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Jul 27 05:26:55 hanvolumio systemd[1]: soundcard-init.service: Succeeded.
Jul 27 05:26:55 hanvolumio ntpd[777]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Jul 27 05:26:55 hanvolumio volumio[807]: info: -------------------------------------------
Jul 27 05:26:55 hanvolumio volumio[807]: info: ----- Volumio3 ----
Jul 27 05:26:55 hanvolumio volumio[807]: info: -------------------------------------------
Jul 27 05:26:55 hanvolumio volumio[807]: info: ----- System startup ----
Jul 27 05:26:55 hanvolumio volumio[807]: info: -------------------------------------------
Jul 27 05:26:56 hanvolumio volumio[807]: info: MYVOLUMIO Environment detected
Jul 27 05:26:56 hanvolumio volumio[807]: info: Plugin folders cleanup
Jul 27 05:26:56 hanvolumio volumio[807]: info: Scanning into folder /volumio/app/plugins/
Jul 27 05:26:56 hanvolumio volumio[807]: info: Scanning category audio_interface
Jul 27 05:26:56 hanvolumio volumio[807]: info: Scanning category miscellanea
Jul 27 05:26:56 hanvolumio volumio[807]: info: Scanning category music_service
Jul 27 05:26:56 hanvolumio volumio[807]: info: Scanning category plugins.json
Jul 27 05:26:56 hanvolumio volumio[807]: info: Scanning category system_controller
Jul 27 05:26:56 hanvolumio volumio[807]: info: Scanning category user_interface
Jul 27 05:26:56 hanvolumio volumio[807]: info: Scanning into folder /data/plugins/
Jul 27 05:26:56 hanvolumio volumio[807]: info: Scanning category music_service
Jul 27 05:26:56 hanvolumio volumio[807]: info: Scanning category user_interface
Jul 27 05:26:56 hanvolumio volumio[807]: info: Plugin folders cleanup completed
Jul 27 05:26:56 hanvolumio volumio[807]: info: -------------------------------------------
Jul 27 05:26:56 hanvolumio volumio[807]: info: ----- Core plugins startup ----
Jul 27 05:26:56 hanvolumio volumio[807]: info: -------------------------------------------
Jul 27 05:26:56 hanvolumio volumio[807]: info: Loading plugins from folder /volumio/app/plugins/
Jul 27 05:26:56 hanvolumio volumio[807]: info: Adding plugin upnp to MyMusic Plugins
Jul 27 05:26:56 hanvolumio volumio[807]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jul 27 05:26:56 hanvolumio volumio[807]: info: Adding plugin upnp_browser to MyMusic Plugins
Jul 27 05:26:56 hanvolumio volumio[807]: info: Loading plugins from folder /data/plugins/
Jul 27 05:26:56 hanvolumio volumio[807]: info: Loading plugin "system"...
Jul 27 05:26:56 hanvolumio volumio[807]: info: Loading plugin "appearance"...
Jul 27 05:26:56 hanvolumio ntpd[777]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Jul 27 05:26:56 hanvolumio volumio[807]: info: Loading plugin "network"...
Jul 27 05:26:56 hanvolumio volumio[807]: info: Refreshing Cached IP Addresses
Jul 27 05:26:56 hanvolumio volumio[807]: info: Loading plugin "services"...
Jul 27 05:26:56 hanvolumio volumio[807]: info: Loading plugin "alsa_controller"...
Jul 27 05:26:57 hanvolumio sudo[955]: volumio : unable to resolve host hanvolumio
Jul 27 05:26:57 hanvolumio sudo[955]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Jul 27 05:26:57 hanvolumio sudo[957]: volumio : unable to resolve host hanvolumio
Jul 27 05:26:57 hanvolumio sudo[957]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Jul 27 05:26:57 hanvolumio sudo[953]: volumio : unable to resolve host hanvolumio
Jul 27 05:26:57 hanvolumio sudo[953]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Jul 27 05:26:57 hanvolumio sudo[957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jul 27 05:26:57 hanvolumio sudo[957]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:26:57 hanvolumio sudo[955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 27 05:26:57 hanvolumio sudo[955]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:26:57 hanvolumio sudo[953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 27 05:26:57 hanvolumio sudo[953]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:26:57 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "wizard"...
Jul 27 05:26:57 hanvolumio sudo[957]: pam_unix(sudo:session): session closed for user root
Jul 27 05:26:57 hanvolumio sudo[953]: pam_unix(sudo:session): session closed for user root
Jul 27 05:26:57 hanvolumio sudo[955]: pam_unix(sudo:session): session closed for user root
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "networkfs"...
Jul 27 05:26:57 hanvolumio volumio[807]: info: Starting Udev Watcher for removable devices
Jul 27 05:26:57 hanvolumio volumio[807]: info: Ignoring mount for partition: boot
Jul 27 05:26:57 hanvolumio volumio[807]: info: Ignoring mount for partition: volumio
Jul 27 05:26:57 hanvolumio volumio[807]: info: Ignoring mount for partition: volumio_data
Jul 27 05:26:57 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "volumio_command_line_client"...
Jul 27 05:26:57 hanvolumio sudo[970]: volumio : unable to resolve host hanvolumio
Jul 27 05:26:57 hanvolumio sudo[970]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Jul 27 05:26:57 hanvolumio sudo[970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=hanson,password=han30959769,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.99.193/music /mnt/NAS/music
Jul 27 05:26:57 hanvolumio sudo[970]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "upnp"...
Jul 27 05:26:57 hanvolumio volumio[807]: info: [1722058017165] Starting Upmpd Daemon
Jul 27 05:26:57 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "my_music"...
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "mpd"...
Jul 27 05:26:57 hanvolumio kernel: FS-Cache: Loaded
Jul 27 05:26:57 hanvolumio kernel: Key type dns_resolver registered
Jul 27 05:26:57 hanvolumio kernel: Key type cifs.spnego registered
Jul 27 05:26:57 hanvolumio kernel: Key type cifs.idmap registered
Jul 27 05:26:57 hanvolumio sudo[970]: pam_unix(sudo:session): session closed for user root
Jul 27 05:26:57 hanvolumio 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.
Jul 27 05:26:57 hanvolumio kernel: CIFS: Attempting to mount //192.168.99.193/music
Jul 27 05:26:57 hanvolumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Jul 27 05:26:57 hanvolumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101
Jul 27 05:26:57 hanvolumio ntpd[777]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "upnp_browser"...
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "alarm-clock"...
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "airplay_emulation"...
Jul 27 05:26:57 hanvolumio volumio[807]: info: Starting Shairport Sync
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "last_100"...
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "webradio"...
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "i2s_dacs"...
Jul 27 05:26:57 hanvolumio volumio[807]: info: I2S DAC not set, start Auto-detection
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "volumiodiscovery"...
Jul 27 05:26:57 hanvolumio volumio[807]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 27 05:26:57 hanvolumio node[807]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 27 05:26:57 hanvolumio volumio[807]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 27 05:26:57 hanvolumio node[807]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 27 05:26:57 hanvolumio volumio[807]: *** WARNING *** For more information see
Jul 27 05:26:57 hanvolumio node[807]: *** WARNING *** For more information see
Jul 27 05:26:57 hanvolumio volumio[807]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 27 05:26:57 hanvolumio node[807]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 27 05:26:57 hanvolumio volumio[807]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 27 05:26:57 hanvolumio node[807]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 27 05:26:57 hanvolumio volumio[807]: *** WARNING *** For more information see
Jul 27 05:26:57 hanvolumio node[807]: *** WARNING *** For more information see
Jul 27 05:26:57 hanvolumio volumio[807]: info: Applying required configuration parameters for plugin volumiodiscovery
Jul 27 05:26:57 hanvolumio volumio[807]: info: Discovery: Started advertising with name: han_Volumio
Jul 27 05:26:57 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 27 05:26:57 hanvolumio volumio[807]: info: Loading plugin "spop"...
Jul 27 05:26:58 hanvolumio volumio-remote-updater[598]: [2024-07-27 05:26:58] [connect] Successful connection
Jul 27 05:26:58 hanvolumio sh[544]: eth0: leased 192.168.99.174 for 86400 seconds
Jul 27 05:26:58 hanvolumio sh[544]: eth0: adding route to 192.168.99.0/24
Jul 27 05:26:58 hanvolumio sh[544]: eth0: adding default route via 192.168.99.1
Jul 27 05:26:58 hanvolumio dhcpcd[600]: eth0: leased 192.168.99.174 for 86400 seconds
Jul 27 05:26:58 hanvolumio dhcpcd[600]: eth0: adding route to 192.168.99.0/24
Jul 27 05:26:58 hanvolumio dhcpcd[600]: eth0: adding default route via 192.168.99.1
Jul 27 05:26:58 hanvolumio avahi-daemon[601]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.99.174.
Jul 27 05:26:58 hanvolumio avahi-daemon[601]: New relevant interface eth0.IPv4 for mDNS.
Jul 27 05:26:58 hanvolumio avahi-daemon[601]: Registering new address record for 192.168.99.174 on eth0.IPv4.
Jul 27 05:26:58 hanvolumio ntpd[777]: ntpd exiting on signal 15 (Terminated)
Jul 27 05:26:58 hanvolumio systemd[1]: Stopping Network Time Service...
Jul 27 05:26:58 hanvolumio systemd[1]: ntp.service: Succeeded.
Jul 27 05:26:58 hanvolumio systemd[1]: Stopped Network Time Service.
Jul 27 05:26:58 hanvolumio systemd[1]: Starting Network Time Service...
Jul 27 05:26:58 hanvolumio ntpd[1019]: ntpd 4.2.8p12@1.3728-o (1): Starting
Jul 27 05:26:58 hanvolumio ntpd[1019]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Jul 27 05:26:58 hanvolumio systemd[1]: Started Network Time Service.
Jul 27 05:26:58 hanvolumio sh[544]: forked to background, child pid 1026
Jul 27 05:26:58 hanvolumio dhcpcd[600]: forked to background, child pid 1026
Jul 27 05:26:58 hanvolumio nmbd[730]: [2024/07/27 05:26:58.837155, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Jul 27 05:26:58 hanvolumio nmbd[730]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Jul 27 05:26:58 hanvolumio systemd[1]: Started Samba NMB Daemon.
Jul 27 05:26:58 hanvolumio ntpd[1025]: proto: precision = 0.037 usec (-25)
Jul 27 05:26:58 hanvolumio ntpd[1025]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Jul 27 05:26:58 hanvolumio ntpd[1025]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Jul 27 05:26:58 hanvolumio ntpd[1025]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 578 days ago
Jul 27 05:26:58 hanvolumio ntpd[1025]: Listen and drop on 0 v6wildcard [::]:123
Jul 27 05:26:58 hanvolumio ntpd[1025]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Jul 27 05:26:58 hanvolumio ntpd[1025]: Listen normally on 2 lo 127.0.0.1:123
Jul 27 05:26:58 hanvolumio ntpd[1025]: Listen normally on 3 eth0 192.168.99.174:123
Jul 27 05:26:58 hanvolumio ntpd[1025]: Listening on routing socket on fd #20 for interface updates
Jul 27 05:26:58 hanvolumio ntpd[1025]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jul 27 05:26:58 hanvolumio ntpd[1025]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jul 27 05:26:58 hanvolumio dhcpcd[679]: eth0: leased 192.168.99.174 for 86400 seconds
Jul 27 05:26:58 hanvolumio dhcpcd[679]: eth0: adding route to 192.168.99.0/24
Jul 27 05:26:58 hanvolumio dhcpcd[679]: eth0: adding default route via 192.168.99.1
Jul 27 05:26:58 hanvolumio systemd[1]: Starting Samba Winbind Daemon...
Jul 27 05:26:59 hanvolumio sh[544]: eth0=eth0
Jul 27 05:26:59 hanvolumio ifplugd(eth0)[769]: client: ifup: interface eth0 already configured
Jul 27 05:26:59 hanvolumio ifplugd(eth0)[769]: Program executed successfully.
Jul 27 05:26:59 hanvolumio ifplugd[729]: Network Interface Plugging Daemon...start eth0...done.
Jul 27 05:26:59 hanvolumio systemd[1]: Started LSB: Brings up/down network automatically.
Jul 27 05:26:59 hanvolumio systemd[1]: Stopping Network Time Service...
Jul 27 05:26:59 hanvolumio ntpd[1025]: ntpd exiting on signal 15 (Terminated)
Jul 27 05:26:59 hanvolumio systemd[1]: ntp.service: Succeeded.
Jul 27 05:26:59 hanvolumio systemd[1]: Stopped Network Time Service.
Jul 27 05:26:59 hanvolumio systemd[1]: Starting Network Time Service...
Jul 27 05:26:59 hanvolumio ntpd[1088]: ntpd 4.2.8p12@1.3728-o (1): Starting
Jul 27 05:26:59 hanvolumio ntpd[1088]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Jul 27 05:26:59 hanvolumio systemd[1]: Started Network Time Service.
Jul 27 05:26:59 hanvolumio winbindd[1029]: [2024/07/27 05:26:59.244340, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Jul 27 05:26:59 hanvolumio ntpd[1095]: proto: precision = 0.038 usec (-25)
Jul 27 05:26:59 hanvolumio winbindd[1029]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Jul 27 05:26:59 hanvolumio ntpd[1095]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Jul 27 05:26:59 hanvolumio ntpd[1095]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Jul 27 05:26:59 hanvolumio ntpd[1095]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 578 days ago
Jul 27 05:26:59 hanvolumio ntpd[1095]: Listen and drop on 0 v6wildcard [::]:123
Jul 27 05:26:59 hanvolumio ntpd[1095]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Jul 27 05:26:59 hanvolumio ntpd[1095]: Listen normally on 2 lo 127.0.0.1:123
Jul 27 05:26:59 hanvolumio ntpd[1095]: Listen normally on 3 eth0 192.168.99.174:123
Jul 27 05:26:59 hanvolumio ntpd[1095]: Listening on routing socket on fd #20 for interface updates
Jul 27 05:26:59 hanvolumio ntpd[1095]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jul 27 05:26:59 hanvolumio ntpd[1095]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jul 27 05:26:59 hanvolumio winbindd[1029]: [2024/07/27 05:26:59.260843, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Jul 27 05:26:59 hanvolumio winbindd[1029]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Jul 27 05:26:59 hanvolumio systemd[1]: Started Samba Winbind Daemon.
Jul 27 05:26:59 hanvolumio systemd[1]: Starting Samba SMB Daemon...
Jul 27 05:26:59 hanvolumio volumio[807]: info: Loading plugin "ytmusic"...
Jul 27 05:26:59 hanvolumio smbd[1099]: [2024/07/27 05:26:59.856636, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Jul 27 05:26:59 hanvolumio smbd[1099]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Jul 27 05:26:59 hanvolumio systemd[1]: Started Samba SMB Daemon.
Jul 27 05:26:59 hanvolumio systemd[1]: Reached target Multi-User System.
Jul 27 05:26:59 hanvolumio systemd[1]: Reached target Graphical Interface.
Jul 27 05:26:59 hanvolumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Jul 27 05:26:59 hanvolumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Jul 27 05:26:59 hanvolumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Jul 27 05:26:59 hanvolumio systemd[1]: Startup finished in 7.669s (kernel) + 9.279s (userspace) = 16.949s.
Jul 27 05:27:00 hanvolumio ntpd[1095]: Soliciting pool server 220.135.175.159
Jul 27 05:27:00 hanvolumio volumio[807]: info: Loading plugin "now_playing"...
Jul 27 05:27:01 hanvolumio ntpd[1095]: Soliciting pool server 118.163.81.63
Jul 27 05:27:01 hanvolumio ntpd[1095]: Soliciting pool server 118.163.81.61
Jul 27 05:27:01 hanvolumio volumio[807]: info: Loading plugin "outputs"...
Jul 27 05:27:01 hanvolumio volumio[807]: info: Loading plugin "albumart"...
Jul 27 05:27:01 hanvolumio volumio[807]: info: Plugin example_plugin is not enabled
Jul 27 05:27:02 hanvolumio volumio[807]: info: Loading plugin "inputs"...
Jul 27 05:27:02 hanvolumio volumio[807]: info: Loading plugin "updater_comm"...
Jul 27 05:27:02 hanvolumio ntpd[1095]: Soliciting pool server 125.229.106.76
Jul 27 05:27:02 hanvolumio ntpd[1095]: Soliciting pool server 103.159.118.4
Jul 27 05:27:02 hanvolumio ntpd[1095]: Soliciting pool server 114.33.15.129
Jul 27 05:27:02 hanvolumio volumio[807]: Forking 1 albumart workers
Jul 27 05:27:02 hanvolumio volumio[807]: info: Plugin mpdemulation is not enabled
Jul 27 05:27:02 hanvolumio volumio[807]: info: Loading plugin "rest_api"...
Jul 27 05:27:02 hanvolumio volumio[807]: info: Loading plugin "websocket"...
Jul 27 05:27:02 hanvolumio volumio[807]: info: Starting Socket.io Server version 2.3.0
Jul 27 05:27:02 hanvolumio volumio[807]: info: Loading i18n strings for locale zh_TW
Jul 27 05:27:02 hanvolumio volumio[807]: Updating browse sources language
Jul 27 05:27:02 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 27 05:27:02 hanvolumio volumio[807]: Starting albumart workers
Jul 27 05:27:03 hanvolumio ntpd[1095]: Soliciting pool server 118.163.74.161
Jul 27 05:27:03 hanvolumio ntpd[1095]: Soliciting pool server 183.177.72.202
Jul 27 05:27:03 hanvolumio ntpd[1095]: Soliciting pool server 122.117.253.246
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::initPlayerControls
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: Express server listening on port 3000
Jul 27 05:27:03 hanvolumio volumio[807]: [Metrics] WebUI: 8s 45.88ms
Jul 27 05:27:03 hanvolumio volumio[807]: info: Setting Device type: x86
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreStateMachine::resetVolumioState
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreStateMachine::getcurrentVolume
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::volumioRetrievevolume
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Jul 27 05:27:03 hanvolumio volumio[807]: info: Completed loading Core Plugins
Jul 27 05:27:03 hanvolumio volumio[807]: info: Preparing to generate the ALSA configuration file
Jul 27 05:27:03 hanvolumio ntpd[1095]: Soliciting pool server 123.204.232.128
Jul 27 05:27:03 hanvolumio volumio[807]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds
Jul 27 05:27:03 hanvolumio volumio[807]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Jul 27 05:27:03 hanvolumio volumio[807]: sudo: unable to resolve host hanvolumio: System error
Jul 27 05:27:03 hanvolumio volumio[807]: wlan0 Interface doesn't support scanning.
Jul 27 05:27:03 hanvolumio volumio[807]: info: Cannot use regular scanning, forcing with ap-force
Jul 27 05:27:03 hanvolumio sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Jul 27 05:27:03 hanvolumio sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:03 hanvolumio sudo[1193]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:03 hanvolumio volumio[807]: command failed: No such device (-19)
Jul 27 05:27:03 hanvolumio volumio[807]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Jul 27 05:27:03 hanvolumio volumio[807]: command failed: No such device (-19)
Jul 27 05:27:03 hanvolumio volumio[807]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Jul 27 05:27:03 hanvolumio volumio[807]: info: Reloading queue from file
Jul 27 05:27:03 hanvolumio volumio[807]: info: VolumeController:: Volume=100 Mute =false
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreStateMachine::pushState
Jul 27 05:27:03 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::volumioPushState
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreStateMachine::updateTrackBlock
Jul 27 05:27:03 hanvolumio volumio[807]: info: CorePlayQueue::getTrackBlock
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::volumioRetrievevolume
Jul 27 05:27:03 hanvolumio volumio[807]: info: Asound.conf file unchanged, so no further update is needed
Jul 27 05:27:03 hanvolumio volumio[807]: info: Output device has changed, restarting MPD
Jul 27 05:27:03 hanvolumio volumio[807]: info: Output device has changed, restarting Shairport Sync
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:03 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 27 05:27:03 hanvolumio sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 27 05:27:04 hanvolumio sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:04 hanvolumio sudo[1207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 27 05:27:04 hanvolumio sudo[1205]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:04 hanvolumio sudo[1207]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:04 hanvolumio volumio[807]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 27 05:27:04 hanvolumio volumio[807]: info: ___________ START PLUGINS ___________
Jul 27 05:27:04 hanvolumio volumio[807]: info: ControllerMpd::onStart: Initializing MPD
Jul 27 05:27:04 hanvolumio volumio[807]: info: Creating MPD Configuration file
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 27 05:27:04 hanvolumio volumio[807]: info: [1722058024071] CoreMusicLibrary::Adding element Media Servers
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 27 05:27:04 hanvolumio systemd[1]: Listening on mpd.socket.
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:04 hanvolumio systemd[1]: Starting Music Player Daemon...
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 27 05:27:04 hanvolumio sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 27 05:27:04 hanvolumio sudo[1215]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 27 05:27:04 hanvolumio sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:04 hanvolumio sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:04 hanvolumio sudo[1215]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Jul 27 05:27:04 hanvolumio sudo[1215]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:04 hanvolumio sudo[1216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 27 05:27:04 hanvolumio sudo[1214]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:04 hanvolumio sudo[1216]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:04 hanvolumio ntpd[1095]: Soliciting pool server 210.243.152.152
Jul 27 05:27:04 hanvolumio ntpd[1095]: Soliciting pool server 114.34.171.136
Jul 27 05:27:04 hanvolumio ntpd[1095]: Soliciting pool server 183.177.72.201
Jul 27 05:27:04 hanvolumio volumio[807]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 27 05:27:04 hanvolumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jul 27 05:27:04 hanvolumio systemd[1]: mpd.service: Succeeded.
Jul 27 05:27:04 hanvolumio systemd[1]: Stopped Music Player Daemon.
Jul 27 05:27:04 hanvolumio systemd[1]: Starting Music Player Daemon...
Jul 27 05:27:04 hanvolumio volumio[807]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 27 05:27:04 hanvolumio volumio[807]: info: [1722058024345] CoreMusicLibrary::Adding element Last_100
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 27 05:27:04 hanvolumio volumio[807]: info: [1722058024346] CoreMusicLibrary::Adding element Webradio
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 27 05:27:04 hanvolumio volumio[807]: info: Initializing BBC Radios
Jul 27 05:27:04 hanvolumio sudo[1225]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 27 05:27:04 hanvolumio sudo[1225]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:04 hanvolumio sudo[1225]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Jul 27 05:27:04 hanvolumio sudo[1225]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 27 05:27:04 hanvolumio volumio[807]: info: Creating Spotify config file
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 27 05:27:04 hanvolumio volumio[807]: info: [1722058024510] CoreMusicLibrary::Adding element YouTube Music
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 27 05:27:04 hanvolumio volumio[807]: Cannot find translation for source YouTube Music
Jul 27 05:27:04 hanvolumio volumio[807]: info: [now-playing-config] Config is up to date.
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 27 05:27:04 hanvolumio volumio[807]: info: Discovery: Getting this device information
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::volumioGetState
Jul 27 05:27:04 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 27 05:27:04 hanvolumio volumio[807]: info: Volumio Calling Home
Jul 27 05:27:04 hanvolumio volumio[807]: info: [now-playing-app] App is listening on port 4004.
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreStateMachine::setRepeat false single undefined
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreStateMachine::pushState
Jul 27 05:27:04 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::volumioPushState
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreStateMachine::setRandom true
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreStateMachine::pushState
Jul 27 05:27:04 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::volumioPushState
Jul 27 05:27:04 hanvolumio volumio[807]: info: MPD Permissions set
Jul 27 05:27:04 hanvolumio volumio[807]: info: Spotify config file written
Jul 27 05:27:04 hanvolumio sudo[1247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 27 05:27:04 hanvolumio sudo[1247]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:04 hanvolumio sudo[1247]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:04 hanvolumio sudo[1248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 27 05:27:04 hanvolumio sudo[1248]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:04 hanvolumio volumio[807]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Jul 27 05:27:04 hanvolumio volumio[807]: info: Discovery: adding a6ef1aa9-91b2-4018-b9f4-9e5d420aee05
Jul 27 05:27:04 hanvolumio volumio[807]: info: Discovery: Found device han_Volumio
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::volumioGetState
Jul 27 05:27:04 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:04 hanvolumio sudo[1251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:04 hanvolumio sudo[1248]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:04 hanvolumio sudo[1251]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:04 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:05 hanvolumio systemd[1]: Started go-librespot Daemon.
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:05 hanvolumio go-librespot[1262]: Librespot-go daemon starting...
Jul 27 05:27:05 hanvolumio sudo[1251]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 27 05:27:05 hanvolumio volumio[807]: info: VolumeController:: Volume=100 Mute =false
Jul 27 05:27:05 hanvolumio ntpd[1095]: Soliciting pool server 114.35.131.27
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreStateMachine::pushState
Jul 27 05:27:05 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::volumioPushState
Jul 27 05:27:05 hanvolumio ntpd[1095]: Soliciting pool server 125.229.162.223
Jul 27 05:27:05 hanvolumio volumio[807]: info: Volumio called home
Jul 27 05:27:05 hanvolumio volumio[807]: info: Starting Shairport Sync
Jul 27 05:27:05 hanvolumio volumio[807]: info: Starting Shairport Sync
Jul 27 05:27:05 hanvolumio volumio[807]: info: Starting Shairport Sync
Jul 27 05:27:05 hanvolumio volumio[807]: verbose: New Socket.io Connection to 192.168.99.174 from 192.168.99.154 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Jul 27 05:27:05 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:05Z" level=info msg="generated new device id: 4475cc0fe5003d8593a2384f44de3056839e6a0f"
Jul 27 05:27:05 hanvolumio sudo[1274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::volumioGetState
Jul 27 05:27:05 hanvolumio sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 27 05:27:05 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:05Z" level=debug msg="stored credentials found for 31ugyez5ziuof5vbs5ax2jjdb4ce"
Jul 27 05:27:05 hanvolumio sudo[1274]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:05 hanvolumio sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:05 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 27 05:27:05 hanvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 27 05:27:05 hanvolumio systemd[1]: shairport-sync.service: Succeeded.
Jul 27 05:27:05 hanvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 27 05:27:05 hanvolumio sudo[1278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 27 05:27:05 hanvolumio sudo[1278]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:05 hanvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 27 05:27:05 hanvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 27 05:27:05 hanvolumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jul 27 05:27:05 hanvolumio systemd[1]: shairport-sync.service: Succeeded.
Jul 27 05:27:05 hanvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 27 05:27:05 hanvolumio sudo[1274]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:05 hanvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 27 05:27:05 hanvolumio sudo[1277]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:05 hanvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 27 05:27:05 hanvolumio systemd[1]: shairport-sync.service: Succeeded.
Jul 27 05:27:05 hanvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 27 05:27:05 hanvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 27 05:27:05 hanvolumio sudo[1278]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::volumioGetState
Jul 27 05:27:05 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::volumioGetQueue
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreStateMachine::getQueue
Jul 27 05:27:05 hanvolumio volumio[807]: info: CorePlayQueue::getQueue
Jul 27 05:27:05 hanvolumio volumio[807]: info: Listing playlists
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 27 05:27:05 hanvolumio volumio[807]: info: Received Get System Info
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 27 05:27:05 hanvolumio volumio[807]: info: Discovery: Getting this device information
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::volumioGetState
Jul 27 05:27:05 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::volumioGetState
Jul 27 05:27:05 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jul 27 05:27:05 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 27 05:27:05 hanvolumio volumio[807]: info: Shairport-Sync Started
Jul 27 05:27:05 hanvolumio volumio[807]: Error adding Membership: Error: addMembership EINVAL
Jul 27 05:27:05 hanvolumio volumio[807]: info: Shairport-Sync Started
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="obtained new client token: AAAmLX65W6g0RxR9SQidjxGDlK9juS2fRxRYhtSDyOQTN2RdTzOG3ganU+QIlNfIHYGv+IlsbqYcAM0XFnoRIDrsFLpfq1m38CbgYsZz6gXjRliHPYi6RBg1HSQKBWf3F9IVqZ+2y6Q8S9NJMncinL2nbP2+cQJtKGV4w2tfYwni17tLVdVe9dKKEtVle1EUFtyXAmoIblp7jjoDImHKRJsvC1CK6HeWcmKuS3wEJhjJOsm1YbAaZ2RX4eNyMw=="
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="completed keyexchange"
Jul 27 05:27:06 hanvolumio ntpd[1095]: Soliciting pool server 112.104.189.124
Jul 27 05:27:06 hanvolumio ntpd[1095]: Soliciting pool server 2405:a640::149
Jul 27 05:27:06 hanvolumio mpd[1232]: Jul 27 05:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 27 05:27:06 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 27 05:27:06 hanvolumio volumio[807]: info: Received Get System Info
Jul 27 05:27:06 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 27 05:27:06 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 27 05:27:06 hanvolumio volumio[807]: info: Discovery: Getting this device information
Jul 27 05:27:06 hanvolumio volumio[807]: info: CoreCommandRouter::volumioGetState
Jul 27 05:27:06 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:06 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="completed challenge"
Jul 27 05:27:06 hanvolumio systemd[1]: Started Music Player Daemon.
Jul 27 05:27:06 hanvolumio sudo[1207]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:06 hanvolumio sudo[1216]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:06 hanvolumio volumio[807]: info: Completed starting Core Plugins
Jul 27 05:27:06 hanvolumio volumio[807]: info: -------------------------------------------
Jul 27 05:27:06 hanvolumio volumio[807]: info: ----- MyVolumio plugins startup ----
Jul 27 05:27:06 hanvolumio volumio[807]: info: -------------------------------------------
Jul 27 05:27:06 hanvolumio volumio[807]: info: [MyVolumio PluginManager] Fetching plans data....
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="authenticated as 31ugyez5ziuof5vbs5ax2jjdb4ce"
Jul 27 05:27:06 hanvolumio volumio[807]: error: MPD error: The expression evaluated to a falsy value:
Jul 27 05:27:06 hanvolumio volumio[807]: assert.ok(self.idling)
Jul 27 05:27:06 hanvolumio volumio[807]: error: The expression evaluated to a falsy value:
Jul 27 05:27:06 hanvolumio volumio[807]: assert.ok(self.idling)
Jul 27 05:27:06 hanvolumio volumio[807]: info: MPD running with PID1232
Jul 27 05:27:06 hanvolumio volumio[807]: ,establishing connection
Jul 27 05:27:06 hanvolumio volumio[807]: error: MPD error: The expression evaluated to a falsy value:
Jul 27 05:27:06 hanvolumio volumio[807]: assert.ok(self.idling)
Jul 27 05:27:06 hanvolumio volumio[807]: error: The expression evaluated to a falsy value:
Jul 27 05:27:06 hanvolumio volumio[807]: assert.ok(self.idling)
Jul 27 05:27:06 hanvolumio volumio[807]: error: updateQueue error: null
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="authenticated as 31ugyez5ziuof5vbs5ax2jjdb4ce"
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="fetched new dealers: [gae2-dealer2.spotify.com:443 guc3-dealer2.spotify.com:443 gue1-dealer2.spotify.com:443 gew1-dealer2.spotify.com:443]"
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="dealer connection opened"
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="received connection id: YmY5ZjE3ZDYtMWUzYi00MTAyLWJkMGUtNWVmZWRkMWI0Yjc0K2RlYWxlcit0Y3A6Ly8wYTYwNDI4Mi5pcC5nYWUyLnNwb3RpZnkubmV0OjU3MDArNzk4RkMyMTU1RUNFQkY3RUMzODM1NkNBREYxMzc0RDg2MkI4MUZGNzg4RjgyM0FENjRDNkVGNkU5MkRFRkI1Qg=="
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336"
Jul 27 05:27:06 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:06Z" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2"
Jul 27 05:27:07 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:07Z" level=debug msg="put connect state because NEW_DEVICE"
Jul 27 05:27:07 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:07Z" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17"
Jul 27 05:27:07 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:07Z" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0"
Jul 27 05:27:07 hanvolumio go-librespot[1262]: time="2024-07-27T05:27:07Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513"
Jul 27 05:27:07 hanvolumio sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 27 05:27:07 hanvolumio sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:07 hanvolumio sudo[1299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 27 05:27:07 hanvolumio sudo[1299]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:07 hanvolumio sudo[1300]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:07 hanvolumio sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 27 05:27:07 hanvolumio sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 27 05:27:07 hanvolumio sudo[1299]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:07 hanvolumio systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 27 05:27:07 hanvolumio sudo[1302]: pam_unix(sudo:session): session closed for user root
Jul 27 05:27:07 hanvolumio volumio[807]: info: Upmpdcli Daemon Started
Jul 27 05:27:07 hanvolumio volumio[1308]: Generating RSA private key, 4096 bit long modulus (2 primes)
Jul 27 05:27:07 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 27 05:27:07 hanvolumio volumio[807]: info: Received Get System Info
Jul 27 05:27:07 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 27 05:27:07 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 27 05:27:07 hanvolumio volumio[807]: info: Discovery: Getting this device information
Jul 27 05:27:07 hanvolumio volumio[807]: info: CoreCommandRouter::volumioGetState
Jul 27 05:27:07 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 0
Jul 27 05:27:07 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 27 05:27:07 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jul 27 05:27:07 hanvolumio volumio[1308]: ..........................++++
Jul 27 05:27:08 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Jul 27 05:27:08 hanvolumio volumio[807]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------
Jul 27 05:27:08 hanvolumio volumio[807]: SPOTIFY: BQB-WpmyIF8iye63Dcavz-vxEY8rtyuqIteLWp3VRN1y7oyxmmWe-RmCx_3CD2kTzeqiqMUxGn-hGbtw9ivNqB-Qw5WbrNbnNsjDPsMIshNuastffWuDBZ9phjYBWcdtov1uNXEg0XrKTGRdmiHoTXtZKu66zEPp1Y3PLvflUcOaS1kQzLqgH49Jxrw0jHugUhqq9rhRooNrrEKb6N6Kl-fWcxx-mLyoQTHtRzvHx9KQ7ba7Xx2aEAt6En2o9v2oSF-zw7t74LHgJelc
Jul 27 05:27:08 hanvolumio volumio[807]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------
Jul 27 05:27:08 hanvolumio volumio[807]: info: New Spotify access token = BQB-WpmyIF8iye63Dcavz-vxEY8rtyuqIteLWp3VRN1y7oyxmmWe-RmCx_3CD2kTzeqiqMUxGn-hGbtw9ivNqB-Qw5WbrNbnNsjDPsMIshNuastffWuDBZ9phjYBWcdtov1uNXEg0XrKTGRdmiHoTXtZKu66zEPp1Y3PLvflUcOaS1kQzLqgH49Jxrw0jHugUhqq9rhRooNrrEKb6N6Kl-fWcxx-mLyoQTHtRzvHx9KQ7ba7Xx2aEAt6En2o9v2oSF-zw7t74LHgJelc
Jul 27 05:27:08 hanvolumio volumio[807]: info: Spotify credentials grant success - running version from March 24, 2019
Jul 27 05:27:08 hanvolumio volumio[1308]: ...........................................................++++
Jul 27 05:27:08 hanvolumio volumio[1308]: e is 65537 (0x010001)
Jul 27 05:27:08 hanvolumio volumio[1308]: writing RSA key
Jul 27 05:27:08 hanvolumio volumio[807]: SPOTIFY: User informations: {"display_name":"han30959769","external_urls":{"spotify":"https://open.spotify.com/user/31ugyez5ziuof5vbs5ax2jjdb4ce"},"href":"https://api.spotify.com/v1/users/31ugyez5ziuof5vbs5ax2jjdb4ce","id":"31ugyez5ziuof5vbs5ax2jjdb4ce","images":[],"type":"user","uri":"spotify:user:31ugyez5ziuof5vbs5ax2jjdb4ce","followers":{"href":null,"total":0},"country":"TW","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"hanson30959769@gmail.com"}
Jul 27 05:27:08 hanvolumio volumio[807]: info: Spotify Successfully logged in
Jul 27 05:27:08 hanvolumio volumio[807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 27 00:06:52 hanvolumio volumio[807]: info: Enabling plugin now_playing
Jul 27 00:06:52 hanvolumio volumio[807]: info: Loading plugin "now_playing"...
Jul 27 00:06:52 hanvolumio volumio[807]: error: !!!! WARNING !!!!
Jul 27 00:06:52 hanvolumio volumio[807]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry
Jul 27 00:06:52 hanvolumio volumio[807]: error: Stack trace: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry
Jul 27 00:06:52 hanvolumio volumio[807]: at tryPackage (internal/modules/cjs/loader.js:349:19)
Jul 27 00:06:52 hanvolumio volumio[807]: at Function.Module._findPath (internal/modules/cjs/loader.js:562:18)
Jul 27 00:06:52 hanvolumio volumio[807]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:917:27)
Jul 27 00:06:52 hanvolumio volumio[807]: at Function.Module._load (internal/modules/cjs/loader.js:774:27)
Jul 27 00:06:52 hanvolumio volumio[807]: at Module.require (internal/modules/cjs/loader.js:1003:19)
Jul 27 00:06:52 hanvolumio volumio[807]: at require (internal/modules/cjs/helpers.js:107:18)
Jul 27 00:06:52 hanvolumio volumio[807]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34)
Jul 27 00:06:52 hanvolumio volumio[807]: at Module._compile (internal/modules/cjs/loader.js:1114:14)
Jul 27 00:06:52 hanvolumio volumio[807]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10)
Jul 27 00:06:52 hanvolumio volumio[807]: at Module.load (internal/modules/cjs/loader.js:979:32)
Jul 27 00:06:52 hanvolumio volumio[807]: at Function.Module._load (internal/modules/cjs/loader.js:819:12)
Jul 27 00:06:52 hanvolumio volumio[807]: at Module.require (internal/modules/cjs/loader.js:1003:19)
Jul 27 00:06:52 hanvolumio volumio[807]: at require (internal/modules/cjs/helpers.js:107:18)
Jul 27 00:06:52 hanvolumio volumio[807]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29)
Jul 27 00:06:52 hanvolumio volumio[807]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Jul 27 00:06:52 hanvolumio volumio[807]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Jul 27 00:06:52 hanvolumio volumio[807]: error: !!!! WARNING !!!!
Jul 27 00:06:52 hanvolumio volumio[807]: info: Done.
Jul 27 00:06:55 hanvolumio volumio[807]: info: Enabling plugin now_playing
Jul 27 00:06:55 hanvolumio volumio[807]: info: Loading plugin "now_playing"...
Jul 27 00:06:55 hanvolumio volumio[807]: error: !!!! WARNING !!!!
Jul 27 00:06:55 hanvolumio volumio[807]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry
Jul 27 00:06:55 hanvolumio volumio[807]: error: Stack trace: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry
Jul 27 00:06:55 hanvolumio volumio[807]: at tryPackage (internal/modules/cjs/loader.js:349:19)
Jul 27 00:06:55 hanvolumio volumio[807]: at Function.Module._findPath (internal/modules/cjs/loader.js:562:18)
Jul 27 00:06:55 hanvolumio volumio[807]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:917:27)
Jul 27 00:06:55 hanvolumio volumio[807]: at Function.Module._load (internal/modules/cjs/loader.js:774:27)
Jul 27 00:06:55 hanvolumio volumio[807]: at Module.require (internal/modules/cjs/loader.js:1003:19)
Jul 27 00:06:55 hanvolumio volumio[807]: at require (internal/modules/cjs/helpers.js:107:18)
Jul 27 00:06:55 hanvolumio volumio[807]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34)
Jul 27 00:06:55 hanvolumio volumio[807]: at Module._compile (internal/modules/cjs/loader.js:1114:14)
Jul 27 00:06:55 hanvolumio volumio[807]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10)
Jul 27 00:06:55 hanvolumio volumio[807]: at Module.load (internal/modules/cjs/loader.js:979:32)
Jul 27 00:06:55 hanvolumio volumio[807]: at Function.Module._load (internal/modules/cjs/loader.js:819:12)
Jul 27 00:06:55 hanvolumio volumio[807]: at Module.require (internal/modules/cjs/loader.js:1003:19)
Jul 27 00:06:55 hanvolumio volumio[807]: at require (internal/modules/cjs/helpers.js:107:18)
Jul 27 00:06:55 hanvolumio volumio[807]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29)
Jul 27 00:06:55 hanvolumio volumio[807]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Jul 27 00:06:55 hanvolumio volumio[807]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Jul 27 00:06:55 hanvolumio volumio[807]: error: !!!! WARNING !!!!
Jul 27 00:06:55 hanvolumio volumio[807]: info: Error: TypeError: Cannot read property 'printToastMessage' of null
Jul 27 00:06:56 hanvolumio volumio[807]: info: Enabling plugin now_playing
Jul 27 00:06:56 hanvolumio volumio[807]: info: Loading plugin "now_playing"...
Jul 27 00:06:56 hanvolumio volumio[807]: error: !!!! WARNING !!!!
Jul 27 00:06:56 hanvolumio volumio[807]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry
Jul 27 00:06:56 hanvolumio volumio[807]: error: Stack trace: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry
Jul 27 00:06:56 hanvolumio volumio[807]: at tryPackage (internal/modules/cjs/loader.js:349:19)
Jul 27 00:06:56 hanvolumio volumio[807]: at Function.Module._findPath (internal/modules/cjs/loader.js:562:18)
Jul 27 00:06:56 hanvolumio volumio[807]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:917:27)
Jul 27 00:06:56 hanvolumio volumio[807]: at Function.Module._load (internal/modules/cjs/loader.js:774:27)
Jul 27 00:06:56 hanvolumio volumio[807]: at Module.require (internal/modules/cjs/loader.js:1003:19)
Jul 27 00:06:56 hanvolumio volumio[807]: at require (internal/modules/cjs/helpers.js:107:18)
Jul 27 00:06:56 hanvolumio volumio[807]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34)
Jul 27 00:06:56 hanvolumio volumio[807]: at Module._compile (internal/modules/cjs/loader.js:1114:14)
Jul 27 00:06:56 hanvolumio volumio[807]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10)
Jul 27 00:06:56 hanvolumio volumio[807]: at Module.load (internal/modules/cjs/loader.js:979:32)
Jul 27 00:06:56 hanvolumio volumio[807]: at Function.Module._load (internal/modules/cjs/loader.js:819:12)
Jul 27 00:06:56 hanvolumio volumio[807]: at Module.require (internal/modules/cjs/loader.js:1003:19)
Jul 27 00:06:56 hanvolumio volumio[807]: at require (internal/modules/cjs/helpers.js:107:18)
Jul 27 00:06:56 hanvolumio volumio[807]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29)
Jul 27 00:06:56 hanvolumio volumio[807]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Jul 27 00:06:56 hanvolumio volumio[807]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Jul 27 00:06:56 hanvolumio volumio[807]: error: !!!! WARNING !!!!
Jul 27 00:06:56 hanvolumio volumio[807]: info: Error: TypeError: Cannot read property 'printToastMessage' of null
Jul 27 00:06:57 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 10
Jul 27 00:06:57 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 39
Jul 27 00:06:57 hanvolumio volumio[807]: info: Prefetching next song
Jul 27 00:06:59 hanvolumio volumio[807]: info: Enabling plugin now_playing
Jul 27 00:06:59 hanvolumio volumio[807]: info: Loading plugin "now_playing"...
Jul 27 00:06:59 hanvolumio volumio[807]: error: !!!! WARNING !!!!
Jul 27 00:06:59 hanvolumio volumio[807]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry
Jul 27 00:06:59 hanvolumio volumio[807]: error: Stack trace: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry
Jul 27 00:06:59 hanvolumio volumio[807]: at tryPackage (internal/modules/cjs/loader.js:349:19)
Jul 27 00:06:59 hanvolumio volumio[807]: at Function.Module._findPath (internal/modules/cjs/loader.js:562:18)
Jul 27 00:06:59 hanvolumio volumio[807]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:917:27)
Jul 27 00:06:59 hanvolumio volumio[807]: at Function.Module._load (internal/modules/cjs/loader.js:774:27)
Jul 27 00:06:59 hanvolumio volumio[807]: at Module.require (internal/modules/cjs/loader.js:1003:19)
Jul 27 00:06:59 hanvolumio volumio[807]: at require (internal/modules/cjs/helpers.js:107:18)
Jul 27 00:06:59 hanvolumio volumio[807]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34)
Jul 27 00:06:59 hanvolumio volumio[807]: at Module._compile (internal/modules/cjs/loader.js:1114:14)
Jul 27 00:06:59 hanvolumio volumio[807]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10)
Jul 27 00:06:59 hanvolumio volumio[807]: at Module.load (internal/modules/cjs/loader.js:979:32)
Jul 27 00:06:59 hanvolumio volumio[807]: at Function.Module._load (internal/modules/cjs/loader.js:819:12)
Jul 27 00:06:59 hanvolumio volumio[807]: at Module.require (internal/modules/cjs/loader.js:1003:19)
Jul 27 00:06:59 hanvolumio volumio[807]: at require (internal/modules/cjs/helpers.js:107:18)
Jul 27 00:06:59 hanvolumio volumio[807]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29)
Jul 27 00:06:59 hanvolumio volumio[807]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Jul 27 00:06:59 hanvolumio volumio[807]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Jul 27 00:06:59 hanvolumio volumio[807]: error: !!!! WARNING !!!!
Jul 27 00:06:59 hanvolumio volumio[807]: info: Error: TypeError: Cannot read property 'printToastMessage' of null
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=trace msg="emitting websocket event: not_playing"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=debug msg="loading track spotify:track:5iJKGpnFfvbjZJeAtwXfCj (paused: true, position: 0ms)"
Jul 27 00:07:01 hanvolumio volumio[807]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:5iJKGpnFfvbjZJeAtwXfCj","play_origin":"go-librespot"}}
Jul 27 00:07:01 hanvolumio volumio[807]: error: Failed to decode event: not_playing
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=trace msg="emitting websocket event: will_play"
Jul 27 00:07:01 hanvolumio volumio[807]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:5iJKGpnFfvbjZJeAtwXfCj","play_origin":"go-librespot"}}
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:5iJKGpnFfvbjZJeAtwXfCj"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=debug msg="requested aes key for file 0af6d4f4eaba026aec923781d2ea998219aeaf78, gid: 5iJKGpnFfvbjZJeAtwXfCj"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=debug msg="fetched first chunk of 17, total size is 8773374 bytes"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=info msg="loaded track \"28\" (uri: spotify:track:5iJKGpnFfvbjZJeAtwXfCj, paused: true, position: 0ms, duration: 233333ms)"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=debug msg="fetched chunk 1/16, size: 524288"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=debug msg="fetched chunk 2/16, size: 524288"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=trace msg="emitting websocket event: metadata"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=trace msg="emitting websocket event: stopped"
Jul 27 00:07:01 hanvolumio volumio[807]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:5iJKGpnFfvbjZJeAtwXfCj","name":"28","artist_names":["Zach Bryan"],"album_name":"The Great American Bar Scene","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02647ad18a07e9e939e399e5a1","position":0,"duration":233333,"release_date":"year:2024 month:7 day:4","track_number":4,"disc_number":1}}
Jul 27 00:07:01 hanvolumio volumio[807]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":"go-librespot"}}
Jul 27 00:07:01 hanvolumio volumio[807]: SPOTIFY: PUSH STATE SPOTIFY
Jul 27 00:07:01 hanvolumio volumio[807]: SPOTIFY: {"status":"stop","service":"spop","title":"28","artist":"Zach Bryan","album":"The Great American Bar Scene","albumart":"https://i.scdn.co/image/ab67616d00001e02647ad18a07e9e939e399e5a1","uri":"spotify:track:5iJKGpnFfvbjZJeAtwXfCj","trackType":"spotify","seek":0,"duration":233,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jul 27 00:07:01 hanvolumio volumio[807]: info: CoreCommandRouter::servicePushState
Jul 27 00:07:01 hanvolumio volumio[807]: info: CoreStateMachine::pushState
Jul 27 00:07:01 hanvolumio volumio[807]: info: CorePlayQueue::getTrack 10
Jul 27 00:07:01 hanvolumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 27 00:07:01 hanvolumio volumio[807]: info: CoreCommandRouter::volumioPushState
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=debug msg="fetched chunk 3/16, size: 524288"
Jul 27 00:07:01 hanvolumio volumio[807]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 27 00:07:01 hanvolumio volumio[807]: TypeError: Cannot read property 'pushState' of null
Jul 27 00:07:01 hanvolumio volumio[807]: at /volumio/app/index.js:325:32
Jul 27 00:07:01 hanvolumio volumio[807]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17)
Jul 27 00:07:01 hanvolumio volumio[807]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12)
Jul 27 00:07:01 hanvolumio volumio[807]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:323:13)
Jul 27 00:07:01 hanvolumio volumio[807]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:527:22)
Jul 27 00:07:01 hanvolumio volumio[807]: at CoreStateMachine.syncState (/volumio/app/statemachine.js:592:10)
Jul 27 00:07:01 hanvolumio volumio[807]: at CoreCommandRouter.servicePushState (/volumio/app/index.js:413:28)
Jul 27 00:07:01 hanvolumio volumio[807]: at ControllerSpotify.pushState (/data/plugins/music_service/spop/index.js:429:31)
Jul 27 00:07:01 hanvolumio volumio[807]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:319:14)
Jul 27 00:07:01 hanvolumio volumio[807]: at WebSocket.message (/data/plugins/music_service/spop/index.js:189:14)
Jul 27 00:07:01 hanvolumio volumio[807]: at WebSocket.emit (events.js:400:28)
Jul 27 00:07:01 hanvolumio volumio[807]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1209:20)
Jul 27 00:07:01 hanvolumio volumio[807]: at Receiver.emit (events.js:400:28)
Jul 27 00:07:01 hanvolumio volumio[807]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:594:14)
Jul 27 00:07:01 hanvolumio volumio[807]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10)
Jul 27 00:07:01 hanvolumio volumio[807]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16)
Jul 27 00:07:01 hanvolumio volumio[807]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 27 00:07:01 hanvolumio go-librespot[1262]: time="2024-07-27T00:07:01Z" level=trace msg="emitting websocket event: paused"
Jul 27 00:07:02 hanvolumio sudo[9832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-27 00:06
Jul 27 00:07:02 hanvolumio sudo[9832]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"