-- Logs begin at Sat 2025-03-01 13:37:07 CET, end at Sat 2025-03-01 13:37:48 CET. -- Mar 01 13:37:07 volumiodk kernel: Booting Linux on physical CPU 0x0 Mar 01 13:37:07 volumiodk kernel: Linux version 5.15.93-sunxi (root@thinkcentre) (arm-linux-gnueabihf-gcc (GNU Toolchain for the A-profile Architecture 8.3-2019.03 (arm-rel-8.36)) 8.3.0, GNU ld (GNU Toolchain for the A-profile Architecture 8.3-2019.03 (arm-rel-8.36)) 2.32.0.20190321) #trunk SMP Fri Jan 19 12:21:53 CET 2024 Mar 01 13:37:07 volumiodk kernel: CPU: ARMv7 Processor [410fc074] revision 4 (ARMv7), cr=50c5387d Mar 01 13:37:07 volumiodk kernel: CPU: div instructions available: patching division code Mar 01 13:37:07 volumiodk kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache Mar 01 13:37:07 volumiodk kernel: OF: fdt: Machine model: LeMaker Banana Pi Mar 01 13:37:07 volumiodk kernel: Memory policy: Data cache writealloc Mar 01 13:37:07 volumiodk kernel: Reserved memory: created CMA memory pool at 0x4a000000, size 96 MiB Mar 01 13:37:07 volumiodk kernel: OF: reserved mem: initialized node default-pool, compatible id shared-dma-pool Mar 01 13:37:07 volumiodk kernel: Zone ranges: Mar 01 13:37:07 volumiodk kernel: Normal [mem 0x0000000040000000-0x000000006fffffff] Mar 01 13:37:07 volumiodk kernel: HighMem [mem 0x0000000070000000-0x000000007e00efff] Mar 01 13:37:07 volumiodk kernel: Movable zone start for each node Mar 01 13:37:07 volumiodk kernel: Early memory node ranges Mar 01 13:37:07 volumiodk kernel: node 0: [mem 0x0000000040000000-0x000000007e00efff] Mar 01 13:37:07 volumiodk kernel: Initmem setup node 0 [mem 0x0000000040000000-0x000000007e00efff] Mar 01 13:37:07 volumiodk kernel: On node 0, zone HighMem: 1009 pages in unavailable ranges Mar 01 13:37:07 volumiodk kernel: psci: probing for conduit method from DT. Mar 01 13:37:07 volumiodk kernel: psci: Using PSCI v0.1 Function IDs from DT Mar 01 13:37:07 volumiodk kernel: percpu: Embedded 17 pages/cpu s38540 r8192 d22900 u69632 Mar 01 13:37:07 volumiodk kernel: pcpu-alloc: s38540 r8192 d22900 u69632 alloc=17*4096 Mar 01 13:37:07 volumiodk kernel: pcpu-alloc: [0] 0 [0] 1 Mar 01 13:37:07 volumiodk kernel: Built 1 zonelists, mobility grouping on. Total pages: 252239 Mar 01 13:37:07 volumiodk kernel: Kernel command line: root=/dev/mmcblk0p2 rootwait rootfstype=ext4 splash plymouth.ignore-serial-consoles console=ttyS0,115200 console=tty1 hdmi.audio=EDID:0 disp.screen0_output_mode=1920x1080p60 consoleblank=0 loglevel=0 ubootpart=a7d0c7b1-01 ubootsource=mmc usb-storage.quirks=0x2537:0x1066:u,0x2537:0x1068:u imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh net.ifnames=0 sunxi_ve_mem_reserve=0 sunxi_g2d_mem_reserve=0 sunxi_fb_mem_reserve=16 cgroup_enable=memory swapaccount=1 Mar 01 13:37:07 volumiodk kernel: Unknown kernel command line parameters "splash ubootpart=a7d0c7b1-01 ubootsource=mmc imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh sunxi_ve_mem_reserve=0 sunxi_g2d_mem_reserve=0 sunxi_fb_mem_reserve=16 cgroup_enable=memory", will be passed to user space. Mar 01 13:37:07 volumiodk kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) Mar 01 13:37:07 volumiodk kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 01 13:37:07 volumiodk kernel: mem auto-init: stack:off, heap alloc:on, heap free:off Mar 01 13:37:07 volumiodk kernel: Memory: 876076K/1015868K available (9216K kernel code, 1510K rwdata, 3408K rodata, 1024K init, 326K bss, 41488K reserved, 98304K cma-reserved, 229436K highmem) Mar 01 13:37:07 volumiodk kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Mar 01 13:37:07 volumiodk kernel: ftrace: allocating 44001 entries in 130 pages Mar 01 13:37:07 volumiodk kernel: ftrace: allocated 129 pages with 2 groups Mar 01 13:37:07 volumiodk kernel: trace event string verifier disabled Mar 01 13:37:07 volumiodk kernel: rcu: Hierarchical RCU implementation. Mar 01 13:37:07 volumiodk kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2. Mar 01 13:37:07 volumiodk kernel: Rude variant of Tasks RCU enabled. Mar 01 13:37:07 volumiodk kernel: Tracing variant of Tasks RCU enabled. Mar 01 13:37:07 volumiodk kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Mar 01 13:37:07 volumiodk kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Mar 01 13:37:07 volumiodk kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Mar 01 13:37:07 volumiodk kernel: GIC: Using split EOI/Deactivate mode Mar 01 13:37:07 volumiodk kernel: arch_timer: cp15 timer(s) running at 24.00MHz (phys). Mar 01 13:37:07 volumiodk kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns Mar 01 13:37:07 volumiodk kernel: sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns Mar 01 13:37:07 volumiodk kernel: Switching to timer-based delay loop, resolution 41ns Mar 01 13:37:07 volumiodk kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635851949 ns Mar 01 13:37:07 volumiodk kernel: clocksource: hstimer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370868154 ns Mar 01 13:37:07 volumiodk kernel: Console: colour dummy device 80x30 Mar 01 13:37:07 volumiodk kernel: printk: console [tty1] enabled Mar 01 13:37:07 volumiodk kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000) Mar 01 13:37:07 volumiodk kernel: pid_max: default: 32768 minimum: 301 Mar 01 13:37:07 volumiodk kernel: LSM: Security Framework initializing Mar 01 13:37:07 volumiodk kernel: Yama: becoming mindful. Mar 01 13:37:07 volumiodk kernel: AppArmor: AppArmor initialized Mar 01 13:37:07 volumiodk kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Mar 01 13:37:07 volumiodk kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Mar 01 13:37:07 volumiodk kernel: CPU: Testing write buffer coherency: ok Mar 01 13:37:07 volumiodk kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Mar 01 13:37:07 volumiodk kernel: Setting up static identity map for 0x40100000 - 0x40100054 Mar 01 13:37:07 volumiodk kernel: rcu: Hierarchical SRCU implementation. Mar 01 13:37:07 volumiodk kernel: smp: Bringing up secondary CPUs ... Mar 01 13:37:07 volumiodk kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Mar 01 13:37:07 volumiodk kernel: smp: Brought up 1 node, 2 CPUs Mar 01 13:37:07 volumiodk kernel: SMP: Total of 2 processors activated (96.00 BogoMIPS). Mar 01 13:37:07 volumiodk kernel: CPU: All CPU(s) started in HYP mode. Mar 01 13:37:07 volumiodk kernel: CPU: Virtualization extensions available. Mar 01 13:37:07 volumiodk kernel: allocated 1048576 bytes of page_ext Mar 01 13:37:07 volumiodk kernel: devtmpfs: initialized Mar 01 13:37:07 volumiodk kernel: VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 4 Mar 01 13:37:07 volumiodk kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Mar 01 13:37:07 volumiodk kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Mar 01 13:37:07 volumiodk kernel: pinctrl core: initialized pinctrl subsystem Mar 01 13:37:07 volumiodk kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Mar 01 13:37:07 volumiodk kernel: DMA: preallocated 256 KiB pool for atomic coherent allocations Mar 01 13:37:07 volumiodk kernel: audit: initializing netlink subsys (disabled) Mar 01 13:37:07 volumiodk kernel: audit: type=2000 audit(0.036:1): state=initialized audit_enabled=0 res=1 Mar 01 13:37:07 volumiodk kernel: thermal_sys: Registered thermal governor 'fair_share' Mar 01 13:37:07 volumiodk kernel: thermal_sys: Registered thermal governor 'bang_bang' Mar 01 13:37:07 volumiodk kernel: thermal_sys: Registered thermal governor 'step_wise' Mar 01 13:37:07 volumiodk kernel: cpuidle: using governor ladder Mar 01 13:37:07 volumiodk kernel: cpuidle: using governor menu Mar 01 13:37:07 volumiodk kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Mar 01 13:37:07 volumiodk kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Mar 01 13:37:07 volumiodk kernel: platform 1c16000.hdmi: Fixing up cyclic dependency with 1c0d000.lcd-controller Mar 01 13:37:07 volumiodk kernel: platform 1c16000.hdmi: Fixing up cyclic dependency with 1c0c000.lcd-controller Mar 01 13:37:07 volumiodk kernel: platform 1e40000.display-backend: Fixing up cyclic dependency with 1c0d000.lcd-controller Mar 01 13:37:07 volumiodk kernel: platform 1e40000.display-backend: Fixing up cyclic dependency with 1c0c000.lcd-controller Mar 01 13:37:07 volumiodk kernel: platform 1e40000.display-backend: Fixing up cyclic dependency with 1e20000.display-frontend Mar 01 13:37:07 volumiodk kernel: platform 1e40000.display-backend: Fixing up cyclic dependency with 1e00000.display-frontend Mar 01 13:37:07 volumiodk kernel: platform 1e60000.display-backend: Fixing up cyclic dependency with 1c0d000.lcd-controller Mar 01 13:37:07 volumiodk kernel: platform 1e60000.display-backend: Fixing up cyclic dependency with 1c0c000.lcd-controller Mar 01 13:37:07 volumiodk kernel: platform 1e60000.display-backend: Fixing up cyclic dependency with 1e20000.display-frontend Mar 01 13:37:07 volumiodk kernel: platform 1e60000.display-backend: Fixing up cyclic dependency with 1e00000.display-frontend Mar 01 13:37:07 volumiodk kernel: platform hdmi-connector: Fixing up cyclic dependency with 1c16000.hdmi Mar 01 13:37:07 volumiodk kernel: cryptd: max_cpu_qlen set to 1000 Mar 01 13:37:07 volumiodk kernel: raid6: neonx8 gen() 703 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: neonx8 xor() 518 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: neonx4 gen() 755 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: neonx4 xor() 569 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: neonx2 gen() 828 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: neonx2 xor() 590 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: neonx1 gen() 737 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: neonx1 xor() 511 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: int32x8 gen() 274 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: int32x8 xor() 162 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: int32x4 gen() 320 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: int32x4 xor() 186 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: int32x2 gen() 361 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: int32x2 xor() 193 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: int32x1 gen() 363 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: int32x1 xor() 173 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: using algorithm neonx2 gen() 828 MB/s Mar 01 13:37:07 volumiodk kernel: raid6: .... xor() 590 MB/s, rmw enabled Mar 01 13:37:07 volumiodk kernel: raid6: using neon recovery algorithm Mar 01 13:37:07 volumiodk kernel: iommu: Default domain type: Translated Mar 01 13:37:07 volumiodk kernel: iommu: DMA domain TLB invalidation policy: strict mode Mar 01 13:37:07 volumiodk kernel: SCSI subsystem initialized Mar 01 13:37:07 volumiodk kernel: libata version 3.00 loaded. Mar 01 13:37:07 volumiodk kernel: usbcore: registered new interface driver usbfs Mar 01 13:37:07 volumiodk kernel: usbcore: registered new interface driver hub Mar 01 13:37:07 volumiodk kernel: usbcore: registered new device driver usb Mar 01 13:37:07 volumiodk kernel: mc: Linux media interface: v0.10 Mar 01 13:37:07 volumiodk kernel: videodev: Linux video capture interface: v2.00 Mar 01 13:37:07 volumiodk kernel: pps_core: LinuxPPS API ver. 1 registered Mar 01 13:37:07 volumiodk kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Mar 01 13:37:07 volumiodk kernel: PTP clock support registered Mar 01 13:37:07 volumiodk kernel: Advanced Linux Sound Architecture Driver Initialized. Mar 01 13:37:07 volumiodk kernel: NetLabel: Initializing Mar 01 13:37:07 volumiodk kernel: NetLabel: domain hash size = 128 Mar 01 13:37:07 volumiodk kernel: NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO Mar 01 13:37:07 volumiodk kernel: NetLabel: unlabeled traffic allowed by default Mar 01 13:37:07 volumiodk kernel: clocksource: Switched to clocksource arch_sys_counter Mar 01 13:37:07 volumiodk kernel: VFS: Disk quotas dquot_6.6.0 Mar 01 13:37:07 volumiodk kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Mar 01 13:37:07 volumiodk kernel: AppArmor: AppArmor Filesystem Enabled Mar 01 13:37:07 volumiodk kernel: NET: Registered PF_INET protocol family Mar 01 13:37:07 volumiodk kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Mar 01 13:37:07 volumiodk kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear) Mar 01 13:37:07 volumiodk kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 01 13:37:07 volumiodk kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Mar 01 13:37:07 volumiodk kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear) Mar 01 13:37:07 volumiodk kernel: TCP: Hash tables configured (established 8192 bind 8192) Mar 01 13:37:07 volumiodk kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Mar 01 13:37:07 volumiodk kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Mar 01 13:37:07 volumiodk kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Mar 01 13:37:07 volumiodk kernel: Trying to unpack rootfs image as initramfs... Mar 01 13:37:07 volumiodk kernel: armv7-pmu pmu: hw perfevents: no interrupt-affinity property, guessing. Mar 01 13:37:07 volumiodk kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 5 counters available Mar 01 13:37:07 volumiodk kernel: Initialise system trusted keyrings Mar 01 13:37:07 volumiodk kernel: Key type blacklist registered Mar 01 13:37:07 volumiodk kernel: workingset: timestamp_bits=14 max_order=18 bucket_order=4 Mar 01 13:37:07 volumiodk kernel: zbud: loaded Mar 01 13:37:07 volumiodk kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 01 13:37:07 volumiodk kernel: fuse: init (API version 7.34) Mar 01 13:37:07 volumiodk kernel: integrity: Platform Keyring initialized Mar 01 13:37:07 volumiodk kernel: xor: measuring software checksum speed Mar 01 13:37:07 volumiodk kernel: arm4regs : 1171 MB/sec Mar 01 13:37:07 volumiodk kernel: 8regs : 808 MB/sec Mar 01 13:37:07 volumiodk kernel: 32regs : 765 MB/sec Mar 01 13:37:07 volumiodk kernel: neon : 1192 MB/sec Mar 01 13:37:07 volumiodk kernel: xor: using function: neon (1192 MB/sec) Mar 01 13:37:07 volumiodk kernel: Key type asymmetric registered Mar 01 13:37:07 volumiodk kernel: Asymmetric key parser 'x509' registered Mar 01 13:37:07 volumiodk kernel: bounce: pool size: 64 pages Mar 01 13:37:07 volumiodk kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246) Mar 01 13:37:07 volumiodk kernel: io scheduler mq-deadline registered Mar 01 13:37:07 volumiodk kernel: io scheduler kyber registered Mar 01 13:37:07 volumiodk kernel: io scheduler bfq registered Mar 01 13:37:07 volumiodk kernel: sun4i-pinctrl 1c20800.pinctrl: initialized sunXi PIO driver Mar 01 13:37:07 volumiodk kernel: Serial: 8250/16550 driver, 8 ports, IRQ sharing disabled Mar 01 13:37:07 volumiodk kernel: sun4i-pinctrl 1c20800.pinctrl: supply vcc-pb not found, using dummy regulator Mar 01 13:37:07 volumiodk kernel: printk: console [ttyS0] disabled Mar 01 13:37:07 volumiodk kernel: 1c28000.serial: ttyS0 at MMIO 0x1c28000 (irq = 57, base_baud = 1500000) is a 16550A Mar 01 13:37:07 volumiodk kernel: printk: console [ttyS0] enabled Mar 01 13:37:07 volumiodk kernel: sun4i-pinctrl 1c20800.pinctrl: supply vcc-ph not found, using dummy regulator Mar 01 13:37:07 volumiodk kernel: 1c28c00.serial: ttyS1 at MMIO 0x1c28c00 (irq = 58, base_baud = 1500000) is a 16550A Mar 01 13:37:07 volumiodk kernel: sun4i-pinctrl 1c20800.pinctrl: supply vcc-pi not found, using dummy regulator Mar 01 13:37:07 volumiodk kernel: 1c29c00.serial: ttyS2 at MMIO 0x1c29c00 (irq = 59, base_baud = 1500000) is a 16550A Mar 01 13:37:07 volumiodk kernel: sun4i-drm display-engine: bound 1e00000.display-frontend (ops 0xc0aa1490) Mar 01 13:37:07 volumiodk kernel: sun4i-drm display-engine: bound 1e20000.display-frontend (ops 0xc0aa1490) Mar 01 13:37:07 volumiodk kernel: sun4i-drm display-engine: bound 1e60000.display-backend (ops 0xc0aa0c28) Mar 01 13:37:07 volumiodk kernel: sun4i-drm display-engine: bound 1e40000.display-backend (ops 0xc0aa0c28) Mar 01 13:37:07 volumiodk kernel: sun4i-drm display-engine: No panel or bridge found... RGB output disabled Mar 01 13:37:07 volumiodk kernel: sun4i-drm display-engine: bound 1c0c000.lcd-controller (ops 0xc0a9f46c) Mar 01 13:37:07 volumiodk kernel: sun4i-drm display-engine: No panel or bridge found... RGB output disabled Mar 01 13:37:07 volumiodk kernel: sun4i-drm display-engine: bound 1c0d000.lcd-controller (ops 0xc0a9f46c) Mar 01 13:37:07 volumiodk kernel: sun4i-drm display-engine: bound 1c16000.hdmi (ops 0xc0aa1e4c) Mar 01 13:37:07 volumiodk kernel: [drm] Initialized sun4i-drm 1.0.0 20150629 for display-engine on minor 0 Mar 01 13:37:07 volumiodk kernel: sun4i-drm display-engine: [drm] Cannot find any crtc or sizes Mar 01 13:37:07 volumiodk kernel: brd: module loaded Mar 01 13:37:07 volumiodk kernel: loop: module loaded Mar 01 13:37:07 volumiodk kernel: ahci-sunxi 1c18000.sata: supply ahci not found, using dummy regulator Mar 01 13:37:07 volumiodk kernel: ahci-sunxi 1c18000.sata: supply phy not found, using dummy regulator Mar 01 13:37:07 volumiodk kernel: ahci-sunxi 1c18000.sata: supply target not found, using dummy regulator Mar 01 13:37:07 volumiodk kernel: ahci-sunxi 1c18000.sata: PHY power up failed. Mar 01 13:37:07 volumiodk kernel: ahci-sunxi: probe of 1c18000.sata failed with error -5 Mar 01 13:37:07 volumiodk kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Mar 01 13:37:07 volumiodk kernel: ehci-platform: EHCI generic platform driver Mar 01 13:37:07 volumiodk kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Mar 01 13:37:07 volumiodk kernel: ohci-platform: OHCI generic platform driver Mar 01 13:37:07 volumiodk kernel: usbcore: registered new interface driver usb-storage Mar 01 13:37:07 volumiodk kernel: sunxi-rtc 1c20d00.rtc: registered as rtc0 Mar 01 13:37:07 volumiodk kernel: sunxi-rtc 1c20d00.rtc: setting system clock to 2025-03-01T12:36:57 UTC (1740832617) Mar 01 13:37:07 volumiodk kernel: i2c_dev: i2c /dev entries driver Mar 01 13:37:07 volumiodk kernel: axp20x-i2c 1-0034: AXP20x variant AXP209 found Mar 01 13:37:07 volumiodk kernel: input: axp20x-pek as /devices/platform/soc/1c2ac00.i2c/i2c-1/1-0034/axp20x-pek/input/input0 Mar 01 13:37:07 volumiodk kernel: vdd-rtc: supplied by regulator-dummy Mar 01 13:37:07 volumiodk kernel: avcc: supplied by regulator-dummy Mar 01 13:37:07 volumiodk kernel: ldo3: supplied by regulator-dummy Mar 01 13:37:07 volumiodk kernel: ldo4: supplied by regulator-dummy Mar 01 13:37:07 volumiodk kernel: ldo5: supplied by regulator-dummy Mar 01 13:37:07 volumiodk kernel: vdd-cpu: supplied by regulator-dummy Mar 01 13:37:07 volumiodk kernel: vdd-int-dll: supplied by regulator-dummy Mar 01 13:37:07 volumiodk kernel: axp20x-i2c 1-0034: Backup (RTC) battery charging is disabled Mar 01 13:37:07 volumiodk kernel: axp20x-i2c 1-0034: AXP20X driver loaded Mar 01 13:37:07 volumiodk kernel: sunxi-wdt 1c20c90.watchdog: Watchdog enabled (timeout=16 sec, nowayout=0) Mar 01 13:37:07 volumiodk kernel: ledtrig-cpu: registered to indicate activity on CPUs Mar 01 13:37:07 volumiodk kernel: sun4i-ss 1c15000.crypto-engine: no reset control found Mar 01 13:37:07 volumiodk kernel: sun4i-ss 1c15000.crypto-engine: Die ID 0 Mar 01 13:37:07 volumiodk kernel: sunxi-mmc 1c0f000.mmc: Got CD GPIO Mar 01 13:37:07 volumiodk kernel: hid: raw HID events driver (C) Jiri Kosina Mar 01 13:37:07 volumiodk kernel: usbcore: registered new interface driver usbhid Mar 01 13:37:07 volumiodk kernel: usbhid: USB HID core driver Mar 01 13:37:07 volumiodk kernel: debugfs: Directory '1c22c00.codec' with parent 'sun4i-codec' already present! Mar 01 13:37:07 volumiodk kernel: Initializing XFRM netlink socket Mar 01 13:37:07 volumiodk kernel: NET: Registered PF_INET6 protocol family Mar 01 13:37:07 volumiodk kernel: sunxi-mmc 1c0f000.mmc: initialized, max. request size: 16384 KB Mar 01 13:37:07 volumiodk kernel: mmc0: host does not support reading read-only switch, assuming write-enable Mar 01 13:37:07 volumiodk kernel: mmc0: new high speed SDHC card at address 0001 Mar 01 13:37:07 volumiodk kernel: mmcblk0: mmc0:0001 USD 29.1 GiB Mar 01 13:37:07 volumiodk kernel: mmcblk0: p1 p2 p3 Mar 01 13:37:07 volumiodk kernel: Freeing initrd memory: 15044K Mar 01 13:37:07 volumiodk kernel: Segment Routing with IPv6 Mar 01 13:37:07 volumiodk kernel: In-situ OAM (IOAM) with IPv6 Mar 01 13:37:07 volumiodk kernel: NET: Registered PF_PACKET protocol family Mar 01 13:37:07 volumiodk kernel: NET: Registered PF_KEY protocol family Mar 01 13:37:07 volumiodk kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Mar 01 13:37:07 volumiodk kernel: 8021q: 802.1Q VLAN Support v1.8 Mar 01 13:37:07 volumiodk kernel: Key type dns_resolver registered Mar 01 13:37:07 volumiodk kernel: Registering SWP/SWPB emulation handler Mar 01 13:37:07 volumiodk kernel: registered taskstats version 1 Mar 01 13:37:07 volumiodk kernel: Loading compiled-in X.509 certificates Mar 01 13:37:07 volumiodk kernel: Loaded X.509 cert 'Build time autogenerated kernel key: 8f8e38801ad26e1c5752b0545ce65e141a715a7d' Mar 01 13:37:07 volumiodk kernel: zswap: loaded using pool zstd/z3fold Mar 01 13:37:07 volumiodk kernel: Key type .fscrypt registered Mar 01 13:37:07 volumiodk kernel: Key type fscrypt-provisioning registered Mar 01 13:37:07 volumiodk kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=yes Mar 01 13:37:07 volumiodk kernel: Key type encrypted registered Mar 01 13:37:07 volumiodk kernel: AppArmor: AppArmor sha1 policy hashing enabled Mar 01 13:37:07 volumiodk kernel: sun7i-dwmac 1c50000.ethernet: IRQ eth_wake_irq not found Mar 01 13:37:07 volumiodk kernel: sun7i-dwmac 1c50000.ethernet: IRQ eth_lpi not found Mar 01 13:37:07 volumiodk kernel: sun7i-dwmac 1c50000.ethernet: PTP uses main clock Mar 01 13:37:07 volumiodk kernel: sun7i-dwmac 1c50000.ethernet: Version ID not available Mar 01 13:37:07 volumiodk kernel: sun7i-dwmac 1c50000.ethernet: DWMAC1000 Mar 01 13:37:07 volumiodk kernel: sun7i-dwmac 1c50000.ethernet: No HW DMA feature register supported Mar 01 13:37:07 volumiodk kernel: sun7i-dwmac 1c50000.ethernet: TX Checksum insertion supported Mar 01 13:37:07 volumiodk kernel: sun7i-dwmac 1c50000.ethernet: Normal descriptors Mar 01 13:37:07 volumiodk kernel: sun7i-dwmac 1c50000.ethernet: Ring mode enabled Mar 01 13:37:07 volumiodk kernel: of_cfs_init Mar 01 13:37:07 volumiodk kernel: of_cfs_init: OK Mar 01 13:37:07 volumiodk kernel: ALSA device list: Mar 01 13:37:07 volumiodk kernel: #0: sun4i-codec Mar 01 13:37:07 volumiodk kernel: Freeing unused kernel image (initmem) memory: 1024K Mar 01 13:37:07 volumiodk kernel: Run /init as init process Mar 01 13:37:07 volumiodk kernel: with arguments: Mar 01 13:37:07 volumiodk kernel: /init Mar 01 13:37:07 volumiodk kernel: splash Mar 01 13:37:07 volumiodk kernel: with environment: Mar 01 13:37:07 volumiodk kernel: HOME=/ Mar 01 13:37:07 volumiodk kernel: TERM=linux Mar 01 13:37:07 volumiodk kernel: ubootpart=a7d0c7b1-01 Mar 01 13:37:07 volumiodk kernel: ubootsource=mmc Mar 01 13:37:07 volumiodk kernel: imgpart=/dev/mmcblk0p2 Mar 01 13:37:07 volumiodk kernel: imgfile=/volumio_current.sqsh Mar 01 13:37:07 volumiodk kernel: sunxi_ve_mem_reserve=0 Mar 01 13:37:07 volumiodk kernel: sunxi_g2d_mem_reserve=0 Mar 01 13:37:07 volumiodk kernel: sunxi_fb_mem_reserve=16 Mar 01 13:37:07 volumiodk kernel: cgroup_enable=memory Mar 01 13:37:07 volumiodk kernel: sun5i-a13-gpadc-iio: Failed to locate of_node [id: 0] Mar 01 13:37:07 volumiodk kernel: axp20x-gpio axp20x-gpio: DMA mask not set Mar 01 13:37:07 volumiodk kernel: axp20x-gpio axp20x-gpio: AXP209 pinctrl and GPIO driver loaded Mar 01 13:37:07 volumiodk kernel: lima 1c40000.gpu: gp - mali400 version major 1 minor 1 Mar 01 13:37:07 volumiodk kernel: lima 1c40000.gpu: pp0 - mali400 version major 1 minor 1 Mar 01 13:37:07 volumiodk kernel: lima 1c40000.gpu: pp1 - mali400 version major 1 minor 1 Mar 01 13:37:07 volumiodk kernel: lima 1c40000.gpu: l2 cache 64K, 4-way, 64byte cache line, 64bit external bus Mar 01 13:37:07 volumiodk kernel: axp20x-usb-power-supply axp20x-usb-power-supply: DMA mask not set Mar 01 13:37:07 volumiodk kernel: lima 1c40000.gpu: bus rate = 300000000 Mar 01 13:37:07 volumiodk kernel: lima 1c40000.gpu: mod rate = 384000000 Mar 01 13:37:07 volumiodk kernel: [drm] Initialized lima 1.2.0 20200215 for 1c40000.gpu on minor 1 Mar 01 13:37:07 volumiodk kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Mar 01 13:37:07 volumiodk kernel: EXT4-fs (mmcblk0p2): recovery complete Mar 01 13:37:07 volumiodk kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Mar 01 13:37:07 volumiodk kernel: loop0: detected capacity change from 0 to 1341912 Mar 01 13:37:07 volumiodk kernel: EXT4-fs (mmcblk0p3): recovery complete Mar 01 13:37:07 volumiodk kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Mar 01 13:37:07 volumiodk kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038 (0x7fffffff) Mar 01 13:37:07 volumiodk systemd[1]: Inserted module 'autofs4' Mar 01 13:37:07 volumiodk systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Mar 01 13:37:07 volumiodk systemd[1]: Detected architecture arm. Mar 01 13:37:07 volumiodk systemd[1]: Set hostname to . Mar 01 13:37:07 volumiodk systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 01 13:37:07 volumiodk kernel: random: systemd: uninitialized urandom read (16 bytes read) Mar 01 13:37:07 volumiodk kernel: random: systemd: uninitialized urandom read (16 bytes read) Mar 01 13:37:07 volumiodk kernel: random: systemd: uninitialized urandom read (16 bytes read) Mar 01 13:37:07 volumiodk systemd[1]: Listening on RPCbind Server Activation Socket. Mar 01 13:37:07 volumiodk systemd[1]: Created slice system-systemd\x2dfsck.slice. Mar 01 13:37:07 volumiodk systemd[1]: Listening on udev Kernel Socket. Mar 01 13:37:07 volumiodk systemd[1]: Created slice system-serial\x2dgetty.slice. Mar 01 13:37:07 volumiodk systemd[1]: Started Forward Password Requests to Wall Directory Watch. Mar 01 13:37:07 volumiodk systemd[1]: Listening on fsck to fsckd communication Socket. Mar 01 13:37:07 volumiodk kernel: RPC: Registered named UNIX socket transport module. Mar 01 13:37:07 volumiodk kernel: RPC: Registered udp transport module. Mar 01 13:37:07 volumiodk kernel: RPC: Registered tcp transport module. Mar 01 13:37:07 volumiodk kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Mar 01 13:37:07 volumiodk kernel: random: systemd-random-: uninitialized urandom read (512 bytes read) Mar 01 13:37:07 volumiodk kernel: sun4i-drm display-engine: [drm] Cannot find any crtc or sizes Mar 01 13:37:07 volumiodk systemd-journald[430]: Journal started Mar 01 13:37:07 volumiodk systemd-journald[430]: Runtime journal (/run/log/journal/6a0b869a9f938bac12ccb2be6533b273) is 3.7M, max 30.0M, 26.2M free. Mar 01 13:37:07 volumiodk fake-hwclock[414]: Current system time: 2025-03-01 12:37:06 Mar 01 13:37:07 volumiodk fake-hwclock[414]: fake-hwclock saved clock information is in the past: 2025-02-23 15:36:55 Mar 01 13:37:07 volumiodk fake-hwclock[414]: To set system time to this saved clock anyway, use "force" Mar 01 13:37:07 volumiodk kernel: random: systemd-journal: uninitialized urandom read (16 bytes read) Mar 01 13:37:07 volumiodk kernel: random: systemd-journal: uninitialized urandom read (16 bytes read) Mar 01 13:37:07 volumiodk systemd[1]: Started Create System Users. Mar 01 13:37:07 volumiodk systemd[1]: Starting Create Static Device Nodes in /dev... Mar 01 13:37:07 volumiodk systemd[1]: Started Create Static Device Nodes in /dev. Mar 01 13:37:07 volumiodk systemd[1]: Reached target Local File Systems (Pre). Mar 01 13:37:07 volumiodk systemd[1]: Mounting /var/spool/cups... Mar 01 13:37:07 volumiodk systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Mar 01 13:37:07 volumiodk systemd[1]: Mounting /tmp... Mar 01 13:37:07 volumiodk systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Mar 01 13:37:07 volumiodk systemd[1]: Mounting /var/log... Mar 01 13:37:07 volumiodk systemd[1]: Starting udev Kernel Device Manager... Mar 01 13:37:07 volumiodk systemd[1]: Mounted /var/spool/cups. Mar 01 13:37:07 volumiodk systemd[1]: Mounted /tmp. Mar 01 13:37:07 volumiodk systemd[1]: Mounted /var/log. Mar 01 13:37:07 volumiodk systemd[1]: Starting Flush Journal to Persistent Storage... Mar 01 13:37:07 volumiodk systemd[1]: Mounting /var/spool/cups/tmp... Mar 01 13:37:08 volumiodk systemd[1]: Mounted /var/spool/cups/tmp. Mar 01 13:37:08 volumiodk systemd-udevd[448]: Network interface NamePolicy= disabled on kernel command line, ignoring. Mar 01 13:37:08 volumiodk systemd-journald[430]: Runtime journal (/run/log/journal/6a0b869a9f938bac12ccb2be6533b273) is 3.7M, max 30.0M, 26.2M free. Mar 01 13:37:08 volumiodk systemd[1]: Started Flush Journal to Persistent Storage. Mar 01 13:37:08 volumiodk systemd[1]: Started udev Coldplug all Devices. Mar 01 13:37:08 volumiodk systemd[1]: Started udev Kernel Device Manager. Mar 01 13:37:08 volumiodk systemd[1]: Starting Show Plymouth Boot Screen... Mar 01 13:37:08 volumiodk systemd[1]: Starting Helper to synchronize boot up for ifupdown... Mar 01 13:37:08 volumiodk systemd[1]: Started Helper to synchronize boot up for ifupdown. Mar 01 13:37:08 volumiodk systemd[1]: plymouth-start.service: Succeeded. Mar 01 13:37:08 volumiodk systemd[1]: Started Show Plymouth Boot Screen. Mar 01 13:37:08 volumiodk systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 01 13:37:08 volumiodk systemd[1]: Reached target Paths. Mar 01 13:37:08 volumiodk systemd[1]: Reached target Local Encrypted Volumes. Mar 01 13:37:08 volumiodk systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Mar 01 13:37:08 volumiodk kernel: random: systemd: uninitialized urandom read (16 bytes read) Mar 01 13:37:08 volumiodk kernel: random: systemd: uninitialized urandom read (16 bytes read) Mar 01 13:37:09 volumiodk kernel: random: systemd: uninitialized urandom read (16 bytes read) Mar 01 13:37:09 volumiodk kernel: sunxi_cedrus: module is from the staging directory, the quality is unknown, you have been warned. Mar 01 13:37:09 volumiodk kernel: cedrus 1c0e000.video-codec: Device registered as /dev/video0 Mar 01 13:37:09 volumiodk kernel: Registered IR keymap rc-empty Mar 01 13:37:09 volumiodk kernel: rc rc0: sunxi-ir as /devices/platform/soc/1c21800.ir/rc/rc0 Mar 01 13:37:09 volumiodk kernel: rc rc0: lirc_dev: driver sunxi-ir registered at minor = 0, raw IR receiver, no transmitter Mar 01 13:37:09 volumiodk kernel: input: sunxi-ir as /devices/platform/soc/1c21800.ir/rc/rc0/input1 Mar 01 13:37:09 volumiodk kernel: sunxi-ir 1c21800.ir: initialized sunXi IR driver Mar 01 13:37:09 volumiodk kernel: random: systemd: uninitialized urandom read (16 bytes read) Mar 01 13:37:09 volumiodk systemd-udevd[451]: Using default interface naming scheme 'v240'. Mar 01 13:37:10 volumiodk systemd-udevd[451]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 01 13:37:10 volumiodk systemd-udevd[451]: link_config: could not get ethtool features for eth0 Mar 01 13:37:10 volumiodk systemd-udevd[451]: Could not set offload features of eth0: Device or resource busy Mar 01 13:37:10 volumiodk kernel: axp20x-adc axp20x-adc: DMA mask not set Mar 01 13:37:10 volumiodk kernel: usb_phy_generic usb_phy_generic.0.auto: supply vcc not found, using dummy regulator Mar 01 13:37:10 volumiodk kernel: usb_phy_generic usb_phy_generic.0.auto: dummy supplies not allowed for exclusive requests Mar 01 13:37:10 volumiodk kernel: musb-hdrc musb-hdrc.1.auto: MUSB HDRC host driver Mar 01 13:37:10 volumiodk kernel: musb-hdrc musb-hdrc.1.auto: new USB bus registered, assigned bus number 1 Mar 01 13:37:10 volumiodk kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Mar 01 13:37:10 volumiodk kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 01 13:37:10 volumiodk kernel: usb usb1: Product: MUSB HDRC host driver Mar 01 13:37:10 volumiodk kernel: usb usb1: Manufacturer: Linux 5.15.93-sunxi musb-hcd Mar 01 13:37:10 volumiodk kernel: usb usb1: SerialNumber: musb-hdrc.1.auto Mar 01 13:37:10 volumiodk kernel: hub 1-0:1.0: USB hub found Mar 01 13:37:10 volumiodk kernel: hub 1-0:1.0: 1 port detected Mar 01 13:37:10 volumiodk kernel: ehci-platform 1c14000.usb: EHCI Host Controller Mar 01 13:37:10 volumiodk kernel: ehci-platform 1c14000.usb: new USB bus registered, assigned bus number 2 Mar 01 13:37:10 volumiodk kernel: ehci-platform 1c14000.usb: irq 41, io mem 0x01c14000 Mar 01 13:37:10 volumiodk kernel: ehci-platform 1c14000.usb: USB 2.0 started, EHCI 1.00 Mar 01 13:37:10 volumiodk kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Mar 01 13:37:10 volumiodk kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 01 13:37:10 volumiodk kernel: usb usb2: Product: EHCI Host Controller Mar 01 13:37:10 volumiodk kernel: usb usb2: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Mar 01 13:37:10 volumiodk kernel: usb usb2: SerialNumber: 1c14000.usb Mar 01 13:37:10 volumiodk kernel: hub 2-0:1.0: USB hub found Mar 01 13:37:10 volumiodk kernel: hub 2-0:1.0: 1 port detected Mar 01 13:37:10 volumiodk kernel: ehci-platform 1c1c000.usb: EHCI Host Controller Mar 01 13:37:10 volumiodk kernel: ehci-platform 1c1c000.usb: new USB bus registered, assigned bus number 3 Mar 01 13:37:10 volumiodk kernel: ehci-platform 1c1c000.usb: irq 46, io mem 0x01c1c000 Mar 01 13:37:10 volumiodk kernel: ehci-platform 1c1c000.usb: USB 2.0 started, EHCI 1.00 Mar 01 13:37:10 volumiodk kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Mar 01 13:37:10 volumiodk kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 01 13:37:10 volumiodk kernel: usb usb3: Product: EHCI Host Controller Mar 01 13:37:10 volumiodk kernel: usb usb3: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Mar 01 13:37:10 volumiodk kernel: usb usb3: SerialNumber: 1c1c000.usb Mar 01 13:37:10 volumiodk kernel: hub 3-0:1.0: USB hub found Mar 01 13:37:10 volumiodk kernel: hub 3-0:1.0: 1 port detected Mar 01 13:37:10 volumiodk kernel: ohci-platform 1c14400.usb: Generic Platform OHCI controller Mar 01 13:37:10 volumiodk kernel: ohci-platform 1c14400.usb: new USB bus registered, assigned bus number 4 Mar 01 13:37:10 volumiodk kernel: ohci-platform 1c14400.usb: irq 42, io mem 0x01c14400 Mar 01 13:37:10 volumiodk kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Mar 01 13:37:10 volumiodk kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 01 13:37:10 volumiodk kernel: usb usb4: Product: Generic Platform OHCI controller Mar 01 13:37:10 volumiodk kernel: usb usb4: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Mar 01 13:37:10 volumiodk kernel: usb usb4: SerialNumber: 1c14400.usb Mar 01 13:37:10 volumiodk kernel: hub 4-0:1.0: USB hub found Mar 01 13:37:10 volumiodk kernel: hub 4-0:1.0: 1 port detected Mar 01 13:37:10 volumiodk kernel: ohci-platform 1c1c400.usb: Generic Platform OHCI controller Mar 01 13:37:10 volumiodk kernel: ohci-platform 1c1c400.usb: new USB bus registered, assigned bus number 5 Mar 01 13:37:10 volumiodk kernel: ohci-platform 1c1c400.usb: irq 47, io mem 0x01c1c400 Mar 01 13:37:10 volumiodk kernel: usb usb5: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Mar 01 13:37:10 volumiodk kernel: usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 01 13:37:10 volumiodk kernel: usb usb5: Product: Generic Platform OHCI controller Mar 01 13:37:10 volumiodk kernel: usb usb5: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Mar 01 13:37:10 volumiodk kernel: usb usb5: SerialNumber: 1c1c400.usb Mar 01 13:37:11 volumiodk kernel: usb 2-1: new high-speed USB device number 2 using ehci-platform Mar 01 13:37:11 volumiodk kernel: hub 5-0:1.0: USB hub found Mar 01 13:37:11 volumiodk kernel: hub 5-0:1.0: 1 port detected Mar 01 13:37:11 volumiodk kernel: usb 3-1: new high-speed USB device number 2 using ehci-platform Mar 01 13:37:11 volumiodk kernel: usb 2-1: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 1.07 Mar 01 13:37:11 volumiodk kernel: usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Mar 01 13:37:11 volumiodk kernel: usb 2-1: Product: E50 Mar 01 13:37:11 volumiodk kernel: usb 2-1: Manufacturer: Topping Mar 01 13:37:11 volumiodk kernel: usb 3-1: New USB device found, idVendor=05e3, idProduct=0751, bcdDevice=14.04 Mar 01 13:37:11 volumiodk kernel: usb 3-1: New USB device strings: Mfr=3, Product=4, SerialNumber=0 Mar 01 13:37:11 volumiodk kernel: usb 3-1: Product: USB Storage Mar 01 13:37:11 volumiodk kernel: usb 3-1: Manufacturer: USB Storage Mar 01 13:37:11 volumiodk kernel: usb-storage 3-1:1.0: USB Mass Storage device detected Mar 01 13:37:11 volumiodk kernel: hid-generic 0003:152A:8750.0001: hiddev0,hidraw0: USB HID v1.10 Device [Topping E50] on usb-1c14000.usb-1/input3 Mar 01 13:37:11 volumiodk kernel: scsi host0: usb-storage 3-1:1.0 Mar 01 13:37:11 volumiodk systemd-udevd[459]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 01 13:37:11 volumiodk kernel: scsi 0:0:0:0: Direct-Access Generic STORAGE DEVICE 1404 PQ: 0 ANSI: 6 Mar 01 13:37:11 volumiodk kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Mar 01 13:37:11 volumiodk kernel: sd 0:0:0:0: [sda] 61071360 512-byte logical blocks: (31.3 GB/29.1 GiB) Mar 01 13:37:11 volumiodk kernel: sd 0:0:0:0: [sda] Write Protect is off Mar 01 13:37:11 volumiodk kernel: sd 0:0:0:0: [sda] Mode Sense: 21 00 00 00 Mar 01 13:37:11 volumiodk kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Mar 01 13:37:11 volumiodk kernel: sda: sda1 Mar 01 13:37:11 volumiodk kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Mar 01 13:37:12 volumiodk systemd[1]: Found device /dev/ttyS0. Mar 01 13:37:12 volumiodk kernel: usbcore: registered new interface driver uas Mar 01 13:37:12 volumiodk systemd-udevd[458]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 01 13:37:12 volumiodk systemd[1]: Found device /dev/mmcblk0p1. Mar 01 13:37:12 volumiodk systemd-udevd[456]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 01 13:37:13 volumiodk kernel: usb 2-1: 1:3 : unsupported format bits 0x100000000 Mar 01 13:37:13 volumiodk kernel: usbcore: registered new interface driver snd-usb-audio Mar 01 13:37:14 volumiodk systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Mar 01 13:37:14 volumiodk systemd-udevd[454]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Mar 01 13:37:14 volumiodk systemd[1]: Starting File System Check on /dev/mmcblk0p1... Mar 01 13:37:14 volumiodk systemd[1]: Condition check resulted in Huge Pages File System being skipped. Mar 01 13:37:14 volumiodk systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Mar 01 13:37:14 volumiodk systemd[1]: Starting Show Plymouth Boot Screen... Mar 01 13:37:14 volumiodk systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Mar 01 13:37:14 volumiodk systemd[1]: plymouth-start.service: Succeeded. Mar 01 13:37:14 volumiodk systemd[1]: Started Show Plymouth Boot Screen. Mar 01 13:37:14 volumiodk systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 01 13:37:14 volumiodk systemd[1]: Started File System Check Daemon to report status. Mar 01 13:37:14 volumiodk systemd-fsck[666]: fsck.fat 4.1 (2017-01-24) Mar 01 13:37:14 volumiodk systemd-fsck[666]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Mar 01 13:37:14 volumiodk systemd-fsck[666]: Automatically removing dirty bit. Mar 01 13:37:14 volumiodk systemd-fsck[666]: Performing changes. Mar 01 13:37:14 volumiodk systemd-fsck[666]: /dev/mmcblk0p1: 253 files, 16508/62333 clusters Mar 01 13:37:14 volumiodk systemd[1]: Started File System Check on /dev/mmcblk0p1. Mar 01 13:37:14 volumiodk systemd[1]: Mounting /boot... Mar 01 13:37:14 volumiodk systemd[1]: Mounted /boot. Mar 01 13:37:14 volumiodk systemd[1]: Reached target Local File Systems. Mar 01 13:37:14 volumiodk systemd[1]: Started ifup for eth0. Mar 01 13:37:14 volumiodk systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Mar 01 13:37:14 volumiodk systemd[1]: Starting Raise network interfaces... Mar 01 13:37:14 volumiodk systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Mar 01 13:37:14 volumiodk systemd[1]: Starting Preprocess NFS configuration... Mar 01 13:37:14 volumiodk systemd[1]: Starting Create Volatile Files and Directories... Mar 01 13:37:14 volumiodk systemd[1]: plymouth-read-write.service: Succeeded. Mar 01 13:37:14 volumiodk systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Mar 01 13:37:14 volumiodk systemd[1]: Received SIGRTMIN+20 from PID 322 (plymouthd). Mar 01 13:37:14 volumiodk systemd[1]: nfs-config.service: Succeeded. Mar 01 13:37:14 volumiodk systemd[1]: Started Preprocess NFS configuration. Mar 01 13:37:14 volumiodk systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Mar 01 13:37:14 volumiodk systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Mar 01 13:37:14 volumiodk systemd[1]: Reached target NFS client services. Mar 01 13:37:14 volumiodk systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Mar 01 13:37:14 volumiodk systemd[1]: Started Create Volatile Files and Directories. Mar 01 13:37:15 volumiodk systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Mar 01 13:37:15 volumiodk systemd[1]: Starting Update UTMP about System Boot/Shutdown... Mar 01 13:37:15 volumiodk systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Mar 01 13:37:15 volumiodk kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Mar 01 13:37:15 volumiodk kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Mar 01 13:37:15 volumiodk systemd[1]: Starting RPC bind portmap service... Mar 01 13:37:15 volumiodk kernel: platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 Mar 01 13:37:15 volumiodk kernel: platform regulatory.0: Falling back to sysfs fallback for: regulatory.db Mar 01 13:37:15 volumiodk kernel: cfg80211: failed to load regulatory.db Mar 01 13:37:15 volumiodk ifup[675]: command failed: No such device (-19) Mar 01 13:37:15 volumiodk systemd[1]: Started Update UTMP about System Boot/Shutdown. Mar 01 13:37:15 volumiodk systemd[1]: Started RPC bind portmap service. Mar 01 13:37:15 volumiodk systemd[1]: Reached target Remote File Systems (Pre). Mar 01 13:37:15 volumiodk systemd[1]: Reached target Remote File Systems. Mar 01 13:37:15 volumiodk systemd[1]: Reached target RPC Port Mapper. Mar 01 13:37:15 volumiodk systemd[1]: Reached target System Initialization. Mar 01 13:37:15 volumiodk systemd[1]: Listening on triggerhappy.socket. Mar 01 13:37:15 volumiodk systemd[1]: Listening on D-Bus System Message Bus Socket. Mar 01 13:37:15 volumiodk systemd[1]: Started Daily man-db regeneration. Mar 01 13:37:15 volumiodk systemd[1]: Started Daily apt download activities. Mar 01 13:37:15 volumiodk systemd[1]: Started Daily apt upgrade and clean activities. Mar 01 13:37:15 volumiodk systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Mar 01 13:37:15 volumiodk systemd[1]: Reached target Sockets. Mar 01 13:37:15 volumiodk sh[674]: command failed: No such device (-19) Mar 01 13:37:15 volumiodk systemd[1]: Reached target Basic System. Mar 01 13:37:15 volumiodk systemd[1]: Started Manage Sound Card State (restore and store). Mar 01 13:37:15 volumiodk systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Mar 01 13:37:15 volumiodk alsactl[713]: alsactl 1.1.8 daemon started Mar 01 13:37:15 volumiodk systemd[1]: Started volumio-remote-updater.service. Mar 01 13:37:15 volumiodk systemd[1]: Starting Wireless Services... Mar 01 13:37:15 volumiodk systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Mar 01 13:37:15 volumiodk systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Mar 01 13:37:15 volumiodk systemd[1]: Starting Login Service... Mar 01 13:37:15 volumiodk systemd[1]: Starting triggerhappy global hotkey daemon... Mar 01 13:37:15 volumiodk systemd[1]: Started Volumio Iptables Module. Mar 01 13:37:15 volumiodk systemd[1]: Started UPnP Renderer front-end to MPD. Mar 01 13:37:15 volumiodk systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Mar 01 13:37:16 volumiodk thd[727]: Unable to parse trigger line: Mar 01 13:37:16 volumiodk thd[727]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Mar 01 13:37:16 volumiodk thd[727]: Unable to parse trigger line: Mar 01 13:37:16 volumiodk systemd[1]: Started D-Bus System Message Bus. Mar 01 13:37:16 volumiodk thd[727]: Unable to parse trigger line: Mar 01 13:37:16 volumiodk thd[727]: Unable to parse trigger line: Mar 01 13:37:16 volumiodk thd[727]: Found socket passed from systemd Mar 01 13:37:16 volumiodk systemd[1]: Starting WPA supplicant... Mar 01 13:37:16 volumiodk systemd[1]: Started Volumio Log Rotation Service. Mar 01 13:37:16 volumiodk ifup[675]: command failed: No such device (-19) Mar 01 13:37:16 volumiodk systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Mar 01 13:37:16 volumiodk systemd[1]: Starting DHCP Client Daemon... Mar 01 13:37:16 volumiodk systemd[1]: Starting Save/Restore Sound Card State... Mar 01 13:37:16 volumiodk systemd[1]: Started Daily Cleanup of Temporary Directories. Mar 01 13:37:16 volumiodk systemd[1]: Reached target Timers. Mar 01 13:37:16 volumiodk systemd-logind[723]: New seat seat0. Mar 01 13:37:16 volumiodk systemd[1]: Started triggerhappy global hotkey daemon. Mar 01 13:37:16 volumiodk systemd-logind[723]: Watching system buttons on /dev/input/event0 (axp20x-pek) Mar 01 13:37:17 volumiodk volumio-remote-updater[717]: Error: No active session Mar 01 13:37:17 volumiodk volumio-remote-updater[717]: [2025-03-01 13:37:17] [info] asio async_connect error: system:111 (Connection refused) Mar 01 13:37:17 volumiodk volumio-remote-updater[717]: [2025-03-01 13:37:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 01 13:37:17 volumiodk volumio-remote-updater[717]: [2025-03-01 13:37:17] [error] handle_connect error: Underlying Transport Error Mar 01 13:37:17 volumiodk avahi-daemon[750]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Mar 01 13:37:17 volumiodk avahi-daemon[750]: Successfully dropped root privileges. Mar 01 13:37:17 volumiodk avahi-daemon[750]: avahi-daemon 0.7 starting up. Mar 01 13:37:17 volumiodk kernel: phy_rtl8211e_led_fixup in Mar 01 13:37:17 volumiodk kernel: sun7i-dwmac 1c50000.ethernet eth0: PHY [stmmac-0:01] driver [RTL8211E Gigabit Ethernet] (irq=POLL) Mar 01 13:37:17 volumiodk dhcpcd[753]: cat: /run/dhcpcd/resolv.conf.eth0.link: No such file or directory Mar 01 13:37:17 volumiodk kernel: sun7i-dwmac 1c50000.ethernet eth0: Register MEM_TYPE_PAGE_POOL RxQ-0 Mar 01 13:37:17 volumiodk kernel: sun7i-dwmac 1c50000.ethernet eth0: No Safety Features support found Mar 01 13:37:17 volumiodk kernel: sun7i-dwmac 1c50000.ethernet eth0: RX IPC Checksum Offload disabled Mar 01 13:37:17 volumiodk kernel: sun7i-dwmac 1c50000.ethernet eth0: No MAC Management Counters available Mar 01 13:37:17 volumiodk kernel: sun7i-dwmac 1c50000.ethernet eth0: PTP not supported by HW Mar 01 13:37:17 volumiodk kernel: sun7i-dwmac 1c50000.ethernet eth0: configuring for phy/rgmii-id link mode Mar 01 13:37:17 volumiodk dhcpcd[728]: eth0: waiting for carrier Mar 01 13:37:17 volumiodk sh[674]: eth0: waiting for carrier Mar 01 13:37:17 volumiodk sh[674]: eth0: carrier acquired Mar 01 13:37:17 volumiodk sh[674]: DUID 00:01:00:01:2c:c6:6f:6b:02:51:01:c2:08:59 Mar 01 13:37:17 volumiodk sh[674]: eth0: IAID 01:c2:08:59 Mar 01 13:37:17 volumiodk sh[674]: eth0: adding address fe80::a875:7cd1:f0b1:4099 Mar 01 13:37:17 volumiodk sh[674]: ipv6_addaddr1: Permission denied Mar 01 13:37:17 volumiodk sh[674]: eth0: carrier lost Mar 01 13:37:17 volumiodk dhcpcd[728]: eth0: carrier acquired Mar 01 13:37:17 volumiodk dhcpcd[728]: DUID 00:01:00:01:2c:c6:6f:6b:02:51:01:c2:08:59 Mar 01 13:37:17 volumiodk dhcpcd[728]: eth0: IAID 01:c2:08:59 Mar 01 13:37:17 volumiodk dhcpcd[753]: no interfaces have a carrier Mar 01 13:37:17 volumiodk dhcpcd[728]: eth0: adding address fe80::a875:7cd1:f0b1:4099 Mar 01 13:37:17 volumiodk dhcpcd[728]: ipv6_addaddr1: Permission denied Mar 01 13:37:17 volumiodk dhcpcd[728]: eth0: carrier lost Mar 01 13:37:17 volumiodk dhcpcd[753]: no interfaces have a carrier Mar 01 13:37:17 volumiodk dhcpcd[753]: forked to background, child pid 809 Mar 01 13:37:17 volumiodk dhcpcd[753]: forked to background, child pid 809 Mar 01 13:37:17 volumiodk dhcpcd[809]: eth0: waiting for carrier Mar 01 13:37:17 volumiodk dhcpcd[809]: eth0: carrier acquired Mar 01 13:37:17 volumiodk dhcpcd[809]: DUID 00:01:00:01:2c:c6:6f:6b:02:51:01:c2:08:59 Mar 01 13:37:17 volumiodk dhcpcd[809]: eth0: IAID 01:c2:08:59 Mar 01 13:37:17 volumiodk dhcpcd[809]: eth0: adding address fe80::a875:7cd1:f0b1:4099 Mar 01 13:37:17 volumiodk dhcpcd[809]: ipv6_addaddr1: Permission denied Mar 01 13:37:17 volumiodk dhcpcd[809]: eth0: carrier lost Mar 01 13:37:17 volumiodk systemd[1]: Started Login Service. Mar 01 13:37:17 volumiodk systemd[1]: Started DHCP Client Daemon. Mar 01 13:37:17 volumiodk systemd[1]: Started Save/Restore Sound Card State. Mar 01 13:37:17 volumiodk avahi-daemon[750]: Successfully called chroot(). Mar 01 13:37:17 volumiodk avahi-daemon[750]: Successfully dropped remaining capabilities. Mar 01 13:37:17 volumiodk avahi-daemon[750]: Loading service file /services/volumio.service. Mar 01 13:37:17 volumiodk avahi-daemon[750]: Network interface enumeration completed. Mar 01 13:37:17 volumiodk avahi-daemon[750]: Server startup complete. Host name is volumiodk.local. Local service cookie is 3090430068. Mar 01 13:37:17 volumiodk avahi-daemon[750]: Service "VolumioDK" (/services/volumio.service) successfully established. Mar 01 13:37:18 volumiodk systemd[1]: Started Avahi mDNS/DNS-SD Stack. Mar 01 13:37:18 volumiodk wpa_supplicant[746]: Successfully initialized wpa_supplicant Mar 01 13:37:18 volumiodk systemd[1]: Started WPA supplicant. Mar 01 13:37:18 volumiodk systemd[1]: Reached target Sound Card. Mar 01 13:37:18 volumiodk volumio[735]: Could not open config: /tmp/upmpdcli.conf Mar 01 13:37:18 volumiodk systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 01 13:37:18 volumiodk systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 01 13:37:18 volumiodk systemd[1]: Started Raise network interfaces. Mar 01 13:37:18 volumiodk systemd[1]: Reached target Network. Mar 01 13:37:18 volumiodk systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Mar 01 13:37:18 volumiodk loadcpufreq[716]: Loading cpufreq kernel modules...done (none). Mar 01 13:37:18 volumiodk systemd[1]: Starting Permit User Sessions... Mar 01 13:37:18 volumiodk systemd[1]: Starting Network Time Service... Mar 01 13:37:18 volumiodk systemd[1]: Reached target Network is Online. Mar 01 13:37:18 volumiodk systemd[1]: Starting Samba NMB Daemon... Mar 01 13:37:18 volumiodk systemd[1]: Starting /etc/rc.local Compatibility... Mar 01 13:37:19 volumiodk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 01 13:37:19 volumiodk systemd[1]: Starting LSB: Brings up/down network automatically... Mar 01 13:37:19 volumiodk systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Mar 01 13:37:19 volumiodk systemd[1]: Started Permit User Sessions. Mar 01 13:37:19 volumiodk ntpd[882]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 01 13:37:19 volumiodk ntpd[882]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 01 13:37:19 volumiodk systemd[1]: Started Network Time Service. Mar 01 13:37:19 volumiodk systemd[1]: Started /etc/rc.local Compatibility. Mar 01 13:37:19 volumiodk systemd[1]: iptables.service: Succeeded. Mar 01 13:37:19 volumiodk ntpd[899]: proto: precision = 1.083 usec (-20) Mar 01 13:37:19 volumiodk ntpd[899]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 01 13:37:19 volumiodk ntpd[899]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 01 13:37:19 volumiodk ntpd[899]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 795 days ago Mar 01 13:37:19 volumiodk ntpd[899]: Listen and drop on 0 v6wildcard [::]:123 Mar 01 13:37:19 volumiodk ntpd[899]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 01 13:37:19 volumiodk ntpd[899]: Listen normally on 2 lo 127.0.0.1:123 Mar 01 13:37:19 volumiodk ntpd[899]: Listening on routing socket on fd #19 for interface updates Mar 01 13:37:19 volumiodk ntpd[899]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 01 13:37:19 volumiodk ntpd[899]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 01 13:37:19 volumiodk systemd[1]: Starting Hold until boot process finishes up... Mar 01 13:37:19 volumiodk systemd[1]: Starting Terminate Plymouth Boot Screen... Mar 01 13:37:19 volumiodk systemd[1]: Starting LSB: set CPUFreq kernel parameters... Mar 01 13:37:19 volumiodk systemd[1]: Received SIGRTMIN+21 from PID 322 (plymouthd). Mar 01 13:37:19 volumiodk systemd[1]: Received SIGRTMIN+21 from PID 322 (plymouthd). Mar 01 13:37:19 volumiodk systemd[1]: plymouth-quit-wait.service: Succeeded. Mar 01 13:37:19 volumiodk systemd[1]: Started Hold until boot process finishes up. Mar 01 13:37:19 volumiodk systemd[1]: plymouth-quit.service: Succeeded. Mar 01 13:37:19 volumiodk systemd[1]: Started Terminate Plymouth Boot Screen. Mar 01 13:37:20 volumiodk systemd[1]: Started Serial Getty on ttyS0. Mar 01 13:37:20 volumiodk systemd[1]: Reached target Login Prompts. Mar 01 13:37:20 volumiodk ifplugd(eth0)[918]: ifplugd 0.28 initializing. Mar 01 13:37:20 volumiodk ifplugd(eth0)[918]: Using interface eth0/02:51:01:C2:08:59 with driver (version: Jan_2016) Mar 01 13:37:20 volumiodk ifplugd(eth0)[918]: Using detection mode: SIOCETHTOOL Mar 01 13:37:20 volumiodk ifplugd(eth0)[918]: Initialization complete, link beat not detected. Mar 01 13:37:20 volumiodk ifplugd[892]: Network Interface Plugging Daemon...start eth0...done. Mar 01 13:37:20 volumiodk systemd[1]: Started LSB: Brings up/down network automatically. Mar 01 13:37:20 volumiodk haveged[697]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K Mar 01 13:37:20 volumiodk haveged[697]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848 Mar 01 13:37:20 volumiodk haveged[697]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99973 Mar 01 13:37:20 volumiodk haveged[697]: haveged: fills: 0, generated: 0 Mar 01 13:37:20 volumiodk cpufrequtils[907]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...done. Mar 01 13:37:20 volumiodk systemd[1]: Started LSB: set CPUFreq kernel parameters. Mar 01 13:37:20 volumiodk dhcpcd[809]: eth0: carrier acquired Mar 01 13:37:20 volumiodk kernel: sun7i-dwmac 1c50000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Mar 01 13:37:20 volumiodk dhcpcd[728]: eth0: carrier acquired Mar 01 13:37:20 volumiodk sh[674]: eth0: carrier acquired Mar 01 13:37:20 volumiodk dhcpcd[809]: eth0: IAID 01:c2:08:59 Mar 01 13:37:20 volumiodk sh[674]: eth0: IAID 01:c2:08:59 Mar 01 13:37:20 volumiodk dhcpcd[728]: eth0: IAID 01:c2:08:59 Mar 01 13:37:20 volumiodk ntpd[899]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 01 13:37:20 volumiodk dhcpcd[809]: eth0: soliciting an IPv6 router Mar 01 13:37:20 volumiodk dhcpcd[809]: eth0: soliciting a DHCP lease Mar 01 13:37:20 volumiodk sh[674]: eth0: soliciting a DHCP lease Mar 01 13:37:20 volumiodk dhcpcd[728]: eth0: soliciting a DHCP lease Mar 01 13:37:21 volumiodk kernel: random: crng init done Mar 01 13:37:21 volumiodk kernel: random: 244 urandom warning(s) missed due to ratelimiting Mar 01 13:37:21 volumiodk ifplugd(eth0)[918]: Link beat detected. Mar 01 13:37:21 volumiodk ifplugd(eth0)[918]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Mar 01 13:37:21 volumiodk sh[674]: eth0: soliciting an IPv6 router Mar 01 13:37:21 volumiodk dhcpcd[728]: eth0: soliciting an IPv6 router Mar 01 13:37:21 volumiodk ifplugd(eth0)[918]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Mar 01 13:37:21 volumiodk ntpd[899]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 01 13:37:21 volumiodk nmbd[897]: [2025/03/01 13:37:21.639752, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Mar 01 13:37:21 volumiodk nmbd[897]: started asyncdns process 939 Mar 01 13:37:21 volumiodk nmbd[897]: [2025/03/01 13:37:21.646100, 0] ../lib/util/become_daemon.c:149(daemon_status) Mar 01 13:37:21 volumiodk nmbd[897]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Mar 01 13:37:21 volumiodk nmbd[897]: [2025/03/01 13:37:21.646509, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Mar 01 13:37:21 volumiodk nmbd[897]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Mar 01 13:37:22 volumiodk volumio-remote-updater[717]: [2025-03-01 13:37:22] [info] asio async_connect error: system:111 (Connection refused) Mar 01 13:37:22 volumiodk volumio-remote-updater[717]: [2025-03-01 13:37:22] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 01 13:37:22 volumiodk volumio-remote-updater[717]: [2025-03-01 13:37:22] [error] handle_connect error: Underlying Transport Error Mar 01 13:37:22 volumiodk ntpd[899]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 01 13:37:22 volumiodk sh[674]: eth0: offered 192.168.1.29 from 192.168.1.1 Mar 01 13:37:22 volumiodk dhcpcd[728]: eth0: offered 192.168.1.29 from 192.168.1.1 Mar 01 13:37:22 volumiodk sh[674]: eth0: probing address 192.168.1.29/24 Mar 01 13:37:22 volumiodk dhcpcd[728]: eth0: probing address 192.168.1.29/24 Mar 01 13:37:23 volumiodk wireless.js[720]: WIRELESS: No wireless interface, exiting Mar 01 13:37:23 volumiodk iw[944]: command failed: No such device (-19) Mar 01 13:37:23 volumiodk iwconfig[947]: Error for wireless request "Set Power Management" (8B2C) : Mar 01 13:37:23 volumiodk iwconfig[947]: SET failed on device wlan0 ; No such device. Mar 01 13:37:23 volumiodk systemd[1]: wireless.service: Succeeded. Mar 01 13:37:23 volumiodk systemd[1]: Started Wireless Services. Mar 01 13:37:23 volumiodk systemd[1]: Started Volumio Backend Module. Mar 01 13:37:23 volumiodk systemd[1]: Started Volumio Cpu Tweaker. Mar 01 13:37:23 volumiodk ntpd[899]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 01 13:37:23 volumiodk volumio-cpu-tweak[951]: Setting RT Priority for mpd Mar 01 13:37:23 volumiodk volumio-cpu-tweak[951]: chrt: cannot obtain the list of tasks: No such file or directory Mar 01 13:37:23 volumiodk volumio-cpu-tweak[951]: Not enough cores to set MPD affinity Mar 01 13:37:23 volumiodk volumio-cpu-tweak[951]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 01 13:37:23 volumiodk volumio-cpu-tweak[951]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 01 13:37:23 volumiodk systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 01 13:37:25 volumiodk dhcpcd[809]: eth0: probing for an IPv4LL address Mar 01 13:37:25 volumiodk dhcpcd[809]: eth0: offered 192.168.1.29 from 192.168.1.1 Mar 01 13:37:25 volumiodk dhcpcd[809]: eth0: probing address 192.168.1.29/24 Mar 01 13:37:27 volumiodk sh[674]: eth0: leased 192.168.1.29 for 86400 seconds Mar 01 13:37:27 volumiodk sh[674]: eth0: adding route to 192.168.1.0/24 Mar 01 13:37:27 volumiodk dhcpcd[728]: eth0: leased 192.168.1.29 for 86400 seconds Mar 01 13:37:27 volumiodk dhcpcd[728]: eth0: adding route to 192.168.1.0/24 Mar 01 13:37:27 volumiodk sh[674]: eth0: adding default route via 192.168.1.1 Mar 01 13:37:27 volumiodk avahi-daemon[750]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.29. Mar 01 13:37:27 volumiodk avahi-daemon[750]: New relevant interface eth0.IPv4 for mDNS. Mar 01 13:37:27 volumiodk avahi-daemon[750]: Registering new address record for 192.168.1.29 on eth0.IPv4. Mar 01 13:37:27 volumiodk dhcpcd[728]: eth0: adding default route via 192.168.1.1 Mar 01 13:37:27 volumiodk ntpd[899]: ntpd exiting on signal 15 (Terminated) Mar 01 13:37:27 volumiodk systemd[1]: Stopping Network Time Service... Mar 01 13:37:27 volumiodk systemd[1]: ntp.service: Succeeded. Mar 01 13:37:27 volumiodk systemd[1]: Stopped Network Time Service. Mar 01 13:37:27 volumiodk systemd[1]: Starting Network Time Service... Mar 01 13:37:28 volumiodk ntpd[999]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 01 13:37:28 volumiodk ntpd[999]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 01 13:37:28 volumiodk systemd[1]: Started Network Time Service. Mar 01 13:37:28 volumiodk sh[674]: forked to background, child pid 1006 Mar 01 13:37:28 volumiodk dhcpcd[728]: forked to background, child pid 1006 Mar 01 13:37:28 volumiodk ntpd[1005]: proto: precision = 1.041 usec (-20) Mar 01 13:37:28 volumiodk ntpd[1005]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 01 13:37:28 volumiodk ntpd[1005]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 01 13:37:28 volumiodk ntpd[1005]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 795 days ago Mar 01 13:37:28 volumiodk ntpd[1005]: Listen and drop on 0 v6wildcard [::]:123 Mar 01 13:37:28 volumiodk ntpd[1005]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 01 13:37:28 volumiodk ntpd[1005]: Listen normally on 2 lo 127.0.0.1:123 Mar 01 13:37:28 volumiodk ntpd[1005]: Listen normally on 3 eth0 192.168.1.29:123 Mar 01 13:37:28 volumiodk ntpd[1005]: Listening on routing socket on fd #20 for interface updates Mar 01 13:37:28 volumiodk ntpd[1005]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 01 13:37:28 volumiodk ntpd[1005]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 01 13:37:28 volumiodk ifplugd(eth0)[918]: client: ifup: interface eth0 already configured Mar 01 13:37:28 volumiodk sh[674]: eth0=eth0 Mar 01 13:37:28 volumiodk ifplugd(eth0)[918]: Program executed successfully. Mar 01 13:37:29 volumiodk ntpd[1005]: Soliciting pool server 217.196.104.131 Mar 01 13:37:29 volumiodk kernel: vcc3v0: disabling Mar 01 13:37:29 volumiodk kernel: vcc5v0: disabling Mar 01 13:37:29 volumiodk volumio-remote-updater[717]: [2025-03-01 13:37:29] [connect] Successful connection Mar 01 13:37:30 volumiodk ntpd[1005]: Soliciting pool server 217.24.20.5 Mar 01 13:37:30 volumiodk ntpd[1005]: Soliciting pool server 195.250.114.105 Mar 01 13:37:30 volumiodk volumio[950]: info: ------------------------------------------- Mar 01 13:37:30 volumiodk volumio[950]: info: ----- Volumio3 ---- Mar 01 13:37:30 volumiodk volumio[950]: info: ------------------------------------------- Mar 01 13:37:30 volumiodk volumio[950]: info: ----- System startup ---- Mar 01 13:37:30 volumiodk volumio[950]: info: ------------------------------------------- Mar 01 13:37:30 volumiodk dhcpcd[809]: eth0: using IPv4LL address 169.254.227.224 Mar 01 13:37:30 volumiodk dhcpcd[809]: eth0: adding route to 169.254.0.0/16 Mar 01 13:37:30 volumiodk dhcpcd[809]: eth0: adding default route Mar 01 13:37:30 volumiodk dhcpcd[1006]: eth0: deleted default route via 192.168.1.1 Mar 01 13:37:30 volumiodk avahi-daemon[750]: Registering new address record for 169.254.227.224 on eth0.IPv4. Mar 01 13:37:31 volumiodk ntpd[1005]: Soliciting pool server 147.91.8.1 Mar 01 13:37:31 volumiodk ntpd[1005]: Soliciting pool server 147.91.8.1 Mar 01 13:37:31 volumiodk ntpd[1005]: Soliciting pool server 147.91.26.20 Mar 01 13:37:31 volumiodk dhcpcd[809]: eth0: leased 192.168.1.29 for 86400 seconds Mar 01 13:37:31 volumiodk dhcpcd[809]: eth0: adding route to 192.168.1.0/24 Mar 01 13:37:31 volumiodk dhcpcd[809]: eth0: changing default route via 192.168.1.1 Mar 01 13:37:31 volumiodk nmbd[897]: [2025/03/01 13:37:31.661043, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 01 13:37:31 volumiodk nmbd[897]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 01 13:37:31 volumiodk systemd[1]: Started Samba NMB Daemon. Mar 01 13:37:31 volumiodk systemd[1]: Starting Samba Winbind Daemon... Mar 01 13:37:31 volumiodk ntpd[1005]: ntpd exiting on signal 15 (Terminated) Mar 01 13:37:31 volumiodk ntpd[1005]: 217.196.104.131 local addr 192.168.1.29 -> Mar 01 13:37:31 volumiodk systemd[1]: Stopping Network Time Service... Mar 01 13:37:31 volumiodk ntpd[1005]: 217.24.20.5 local addr 192.168.1.29 -> Mar 01 13:37:31 volumiodk ntpd[1005]: 195.250.114.105 local addr 192.168.1.29 -> Mar 01 13:37:31 volumiodk systemd[1]: ntp.service: Succeeded. Mar 01 13:37:31 volumiodk systemd[1]: Stopped Network Time Service. Mar 01 13:37:32 volumiodk systemd[1]: Starting Network Time Service... Mar 01 13:37:32 volumiodk ntpd[1091]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 01 13:37:32 volumiodk ntpd[1091]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 01 13:37:32 volumiodk systemd[1]: Started Network Time Service. Mar 01 13:37:32 volumiodk dhcpcd[809]: eth0: deleting route to 169.254.0.0/16 Mar 01 13:37:32 volumiodk avahi-daemon[750]: Withdrawing address record for 169.254.227.224 on eth0. Mar 01 13:37:32 volumiodk ntpd[1097]: proto: precision = 1.041 usec (-20) Mar 01 13:37:32 volumiodk ntpd[1097]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 01 13:37:32 volumiodk ntpd[1097]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 01 13:37:32 volumiodk ntpd[1097]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 795 days ago Mar 01 13:37:32 volumiodk ntpd[1097]: Listen and drop on 0 v6wildcard [::]:123 Mar 01 13:37:32 volumiodk ntpd[1097]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 01 13:37:32 volumiodk ntpd[1097]: Listen normally on 2 lo 127.0.0.1:123 Mar 01 13:37:32 volumiodk ntpd[1097]: Listen normally on 3 eth0 192.168.1.29:123 Mar 01 13:37:32 volumiodk ntpd[1097]: Listening on routing socket on fd #20 for interface updates Mar 01 13:37:32 volumiodk ntpd[1097]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 01 13:37:32 volumiodk ntpd[1097]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 01 13:37:32 volumiodk winbindd[1084]: [2025/03/01 13:37:32.867606, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 01 13:37:32 volumiodk winbindd[1084]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 01 13:37:32 volumiodk systemd[1]: Started Samba Winbind Daemon. Mar 01 13:37:32 volumiodk winbindd[1084]: [2025/03/01 13:37:32.903431, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 01 13:37:32 volumiodk winbindd[1084]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 01 13:37:32 volumiodk systemd[1]: Starting Samba SMB Daemon... Mar 01 13:37:33 volumiodk ntpd[1097]: Soliciting pool server 217.24.20.5 Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.740986, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:33 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.741670, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:33 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20340 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.741975, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:33 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.742229, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:33 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20341 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.742435, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:33 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.742637, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:33 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20342 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.742847, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:33 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.743178, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:33 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20343 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.743459, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:33 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.743722, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:33 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20344 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.745407, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:33 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.745808, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:33 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20340 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.746172, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:33 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.746444, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:33 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20341 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.746670, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:33 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.746890, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:33 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20342 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.755570, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:33 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.755922, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:33 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20343 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.756214, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:33 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:33 volumiodk nmbd[897]: [2025/03/01 13:37:33.756552, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:33 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20344 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:33 volumiodk volumio[950]: info: MYVOLUMIO Environment detected Mar 01 13:37:34 volumiodk ntpd[1097]: Soliciting pool server 217.196.104.131 Mar 01 13:37:34 volumiodk ntpd[1097]: Soliciting pool server 195.250.114.105 Mar 01 13:37:34 volumiodk volumio[950]: info: Plugin folders cleanup Mar 01 13:37:34 volumiodk volumio[950]: info: Scanning into folder /volumio/app/plugins/ Mar 01 13:37:34 volumiodk volumio[950]: info: Scanning category audio_interface Mar 01 13:37:34 volumiodk volumio[950]: info: Scanning category miscellanea Mar 01 13:37:34 volumiodk volumio[950]: info: Scanning category music_service Mar 01 13:37:34 volumiodk volumio[950]: info: Scanning category plugins.json Mar 01 13:37:34 volumiodk volumio[950]: info: Scanning category system_controller Mar 01 13:37:34 volumiodk volumio[950]: info: Scanning category user_interface Mar 01 13:37:34 volumiodk volumio[950]: info: Scanning into folder /data/plugins/ Mar 01 13:37:34 volumiodk volumio[950]: info: Scanning category system_controller Mar 01 13:37:34 volumiodk volumio[950]: info: Scanning category user_interface Mar 01 13:37:34 volumiodk volumio[950]: info: Plugin folders cleanup completed Mar 01 13:37:34 volumiodk volumio[950]: info: ------------------------------------------- Mar 01 13:37:34 volumiodk volumio[950]: info: ----- Core plugins startup ---- Mar 01 13:37:34 volumiodk volumio[950]: info: ------------------------------------------- Mar 01 13:37:34 volumiodk volumio[950]: info: Loading plugins from folder /volumio/app/plugins/ Mar 01 13:37:34 volumiodk volumio[950]: info: Adding plugin upnp to MyMusic Plugins Mar 01 13:37:34 volumiodk volumio[950]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 01 13:37:34 volumiodk volumio[950]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 01 13:37:34 volumiodk volumio[950]: info: Loading plugins from folder /data/plugins/ Mar 01 13:37:34 volumiodk volumio[950]: info: Loading plugin "system"... Mar 01 13:37:34 volumiodk volumio[950]: info: Loading plugin "appearance"... Mar 01 13:37:35 volumiodk systemd[1]: Started Samba SMB Daemon. Mar 01 13:37:35 volumiodk systemd[1]: Reached target Multi-User System. Mar 01 13:37:35 volumiodk systemd[1]: Reached target Graphical Interface. Mar 01 13:37:35 volumiodk smbd[1119]: [2025/03/01 13:37:35.078654, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 01 13:37:35 volumiodk smbd[1119]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 01 13:37:35 volumiodk systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 01 13:37:35 volumiodk ntpd[1097]: Soliciting pool server 147.91.8.1 Mar 01 13:37:35 volumiodk ntpd[1097]: Soliciting pool server 147.91.26.20 Mar 01 13:37:35 volumiodk ntpd[1097]: Soliciting pool server 195.178.58.245 Mar 01 13:37:35 volumiodk systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 01 13:37:35 volumiodk systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 01 13:37:35 volumiodk systemd[1]: Startup finished in 8.937s (kernel) + 30.587s (userspace) = 39.525s. Mar 01 13:37:35 volumiodk nmbd[897]: [2025/03/01 13:37:35.769080, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:35 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:35 volumiodk nmbd[897]: [2025/03/01 13:37:35.769572, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:35 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20340 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:35 volumiodk nmbd[897]: [2025/03/01 13:37:35.769820, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:35 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:35 volumiodk nmbd[897]: [2025/03/01 13:37:35.769996, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:35 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20341 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:35 volumiodk nmbd[897]: [2025/03/01 13:37:35.770169, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:35 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:35 volumiodk nmbd[897]: [2025/03/01 13:37:35.770321, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:35 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20342 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:35 volumiodk nmbd[897]: [2025/03/01 13:37:35.770472, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:35 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:35 volumiodk nmbd[897]: [2025/03/01 13:37:35.770621, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:35 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20343 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:35 volumiodk nmbd[897]: [2025/03/01 13:37:35.770770, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:35 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Mar 01 13:37:35 volumiodk nmbd[897]: [2025/03/01 13:37:35.770948, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Mar 01 13:37:35 volumiodk nmbd[897]: retransmit_or_expire_response_records: Failed to resend packet id 20344 to IP 169.254.255.255 on subnet 169.254.227.224 Mar 01 13:37:35 volumiodk nmbd[897]: [2025/03/01 13:37:35.772970, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 01 13:37:35 volumiodk nmbd[897]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Mar 01 13:37:36 volumiodk ntpd[1097]: Soliciting pool server 2001:ac8:7d:42:0:2:0:20 Mar 01 13:37:38 volumiodk volumio[950]: info: Loading plugin "network"... Mar 01 13:37:38 volumiodk volumio[950]: info: Refreshing Cached IP Addresses Mar 01 13:37:38 volumiodk volumio[950]: info: Loading plugin "services"... Mar 01 13:37:38 volumiodk volumio[950]: info: Loading plugin "alsa_controller"... Mar 01 13:37:38 volumiodk sudo[1138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 01 13:37:38 volumiodk sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 13:37:38 volumiodk sudo[1134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 01 13:37:38 volumiodk sudo[1138]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:38 volumiodk sudo[1134]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:38 volumiodk sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:39 volumiodk sudo[1134]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:39 volumiodk sudo[1136]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:39 volumiodk sudo[1138]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 13:37:39 volumiodk volumio[950]: info: Loading plugin "wizard"... Mar 01 13:37:39 volumiodk volumio[950]: info: Loading plugin "networkfs"... Mar 01 13:37:39 volumiodk volumio[950]: info: Starting Udev Watcher for removable devices Mar 01 13:37:39 volumiodk volumio[950]: info: Ignoring mount for partition: boot Mar 01 13:37:39 volumiodk volumio[950]: info: Ignoring mount for partition: volumio Mar 01 13:37:39 volumiodk volumio[950]: info: Ignoring mount for partition: volumio_data Mar 01 13:37:39 volumiodk volumio[950]: info: Mounting Device KARALIC Mar 01 13:37:39 volumiodk sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/KARALIC -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 01 13:37:39 volumiodk sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:39 volumiodk kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Mar 01 13:37:39 volumiodk kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Mar 01 13:37:39 volumiodk sudo[1152]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 01 13:37:39 volumiodk volumio[950]: info: Loading plugin "volumio_command_line_client"... Mar 01 13:37:39 volumiodk volumio[950]: info: Loading plugin "upnp"... Mar 01 13:37:39 volumiodk volumio[950]: info: [1740832659882] Starting Upmpd Daemon Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 01 13:37:39 volumiodk volumio[950]: info: Loading plugin "my_music"... Mar 01 13:37:39 volumiodk volumio[950]: info: Loading plugin "mpd"... Mar 01 13:37:41 volumiodk volumio[950]: info: Loading plugin "upnp_browser"... Mar 01 13:37:32 volumiodk ntpd[1097]: receive: Unexpected origin timestamp 0xeb6d7e15.2721d17a does not match aorg 0000000000.00000000 from server@195.250.114.105 xmt 0xeb6d7e0c.b306b3ae Mar 01 13:37:32 volumiodk ntpd[1097]: receive: Unexpected origin timestamp 0xeb6d7e15.271a530b does not match aorg 0000000000.00000000 from server@147.91.26.20 xmt 0xeb6d7e0c.b6b5cded Mar 01 13:37:32 volumiodk ntpd[1097]: receive: Unexpected origin timestamp 0xeb6d7e15.27093777 does not match aorg 0000000000.00000000 from server@147.91.8.1 xmt 0xeb6d7e0c.b79d7bae Mar 01 13:37:33 volumiodk volumio[950]: info: Loading plugin "alarm-clock"... Mar 01 13:37:34 volumiodk volumio[950]: info: Loading plugin "airplay_emulation"... Mar 01 13:37:34 volumiodk volumio[950]: info: Starting Shairport Sync Mar 01 13:37:34 volumiodk volumio[950]: info: Loading plugin "last_100"... Mar 01 13:37:34 volumiodk volumio[950]: info: Loading plugin "webradio"... Mar 01 13:37:34 volumiodk volumio[950]: info: Loading plugin "i2s_dacs"... Mar 01 13:37:34 volumiodk volumio[950]: info: I2S DAC not set, start Auto-detection Mar 01 13:37:34 volumiodk volumio[950]: info: Loading plugin "volumiodiscovery"... Mar 01 13:37:35 volumiodk volumio[950]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 01 13:37:35 volumiodk volumio[950]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 13:37:35 volumiodk node[950]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 01 13:37:35 volumiodk volumio[950]: *** WARNING *** For more information see Mar 01 13:37:35 volumiodk volumio[950]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 01 13:37:35 volumiodk volumio[950]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 13:37:35 volumiodk volumio[950]: *** WARNING *** For more information see Mar 01 13:37:35 volumiodk node[950]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 13:37:35 volumiodk node[950]: *** WARNING *** For more information see Mar 01 13:37:35 volumiodk node[950]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 01 13:37:35 volumiodk node[950]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 13:37:35 volumiodk node[950]: *** WARNING *** For more information see Mar 01 13:37:35 volumiodk volumio[950]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 01 13:37:35 volumiodk volumio[950]: info: Discovery: Started advertising with name: VolumioDK Mar 01 13:37:35 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 01 13:37:35 volumiodk volumio[950]: info: Loading plugin "outputs"... Mar 01 13:37:35 volumiodk volumio[950]: info: Loading plugin "albumart"... Mar 01 13:37:35 volumiodk volumio[950]: info: Plugin example_plugin is not enabled Mar 01 13:37:35 volumiodk volumio[950]: info: Loading plugin "inputs"... Mar 01 13:37:35 volumiodk volumio[950]: info: Loading plugin "updater_comm"... Mar 01 13:37:36 volumiodk systemd[1]: systemd-fsckd.service: Succeeded. Mar 01 13:37:36 volumiodk volumio[950]: info: Plugin mpdemulation is not enabled Mar 01 13:37:36 volumiodk volumio[950]: info: Loading plugin "rest_api"... Mar 01 13:37:36 volumiodk volumio[950]: info: Loading plugin "websocket"... Mar 01 13:37:36 volumiodk volumio[950]: info: Starting Socket.io Server version 2.3.0 Mar 01 13:37:36 volumiodk volumio[950]: info: Loading plugin "backup_restore"... Mar 01 13:37:36 volumiodk volumio[950]: Forking 1 albumart workers Mar 01 13:37:37 volumiodk volumio[950]: info: Applying required configuration parameters for plugin backup_restore Mar 01 13:37:37 volumiodk volumio[950]: info: Loading plugin "Systeminfo"... Mar 01 13:37:38 volumiodk volumio[950]: info: Loading i18n strings for locale en Mar 01 13:37:38 volumiodk volumio[950]: Updating browse sources language Mar 01 13:37:38 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 13:37:39 volumiodk volumio[950]: Starting albumart workers Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::initPlayerControls Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 13:37:39 volumiodk volumio[950]: Express server listening on port 3000 Mar 01 13:37:39 volumiodk volumio[950]: [Metrics] WebUI: 20s 453.34ms Mar 01 13:37:39 volumiodk volumio[950]: info: CoreStateMachine::resetVolumioState Mar 01 13:37:39 volumiodk volumio[950]: info: CoreStateMachine::getcurrentVolume Mar 01 13:37:39 volumiodk volumio[950]: info: CoreCommandRouter::volumioRetrievevolume Mar 01 13:37:39 volumiodk volumio[950]: info: CoreStateMachine::pushState Mar 01 13:37:40 volumiodk volumio[950]: info: CorePlayQueue::getTrack 0 Mar 01 13:37:40 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 13:37:40 volumiodk volumio[950]: info: CoreCommandRouter::volumioPushState Mar 01 13:37:40 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 13:37:40 volumiodk volumio[950]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Mar 01 13:37:40 volumiodk volumio[950]: info: Completed loading Core Plugins Mar 01 13:37:40 volumiodk volumio[950]: info: Preparing to generate the ALSA configuration file Mar 01 13:37:40 volumiodk volumio[950]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Mar 01 13:37:40 volumiodk volumio[950]: wlan0 Interface doesn't support scanning. Mar 01 13:37:40 volumiodk volumio[950]: info: Cannot use regular scanning, forcing with ap-force Mar 01 13:37:40 volumiodk sudo[1177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Mar 01 13:37:40 volumiodk sudo[1177]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:40 volumiodk sudo[1177]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:40 volumiodk volumio[950]: command failed: No such device (-19) Mar 01 13:37:40 volumiodk volumio[950]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Mar 01 13:37:40 volumiodk volumio[950]: command failed: No such device (-19) Mar 01 13:37:41 volumiodk volumio[950]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.6 UA: Mozilla/5.0 (Linux; Android 11; SM-A202F Build/RP1A.200720.012; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.137 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Mar 01 13:37:41 volumiodk volumio[950]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.6 UA: Mozilla/5.0 (Linux; Android 11; SM-A202F Build/RP1A.200720.012; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.137 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Mar 01 13:37:41 volumiodk volumio[950]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.6 UA: Mozilla/5.0 (Linux; Android 11; SM-A202F Build/RP1A.200720.012; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.137 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Mar 01 13:37:41 volumiodk volumio[950]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.6 UA: Mozilla/5.0 (Linux; Android 11; SM-A202F Build/RP1A.200720.012; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.137 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Mar 01 13:37:41 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 13:37:41 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 13:37:41 volumiodk volumio[950]: info: Discovery: Getting this device information Mar 01 13:37:41 volumiodk volumio[950]: info: CoreCommandRouter::volumioGetState Mar 01 13:37:41 volumiodk volumio[950]: info: CorePlayQueue::getTrack 0 Mar 01 13:37:41 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 13:37:41 volumiodk volumio[950]: info: Cannot read play queue from file Mar 01 13:37:41 volumiodk volumio[950]: info: CoreStateMachine::setRepeat false single undefined Mar 01 13:37:41 volumiodk volumio[950]: info: CoreStateMachine::pushState Mar 01 13:37:41 volumiodk volumio[950]: info: CorePlayQueue::getTrack 0 Mar 01 13:37:41 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 13:37:41 volumiodk volumio[950]: info: CoreCommandRouter::volumioPushState Mar 01 13:37:41 volumiodk volumio[950]: info: CoreStateMachine::setRandom null Mar 01 13:37:41 volumiodk volumio[950]: info: CoreStateMachine::pushState Mar 01 13:37:41 volumiodk volumio[950]: info: CorePlayQueue::getTrack 0 Mar 01 13:37:41 volumiodk volumio[950]: info: CoreCommandRouter::volumioPushState Mar 01 13:37:41 volumiodk sudo[1195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 01 13:37:41 volumiodk sudo[1195]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:41 volumiodk sudo[1197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 13:37:41 volumiodk sudo[1197]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:41 volumiodk volumio[950]: info: Asound.conf file unchanged, so no further update is needed Mar 01 13:37:41 volumiodk sudo[1195]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:41 volumiodk volumio[950]: info: Output device has changed, restarting MPD Mar 01 13:37:41 volumiodk sudo[1197]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:41 volumiodk volumio[950]: info: Output device has changed, restarting Shairport Sync Mar 01 13:37:41 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:41 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 13:37:41 volumiodk sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 01 13:37:41 volumiodk sudo[1203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 01 13:37:41 volumiodk sudo[1203]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:41 volumiodk sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:41 volumiodk sudo[1203]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:42 volumiodk systemd[1]: Listening on mpd.socket. Mar 01 13:37:42 volumiodk systemd[1]: Starting Music Player Daemon... Mar 01 13:37:42 volumiodk volumio[950]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 01 13:37:42 volumiodk volumio[950]: info: ___________ START PLUGINS ___________ Mar 01 13:37:42 volumiodk volumio[950]: info: ControllerMpd::onStart: Initializing MPD Mar 01 13:37:42 volumiodk volumio[950]: info: Creating MPD Configuration file Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 01 13:37:42 volumiodk volumio[950]: info: [1740832662308] CoreMusicLibrary::Adding element Media Servers Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 13:37:42 volumiodk sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 01 13:37:42 volumiodk sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:42 volumiodk sudo[1214]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:42 volumiodk sudo[1216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 01 13:37:42 volumiodk sudo[1216]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 13:37:42 volumiodk systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 01 13:37:42 volumiodk systemd[1]: mpd.service: Succeeded. Mar 01 13:37:42 volumiodk systemd[1]: Stopped Music Player Daemon. Mar 01 13:37:42 volumiodk systemd[1]: Starting Music Player Daemon... Mar 01 13:37:42 volumiodk volumio[950]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 13:37:42 volumiodk volumio[950]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 01 13:37:42 volumiodk volumio[950]: info: [1740832662714] CoreMusicLibrary::Adding element Last_100 Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 01 13:37:42 volumiodk volumio[950]: info: [1740832662725] CoreMusicLibrary::Adding element Webradio Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 13:37:42 volumiodk volumio[950]: info: Initializing BBC Radios Mar 01 13:37:42 volumiodk sudo[1222]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 01 13:37:42 volumiodk sudo[1222]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 13:37:42 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 13:37:42 volumiodk volumio[950]: info: Volumio Calling Home Mar 01 13:37:43 volumiodk sudo[1222]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 01 13:37:43 volumiodk sudo[1222]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:43 volumiodk volumio[950]: info: Discovery: adding 91909293-a37b-4d9f-a6b7-64a0d50f7355 Mar 01 13:37:43 volumiodk volumio[950]: info: Discovery: Found device VolumioDK Mar 01 13:37:43 volumiodk volumio[950]: info: CoreCommandRouter::volumioGetState Mar 01 13:37:43 volumiodk volumio[950]: info: CorePlayQueue::getTrack 0 Mar 01 13:37:43 volumiodk volumio[950]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.6 UA: Mozilla/5.0 (Linux; Android 11; SM-A202F Build/RP1A.200720.012; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.137 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Mar 01 13:37:43 volumiodk volumio[950]: info: MPD Permissions set Mar 01 13:37:44 volumiodk volumio[950]: info: Volumio called home Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 01 13:37:44 volumiodk volumio[950]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::volumioGetVisibleSources Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 13:37:44 volumiodk volumio-remote-updater[717]: [2025-03-01 13:37:44] [connect] Successful connection Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::volumioGetState Mar 01 13:37:44 volumiodk volumio[950]: info: CorePlayQueue::getTrack 0 Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 01 13:37:44 volumiodk volumio[950]: info: Received Get System Info Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 13:37:44 volumiodk volumio[950]: info: Discovery: Getting this device information Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::volumioGetState Mar 01 13:37:44 volumiodk volumio[950]: info: CorePlayQueue::getTrack 0 Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::volumioGetState Mar 01 13:37:44 volumiodk volumio[950]: info: CorePlayQueue::getTrack 0 Mar 01 13:37:44 volumiodk volumio[950]: info: Listing playlists Mar 01 13:37:44 volumiodk volumio[950]: info: CoreCommandRouter::volumioGetQueue Mar 01 13:37:44 volumiodk volumio[950]: info: CoreStateMachine::getQueue Mar 01 13:37:44 volumiodk volumio[950]: info: CorePlayQueue::getQueue Mar 01 13:37:45 volumiodk sudo[1254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 01 13:37:45 volumiodk sudo[1254]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:45 volumiodk volumio-remote-updater[717]: [2025-03-01 13:37:45] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1740832664 101 Mar 01 13:37:45 volumiodk volumio[950]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 7 Mar 01 13:37:45 volumiodk volumio[950]: info: Starting Shairport Sync Mar 01 13:37:45 volumiodk systemd[1]: Started UPnP Renderer front-end to MPD. Mar 01 13:37:45 volumiodk sudo[1254]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:45 volumiodk volumio[950]: info: Starting Shairport Sync Mar 01 13:37:45 volumiodk volumio[950]: info: Starting Shairport Sync Mar 01 13:37:45 volumiodk sudo[1259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 01 13:37:45 volumiodk sudo[1259]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:45 volumiodk sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 01 13:37:45 volumiodk sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:45 volumiodk sudo[1265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 01 13:37:45 volumiodk sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 13:37:45 volumiodk volumio[950]: info: Preload queue cleared Mar 01 13:37:45 volumiodk volumio[950]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 01 13:37:45 volumiodk volumio[950]: info: CoreStateMachine::ClearQueue Mar 01 13:37:45 volumiodk volumio[950]: info: CoreStateMachine::stop Mar 01 13:37:45 volumiodk volumio[950]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 13:37:45 volumiodk volumio[950]: info: CorePlayQueue::clearPlayQueue Mar 01 13:37:45 volumiodk volumio[950]: info: CorePlayQueue::saveQueue Mar 01 13:37:45 volumiodk volumio[950]: info: CoreCommandRouter::volumioPushQueue Mar 01 13:37:45 volumiodk volumio[950]: info: CoreStateMachine::addQueueItems Mar 01 13:37:45 volumiodk volumio[950]: info: CorePlayQueue::addQueueItems Mar 01 13:37:45 volumiodk volumio[950]: info: Preload queue cleared Mar 01 13:37:46 volumiodk volumio[950]: info: Adding Item to queue: music-library/USB/KARALIC/2/2-Deep Purple - Machine Head - 1974,(Japan),DSF(tracks),(HANA+SAEC-407+NG-6BG(50)+DDL-120)/B1 Smoke On The Water.dsf Mar 01 13:37:46 volumiodk volumio[950]: info: Exploding uri music-library/USB/KARALIC/2/2-Deep Purple - Machine Head - 1974,(Japan),DSF(tracks),(HANA+SAEC-407+NG-6BG(50)+DDL-120)/B1 Smoke On The Water.dsf in service mpd Mar 01 13:37:46 volumiodk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 01 13:37:46 volumiodk volumio[950]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 13:37:46 volumiodk systemd[1]: shairport-sync.service: Succeeded. Mar 01 13:37:46 volumiodk systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 01 13:37:46 volumiodk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 01 13:37:46 volumiodk volumio[950]: TypeError: Cannot read property 'then' of undefined Mar 01 13:37:46 volumiodk volumio[950]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Mar 01 13:37:46 volumiodk volumio[950]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Mar 01 13:37:46 volumiodk volumio[950]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1365:16) Mar 01 13:37:46 volumiodk volumio[950]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Mar 01 13:37:46 volumiodk volumio[950]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Mar 01 13:37:46 volumiodk volumio[950]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Mar 01 13:37:46 volumiodk volumio[950]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Mar 01 13:37:46 volumiodk volumio[950]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:507:23) Mar 01 13:37:46 volumiodk volumio[950]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:483:17) Mar 01 13:37:46 volumiodk volumio[950]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Mar 01 13:37:46 volumiodk volumio[950]: at Socket.emit (events.js:400:28) Mar 01 13:37:46 volumiodk volumio[950]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 01 13:37:46 volumiodk volumio[950]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Mar 01 13:37:46 volumiodk volumio[950]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 13:37:46 volumiodk sudo[1265]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:46 volumiodk sudo[1262]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:46 volumiodk sudo[1259]: pam_unix(sudo:session): session closed for user root Mar 01 13:37:48 volumiodk sudo[1279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-01 13:36 Mar 01 13:37:48 volumiodk sudo[1279]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Sep 2024 09:45:06 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="bananapim1" VOLUMIO_DEVICENAME="BananaPi M1" VOLUMIO_HASH="89d82fddc741ef0aa74780c3c7a7d849"