-- Logs begin at Wed 2025-12-10 20:17:17 PST, end at Wed 2025-12-10 21:14:47 PST. -- Dec 10 21:14:24 volumio-nanopi kernel: Booting Linux on physical CPU 0x0 Dec 10 21:14:24 volumio-nanopi 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 Tue Jul 11 17:28:34 CEST 2023 Dec 10 21:14:24 volumio-nanopi kernel: CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=50c5387d Dec 10 21:14:24 volumio-nanopi kernel: CPU: div instructions available: patching division code Dec 10 21:14:24 volumio-nanopi kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache Dec 10 21:14:24 volumio-nanopi kernel: OF: fdt: Machine model: Xunlong Orange Pi PC Dec 10 21:14:24 volumio-nanopi kernel: Memory policy: Data cache writealloc Dec 10 21:14:24 volumio-nanopi kernel: cma: Reserved 128 MiB at 0x78000000 Dec 10 21:14:24 volumio-nanopi kernel: Zone ranges: Dec 10 21:14:24 volumio-nanopi kernel: Normal [mem 0x0000000040000000-0x000000006fffffff] Dec 10 21:14:24 volumio-nanopi kernel: HighMem [mem 0x0000000070000000-0x000000007fffffff] Dec 10 21:14:24 volumio-nanopi kernel: Movable zone start for each node Dec 10 21:14:24 volumio-nanopi kernel: Early memory node ranges Dec 10 21:14:24 volumio-nanopi kernel: node 0: [mem 0x0000000040000000-0x000000007fffffff] Dec 10 21:14:24 volumio-nanopi kernel: Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] Dec 10 21:14:24 volumio-nanopi kernel: psci: probing for conduit method from DT. Dec 10 21:14:24 volumio-nanopi kernel: psci: Using PSCI v0.1 Function IDs from DT Dec 10 21:14:24 volumio-nanopi kernel: percpu: Embedded 17 pages/cpu s38540 r8192 d22900 u69632 Dec 10 21:14:24 volumio-nanopi kernel: pcpu-alloc: s38540 r8192 d22900 u69632 alloc=17*4096 Dec 10 21:14:24 volumio-nanopi kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 10 21:14:24 volumio-nanopi kernel: Built 1 zonelists, mobility grouping on. Total pages: 260416 Dec 10 21:14:24 volumio-nanopi 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=01101494-01 ubootsource=mmc usb-storage.quirks=0x2537:0x1066:u,0x2537:0x1068:u imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh net.ifnames=0 hwver=orangepi sunxi_ve_mem_reserve=0 sunxi_g2d_mem_reserve=0 sunxi_fb_mem_reserve=16 cgroup_enable=memory swapaccount=1 Dec 10 21:14:24 volumio-nanopi kernel: Unknown kernel command line parameters "splash ubootpart=01101494-01 ubootsource=mmc imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh hwver=orangepi sunxi_ve_mem_reserve=0 sunxi_g2d_mem_reserve=0 sunxi_fb_mem_reserve=16 cgroup_enable=memory", will be passed to user space. Dec 10 21:14:24 volumio-nanopi kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: mem auto-init: stack:off, heap alloc:on, heap free:off Dec 10 21:14:24 volumio-nanopi kernel: Memory: 875852K/1048576K available (9216K kernel code, 1510K rwdata, 3408K rodata, 1024K init, 326K bss, 41652K reserved, 131072K cma-reserved, 131072K highmem) Dec 10 21:14:24 volumio-nanopi kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 10 21:14:24 volumio-nanopi kernel: ftrace: allocating 44001 entries in 130 pages Dec 10 21:14:24 volumio-nanopi kernel: ftrace: allocated 129 pages with 2 groups Dec 10 21:14:24 volumio-nanopi kernel: trace event string verifier disabled Dec 10 21:14:24 volumio-nanopi kernel: rcu: Hierarchical RCU implementation. Dec 10 21:14:24 volumio-nanopi kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Dec 10 21:14:24 volumio-nanopi kernel: Rude variant of Tasks RCU enabled. Dec 10 21:14:24 volumio-nanopi kernel: Tracing variant of Tasks RCU enabled. Dec 10 21:14:24 volumio-nanopi kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Dec 10 21:14:24 volumio-nanopi kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 10 21:14:24 volumio-nanopi kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Dec 10 21:14:24 volumio-nanopi kernel: GIC: Using split EOI/Deactivate mode Dec 10 21:14:24 volumio-nanopi kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635851949 ns Dec 10 21:14:24 volumio-nanopi kernel: arch_timer: cp15 timer(s) running at 24.00MHz (phys). Dec 10 21:14:24 volumio-nanopi kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns Dec 10 21:14:24 volumio-nanopi kernel: sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns Dec 10 21:14:24 volumio-nanopi kernel: Switching to timer-based delay loop, resolution 41ns Dec 10 21:14:24 volumio-nanopi kernel: Console: colour dummy device 80x30 Dec 10 21:14:24 volumio-nanopi kernel: printk: console [tty1] enabled Dec 10 21:14:24 volumio-nanopi kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000) Dec 10 21:14:24 volumio-nanopi kernel: pid_max: default: 32768 minimum: 301 Dec 10 21:14:24 volumio-nanopi kernel: LSM: Security Framework initializing Dec 10 21:14:24 volumio-nanopi kernel: Yama: becoming mindful. Dec 10 21:14:24 volumio-nanopi kernel: AppArmor: AppArmor initialized Dec 10 21:14:24 volumio-nanopi kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: CPU: Testing write buffer coherency: ok Dec 10 21:14:24 volumio-nanopi kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Dec 10 21:14:24 volumio-nanopi kernel: Setting up static identity map for 0x40100000 - 0x40100054 Dec 10 21:14:24 volumio-nanopi kernel: rcu: Hierarchical SRCU implementation. Dec 10 21:14:24 volumio-nanopi kernel: smp: Bringing up secondary CPUs ... Dec 10 21:14:24 volumio-nanopi kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Dec 10 21:14:24 volumio-nanopi kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Dec 10 21:14:24 volumio-nanopi kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Dec 10 21:14:24 volumio-nanopi kernel: smp: Brought up 1 node, 4 CPUs Dec 10 21:14:24 volumio-nanopi kernel: SMP: Total of 4 processors activated (192.00 BogoMIPS). Dec 10 21:14:24 volumio-nanopi kernel: CPU: All CPU(s) started in HYP mode. Dec 10 21:14:24 volumio-nanopi kernel: CPU: Virtualization extensions available. Dec 10 21:14:24 volumio-nanopi kernel: allocated 1048576 bytes of page_ext Dec 10 21:14:24 volumio-nanopi kernel: devtmpfs: initialized Dec 10 21:14:24 volumio-nanopi kernel: VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 5 Dec 10 21:14:24 volumio-nanopi kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Dec 10 21:14:24 volumio-nanopi kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: pinctrl core: initialized pinctrl subsystem Dec 10 21:14:24 volumio-nanopi kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 10 21:14:24 volumio-nanopi kernel: DMA: preallocated 256 KiB pool for atomic coherent allocations Dec 10 21:14:24 volumio-nanopi kernel: audit: initializing netlink subsys (disabled) Dec 10 21:14:24 volumio-nanopi kernel: audit: type=2000 audit(0.076:1): state=initialized audit_enabled=0 res=1 Dec 10 21:14:24 volumio-nanopi kernel: thermal_sys: Registered thermal governor 'fair_share' Dec 10 21:14:24 volumio-nanopi kernel: thermal_sys: Registered thermal governor 'bang_bang' Dec 10 21:14:24 volumio-nanopi kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 10 21:14:24 volumio-nanopi kernel: cpuidle: using governor ladder Dec 10 21:14:24 volumio-nanopi kernel: cpuidle: using governor menu Dec 10 21:14:24 volumio-nanopi kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Dec 10 21:14:24 volumio-nanopi kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Dec 10 21:14:24 volumio-nanopi kernel: platform 1c0c000.lcd-controller: Fixing up cyclic dependency with 1100000.mixer Dec 10 21:14:24 volumio-nanopi kernel: platform 1ee0000.hdmi: Fixing up cyclic dependency with 1c0c000.lcd-controller Dec 10 21:14:24 volumio-nanopi kernel: platform connector: Fixing up cyclic dependency with 1ee0000.hdmi Dec 10 21:14:24 volumio-nanopi kernel: cryptd: max_cpu_qlen set to 1000 Dec 10 21:14:24 volumio-nanopi kernel: raid6: neonx8 gen() 314 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: neonx8 xor() 233 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: neonx4 gen() 335 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: neonx4 xor() 255 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: neonx2 gen() 369 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: neonx2 xor() 264 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: neonx1 gen() 329 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: neonx1 xor() 228 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: int32x8 gen() 122 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: int32x8 xor() 72 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: int32x4 gen() 143 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: int32x4 xor() 83 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: int32x2 gen() 161 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: int32x2 xor() 86 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: int32x1 gen() 162 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: int32x1 xor() 77 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: using algorithm neonx2 gen() 369 MB/s Dec 10 21:14:24 volumio-nanopi kernel: raid6: .... xor() 264 MB/s, rmw enabled Dec 10 21:14:24 volumio-nanopi kernel: raid6: using neon recovery algorithm Dec 10 21:14:24 volumio-nanopi kernel: iommu: Default domain type: Translated Dec 10 21:14:24 volumio-nanopi kernel: iommu: DMA domain TLB invalidation policy: strict mode Dec 10 21:14:24 volumio-nanopi kernel: SCSI subsystem initialized Dec 10 21:14:24 volumio-nanopi kernel: libata version 3.00 loaded. Dec 10 21:14:24 volumio-nanopi kernel: usbcore: registered new interface driver usbfs Dec 10 21:14:24 volumio-nanopi kernel: usbcore: registered new interface driver hub Dec 10 21:14:24 volumio-nanopi kernel: usbcore: registered new device driver usb Dec 10 21:14:24 volumio-nanopi kernel: mc: Linux media interface: v0.10 Dec 10 21:14:24 volumio-nanopi kernel: videodev: Linux video capture interface: v2.00 Dec 10 21:14:24 volumio-nanopi kernel: pps_core: LinuxPPS API ver. 1 registered Dec 10 21:14:24 volumio-nanopi kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Dec 10 21:14:24 volumio-nanopi kernel: PTP clock support registered Dec 10 21:14:24 volumio-nanopi kernel: Advanced Linux Sound Architecture Driver Initialized. Dec 10 21:14:24 volumio-nanopi kernel: NetLabel: Initializing Dec 10 21:14:24 volumio-nanopi kernel: NetLabel: domain hash size = 128 Dec 10 21:14:24 volumio-nanopi kernel: NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO Dec 10 21:14:24 volumio-nanopi kernel: NetLabel: unlabeled traffic allowed by default Dec 10 21:14:24 volumio-nanopi kernel: clocksource: Switched to clocksource arch_sys_counter Dec 10 21:14:24 volumio-nanopi kernel: VFS: Disk quotas dquot_6.6.0 Dec 10 21:14:24 volumio-nanopi kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Dec 10 21:14:24 volumio-nanopi kernel: AppArmor: AppArmor Filesystem Enabled Dec 10 21:14:24 volumio-nanopi kernel: NET: Registered PF_INET protocol family Dec 10 21:14:24 volumio-nanopi kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: TCP: Hash tables configured (established 8192 bind 8192) Dec 10 21:14:24 volumio-nanopi kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Dec 10 21:14:24 volumio-nanopi kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 10 21:14:24 volumio-nanopi kernel: Trying to unpack rootfs image as initramfs... Dec 10 21:14:24 volumio-nanopi kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 5 counters available Dec 10 21:14:24 volumio-nanopi kernel: Initialise system trusted keyrings Dec 10 21:14:24 volumio-nanopi kernel: Key type blacklist registered Dec 10 21:14:24 volumio-nanopi kernel: workingset: timestamp_bits=14 max_order=18 bucket_order=4 Dec 10 21:14:24 volumio-nanopi kernel: zbud: loaded Dec 10 21:14:24 volumio-nanopi kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 10 21:14:24 volumio-nanopi kernel: fuse: init (API version 7.34) Dec 10 21:14:24 volumio-nanopi kernel: integrity: Platform Keyring initialized Dec 10 21:14:24 volumio-nanopi kernel: xor: measuring software checksum speed Dec 10 21:14:24 volumio-nanopi kernel: arm4regs : 524 MB/sec Dec 10 21:14:24 volumio-nanopi kernel: 8regs : 363 MB/sec Dec 10 21:14:24 volumio-nanopi kernel: 32regs : 343 MB/sec Dec 10 21:14:24 volumio-nanopi kernel: neon : 532 MB/sec Dec 10 21:14:24 volumio-nanopi kernel: xor: using function: neon (532 MB/sec) Dec 10 21:14:24 volumio-nanopi kernel: Key type asymmetric registered Dec 10 21:14:24 volumio-nanopi kernel: Asymmetric key parser 'x509' registered Dec 10 21:14:24 volumio-nanopi kernel: bounce: pool size: 64 pages Dec 10 21:14:24 volumio-nanopi kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246) Dec 10 21:14:25 volumio-nanopi kernel: io scheduler mq-deadline registered Dec 10 21:14:25 volumio-nanopi kernel: io scheduler kyber registered Dec 10 21:14:25 volumio-nanopi kernel: io scheduler bfq registered Dec 10 21:14:25 volumio-nanopi kernel: sun8i-h3-pinctrl 1c20800.pinctrl: initialized sunXi PIO driver Dec 10 21:14:25 volumio-nanopi kernel: sun8i-h3-r-pinctrl 1f02c00.pinctrl: initialized sunXi PIO driver Dec 10 21:14:25 volumio-nanopi kernel: Serial: 8250/16550 driver, 8 ports, IRQ sharing disabled Dec 10 21:14:25 volumio-nanopi kernel: sun8i-h3-pinctrl 1c20800.pinctrl: supply vcc-pa not found, using dummy regulator Dec 10 21:14:25 volumio-nanopi kernel: printk: console [ttyS0] disabled Dec 10 21:14:25 volumio-nanopi kernel: 1c28000.serial: ttyS0 at MMIO 0x1c28000 (irq = 51, base_baud = 1500000) is a 16550A Dec 10 21:14:25 volumio-nanopi kernel: printk: console [ttyS0] enabled Dec 10 21:14:25 volumio-nanopi kernel: brd: module loaded Dec 10 21:14:25 volumio-nanopi kernel: loop: module loaded Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: IRQ eth_wake_irq not found Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: IRQ eth_lpi not found Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: supply phy not found, using dummy regulator Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: supply phy-io not found, using dummy regulator Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: PTP uses main clock Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: Current syscon value is not the default 148000 (expect 58000) Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: No HW DMA feature register supported Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: RX Checksum Offload Engine supported Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: COE Type 2 Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: TX Checksum insertion supported Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: Normal descriptors Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: Chain mode enabled Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: Found internal PHY node Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: Switch mux to internal PHY Dec 10 21:14:25 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet: Powering internal PHY Dec 10 21:14:25 volumio-nanopi kernel: Freeing initrd memory: 15044K Dec 10 21:14:25 volumio-nanopi kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform: EHCI generic platform driver Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1a000.usb: EHCI Host Controller Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1a000.usb: new USB bus registered, assigned bus number 1 Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1a000.usb: irq 35, io mem 0x01c1a000 Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1a000.usb: USB 2.0 started, EHCI 1.00 Dec 10 21:14:25 volumio-nanopi kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Dec 10 21:14:25 volumio-nanopi kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 10 21:14:25 volumio-nanopi kernel: usb usb1: Product: EHCI Host Controller Dec 10 21:14:25 volumio-nanopi kernel: usb usb1: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Dec 10 21:14:25 volumio-nanopi kernel: usb usb1: SerialNumber: 1c1a000.usb Dec 10 21:14:25 volumio-nanopi kernel: hub 1-0:1.0: USB hub found Dec 10 21:14:25 volumio-nanopi kernel: hub 1-0:1.0: 1 port detected Dec 10 21:14:25 volumio-nanopi kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform: OHCI generic platform driver Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1a400.usb: Generic Platform OHCI controller Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1a400.usb: new USB bus registered, assigned bus number 2 Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1a400.usb: irq 36, io mem 0x01c1a400 Dec 10 21:14:25 volumio-nanopi kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Dec 10 21:14:25 volumio-nanopi kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 10 21:14:25 volumio-nanopi kernel: usb usb2: Product: Generic Platform OHCI controller Dec 10 21:14:25 volumio-nanopi kernel: usb usb2: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Dec 10 21:14:25 volumio-nanopi kernel: usb usb2: SerialNumber: 1c1a400.usb Dec 10 21:14:25 volumio-nanopi kernel: hub 2-0:1.0: USB hub found Dec 10 21:14:25 volumio-nanopi kernel: hub 2-0:1.0: 1 port detected Dec 10 21:14:25 volumio-nanopi kernel: usbcore: registered new interface driver usb-storage Dec 10 21:14:25 volumio-nanopi kernel: sun6i-rtc 1f00000.rtc: registered as rtc0 Dec 10 21:14:25 volumio-nanopi kernel: sun6i-rtc 1f00000.rtc: setting system clock to 2025-12-11T05:14:12 UTC (1765430052) Dec 10 21:14:25 volumio-nanopi kernel: sun6i-rtc 1f00000.rtc: RTC enabled Dec 10 21:14:25 volumio-nanopi kernel: i2c_dev: i2c /dev entries driver Dec 10 21:14:25 volumio-nanopi kernel: sun8i-h3-r-pinctrl 1f02c00.pinctrl: supply vcc-pl not found, using dummy regulator Dec 10 21:14:25 volumio-nanopi kernel: sunxi-wdt 1c20ca0.watchdog: Watchdog enabled (timeout=16 sec, nowayout=0) Dec 10 21:14:25 volumio-nanopi kernel: sun8i-h3-pinctrl 1c20800.pinctrl: supply vcc-pf not found, using dummy regulator Dec 10 21:14:25 volumio-nanopi kernel: sunxi-mmc 1c0f000.mmc: Got CD GPIO Dec 10 21:14:25 volumio-nanopi kernel: ledtrig-cpu: registered to indicate activity on CPUs Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Set mod clock to 50000000 (50 Mhz) from 24000000 (24 Mhz) Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Register cbc(aes) Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Register ecb(aes) Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Register cbc(des3_ede) Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Register ecb(des3_ede) Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Register md5 Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Register sha1 Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Register sha224 Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Register sha256 Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Register sha384 Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Register sha512 Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: Register stdrng Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: TRNG not supported Dec 10 21:14:25 volumio-nanopi kernel: sun8i-ce 1c15000.crypto: CryptoEngine Die ID 1 Dec 10 21:14:25 volumio-nanopi kernel: hid: raw HID events driver (C) Jiri Kosina Dec 10 21:14:25 volumio-nanopi kernel: usbcore: registered new interface driver usbhid Dec 10 21:14:25 volumio-nanopi kernel: usbhid: USB HID core driver Dec 10 21:14:25 volumio-nanopi kernel: debugfs: Directory '1c22c00.codec' with parent 'H3 Audio Codec' already present! Dec 10 21:14:25 volumio-nanopi kernel: sunxi-mmc 1c0f000.mmc: initialized, max. request size: 16384 KB Dec 10 21:14:25 volumio-nanopi kernel: Initializing XFRM netlink socket Dec 10 21:14:25 volumio-nanopi kernel: NET: Registered PF_INET6 protocol family Dec 10 21:14:25 volumio-nanopi kernel: mmc0: host does not support reading read-only switch, assuming write-enable Dec 10 21:14:25 volumio-nanopi kernel: mmc0: new high speed SDHC card at address aaaa Dec 10 21:14:25 volumio-nanopi kernel: mmcblk0: mmc0:aaaa SS16G 14.8 GiB Dec 10 21:14:25 volumio-nanopi kernel: mmcblk0: p1 p2 p3 Dec 10 21:14:25 volumio-nanopi kernel: Segment Routing with IPv6 Dec 10 21:14:25 volumio-nanopi kernel: In-situ OAM (IOAM) with IPv6 Dec 10 21:14:25 volumio-nanopi kernel: NET: Registered PF_PACKET protocol family Dec 10 21:14:25 volumio-nanopi kernel: NET: Registered PF_KEY protocol family Dec 10 21:14:25 volumio-nanopi kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Dec 10 21:14:25 volumio-nanopi kernel: 8021q: 802.1Q VLAN Support v1.8 Dec 10 21:14:25 volumio-nanopi kernel: Key type dns_resolver registered Dec 10 21:14:25 volumio-nanopi kernel: Registering SWP/SWPB emulation handler Dec 10 21:14:25 volumio-nanopi kernel: registered taskstats version 1 Dec 10 21:14:25 volumio-nanopi kernel: Loading compiled-in X.509 certificates Dec 10 21:14:25 volumio-nanopi kernel: Loaded X.509 cert 'Build time autogenerated kernel key: 8f8e38801ad26e1c5752b0545ce65e141a715a7d' Dec 10 21:14:25 volumio-nanopi kernel: zswap: loaded using pool zstd/z3fold Dec 10 21:14:25 volumio-nanopi kernel: Key type .fscrypt registered Dec 10 21:14:25 volumio-nanopi kernel: Key type fscrypt-provisioning registered Dec 10 21:14:25 volumio-nanopi kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=yes Dec 10 21:14:25 volumio-nanopi kernel: Key type encrypted registered Dec 10 21:14:25 volumio-nanopi kernel: AppArmor: AppArmor sha1 policy hashing enabled Dec 10 21:14:25 volumio-nanopi kernel: sun8i-h3-pinctrl 1c20800.pinctrl: supply vcc-pg not found, using dummy regulator Dec 10 21:14:25 volumio-nanopi kernel: sun4i-drm display-engine: bound 1100000.mixer (ops 0xc0aa3538) Dec 10 21:14:25 volumio-nanopi kernel: sun4i-drm display-engine: bound 1c0c000.lcd-controller (ops 0xc0a9f46c) Dec 10 21:14:25 volumio-nanopi kernel: sun8i-dw-hdmi 1ee0000.hdmi: supply hvcc not found, using dummy regulator Dec 10 21:14:25 volumio-nanopi kernel: sun8i-dw-hdmi 1ee0000.hdmi: Detected HDMI TX controller v1.32a with HDCP (sun8i_dw_hdmi_phy) Dec 10 21:14:25 volumio-nanopi kernel: sun8i-dw-hdmi 1ee0000.hdmi: registered DesignWare HDMI I2C bus driver Dec 10 21:14:25 volumio-nanopi kernel: sun4i-drm display-engine: bound 1ee0000.hdmi (ops 0xc0aa2aec) Dec 10 21:14:25 volumio-nanopi kernel: [drm] Initialized sun4i-drm 1.0.0 20150629 for display-engine on minor 0 Dec 10 21:14:25 volumio-nanopi kernel: sun4i-drm display-engine: [drm] Cannot find any crtc or sizes Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1b000.usb: EHCI Host Controller Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1b000.usb: new USB bus registered, assigned bus number 3 Dec 10 21:14:25 volumio-nanopi kernel: sun4i-drm display-engine: [drm] Cannot find any crtc or sizes Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1b000.usb: irq 37, io mem 0x01c1b000 Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1b000.usb: USB 2.0 started, EHCI 1.00 Dec 10 21:14:25 volumio-nanopi kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Dec 10 21:14:25 volumio-nanopi kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 10 21:14:25 volumio-nanopi kernel: usb usb3: Product: EHCI Host Controller Dec 10 21:14:25 volumio-nanopi kernel: usb usb3: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Dec 10 21:14:25 volumio-nanopi kernel: usb usb3: SerialNumber: 1c1b000.usb Dec 10 21:14:25 volumio-nanopi kernel: hub 3-0:1.0: USB hub found Dec 10 21:14:25 volumio-nanopi kernel: hub 3-0:1.0: 1 port detected Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1c000.usb: EHCI Host Controller Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1c000.usb: new USB bus registered, assigned bus number 4 Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1c000.usb: irq 39, io mem 0x01c1c000 Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1c000.usb: USB 2.0 started, EHCI 1.00 Dec 10 21:14:25 volumio-nanopi kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Dec 10 21:14:25 volumio-nanopi kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 10 21:14:25 volumio-nanopi kernel: usb usb4: Product: EHCI Host Controller Dec 10 21:14:25 volumio-nanopi kernel: usb usb4: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Dec 10 21:14:25 volumio-nanopi kernel: usb usb4: SerialNumber: 1c1c000.usb Dec 10 21:14:25 volumio-nanopi kernel: hub 4-0:1.0: USB hub found Dec 10 21:14:25 volumio-nanopi kernel: hub 4-0:1.0: 1 port detected Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1d000.usb: EHCI Host Controller Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1d000.usb: new USB bus registered, assigned bus number 5 Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1d000.usb: irq 41, io mem 0x01c1d000 Dec 10 21:14:25 volumio-nanopi kernel: ehci-platform 1c1d000.usb: USB 2.0 started, EHCI 1.00 Dec 10 21:14:25 volumio-nanopi kernel: usb usb5: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Dec 10 21:14:25 volumio-nanopi kernel: usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 10 21:14:25 volumio-nanopi kernel: usb usb5: Product: EHCI Host Controller Dec 10 21:14:25 volumio-nanopi kernel: usb usb5: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Dec 10 21:14:25 volumio-nanopi kernel: usb usb5: SerialNumber: 1c1d000.usb Dec 10 21:14:25 volumio-nanopi kernel: hub 5-0:1.0: USB hub found Dec 10 21:14:25 volumio-nanopi kernel: hub 5-0:1.0: 1 port detected Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1b400.usb: Generic Platform OHCI controller Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1b400.usb: new USB bus registered, assigned bus number 6 Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1b400.usb: irq 38, io mem 0x01c1b400 Dec 10 21:14:25 volumio-nanopi kernel: usb usb6: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Dec 10 21:14:25 volumio-nanopi kernel: usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 10 21:14:25 volumio-nanopi kernel: usb usb6: Product: Generic Platform OHCI controller Dec 10 21:14:25 volumio-nanopi kernel: usb usb6: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Dec 10 21:14:25 volumio-nanopi kernel: usb usb6: SerialNumber: 1c1b400.usb Dec 10 21:14:25 volumio-nanopi kernel: hub 6-0:1.0: USB hub found Dec 10 21:14:25 volumio-nanopi kernel: hub 6-0:1.0: 1 port detected Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1c400.usb: Generic Platform OHCI controller Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1c400.usb: new USB bus registered, assigned bus number 7 Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1c400.usb: irq 40, io mem 0x01c1c400 Dec 10 21:14:25 volumio-nanopi kernel: usb usb7: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Dec 10 21:14:25 volumio-nanopi kernel: usb usb7: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 10 21:14:25 volumio-nanopi kernel: usb usb7: Product: Generic Platform OHCI controller Dec 10 21:14:25 volumio-nanopi kernel: usb usb7: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Dec 10 21:14:25 volumio-nanopi kernel: usb usb7: SerialNumber: 1c1c400.usb Dec 10 21:14:25 volumio-nanopi kernel: hub 7-0:1.0: USB hub found Dec 10 21:14:25 volumio-nanopi kernel: hub 7-0:1.0: 1 port detected Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1d400.usb: Generic Platform OHCI controller Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1d400.usb: new USB bus registered, assigned bus number 8 Dec 10 21:14:25 volumio-nanopi kernel: ohci-platform 1c1d400.usb: irq 42, io mem 0x01c1d400 Dec 10 21:14:25 volumio-nanopi kernel: usb usb8: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Dec 10 21:14:25 volumio-nanopi kernel: usb usb8: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 10 21:14:25 volumio-nanopi kernel: usb usb8: Product: Generic Platform OHCI controller Dec 10 21:14:25 volumio-nanopi kernel: usb usb8: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Dec 10 21:14:25 volumio-nanopi kernel: usb usb8: SerialNumber: 1c1d400.usb Dec 10 21:14:25 volumio-nanopi kernel: hub 8-0:1.0: USB hub found Dec 10 21:14:25 volumio-nanopi kernel: hub 8-0:1.0: 1 port detected Dec 10 21:14:25 volumio-nanopi kernel: of_cfs_init Dec 10 21:14:25 volumio-nanopi kernel: of_cfs_init: OK Dec 10 21:14:25 volumio-nanopi kernel: ALSA device list: Dec 10 21:14:25 volumio-nanopi kernel: #0: H3 Audio Codec Dec 10 21:14:25 volumio-nanopi kernel: Freeing unused kernel image (initmem) memory: 1024K Dec 10 21:14:25 volumio-nanopi kernel: Run /init as init process Dec 10 21:14:25 volumio-nanopi kernel: with arguments: Dec 10 21:14:25 volumio-nanopi kernel: /init Dec 10 21:14:25 volumio-nanopi kernel: splash Dec 10 21:14:25 volumio-nanopi kernel: with environment: Dec 10 21:14:25 volumio-nanopi kernel: HOME=/ Dec 10 21:14:25 volumio-nanopi kernel: TERM=linux Dec 10 21:14:25 volumio-nanopi kernel: ubootpart=01101494-01 Dec 10 21:14:25 volumio-nanopi kernel: ubootsource=mmc Dec 10 21:14:25 volumio-nanopi kernel: imgpart=/dev/mmcblk0p2 Dec 10 21:14:25 volumio-nanopi kernel: imgfile=/volumio_current.sqsh Dec 10 21:14:25 volumio-nanopi kernel: hwver=orangepi Dec 10 21:14:25 volumio-nanopi kernel: sunxi_ve_mem_reserve=0 Dec 10 21:14:25 volumio-nanopi kernel: sunxi_g2d_mem_reserve=0 Dec 10 21:14:25 volumio-nanopi kernel: sunxi_fb_mem_reserve=16 Dec 10 21:14:25 volumio-nanopi kernel: cgroup_enable=memory Dec 10 21:14:25 volumio-nanopi kernel: input: r_gpio_keys as /devices/platform/r_gpio_keys/input/input0 Dec 10 21:14:25 volumio-nanopi kernel: usb_phy_generic usb_phy_generic.3.auto: supply vcc not found, using dummy regulator Dec 10 21:14:25 volumio-nanopi kernel: usb_phy_generic usb_phy_generic.3.auto: dummy supplies not allowed for exclusive requests Dec 10 21:14:25 volumio-nanopi kernel: musb-hdrc musb-hdrc.4.auto: MUSB HDRC host driver Dec 10 21:14:25 volumio-nanopi kernel: musb-hdrc musb-hdrc.4.auto: new USB bus registered, assigned bus number 9 Dec 10 21:14:25 volumio-nanopi kernel: usb usb9: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Dec 10 21:14:25 volumio-nanopi kernel: usb usb9: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 10 21:14:25 volumio-nanopi kernel: usb usb9: Product: MUSB HDRC host driver Dec 10 21:14:25 volumio-nanopi kernel: usb usb9: Manufacturer: Linux 5.15.93-sunxi musb-hcd Dec 10 21:14:25 volumio-nanopi kernel: usb usb9: SerialNumber: musb-hdrc.4.auto Dec 10 21:14:25 volumio-nanopi kernel: hub 9-0:1.0: USB hub found Dec 10 21:14:25 volumio-nanopi kernel: hub 9-0:1.0: 1 port detected Dec 10 21:14:25 volumio-nanopi kernel: lima 1c40000.gpu: gp - mali400 version major 1 minor 1 Dec 10 21:14:25 volumio-nanopi kernel: lima 1c40000.gpu: pp0 - mali400 version major 1 minor 1 Dec 10 21:14:25 volumio-nanopi kernel: lima 1c40000.gpu: pp1 - mali400 version major 1 minor 1 Dec 10 21:14:25 volumio-nanopi kernel: lima 1c40000.gpu: l2 cache 64K, 4-way, 64byte cache line, 64bit external bus Dec 10 21:14:25 volumio-nanopi kernel: lima 1c40000.gpu: bus rate = 200000000 Dec 10 21:14:25 volumio-nanopi kernel: lima 1c40000.gpu: mod rate = 297000000 Dec 10 21:14:25 volumio-nanopi kernel: lima 1c40000.gpu: dev_pm_opp_set_regulators: no regulator (mali) found: -19 Dec 10 21:14:25 volumio-nanopi kernel: lima 1c40000.gpu: Failed to register cooling device Dec 10 21:14:25 volumio-nanopi kernel: [drm] Initialized lima 1.2.0 20200215 for 1c40000.gpu on minor 1 Dec 10 21:14:25 volumio-nanopi kernel: EXT4-fs (mmcblk0p2): recovery complete Dec 10 21:14:25 volumio-nanopi kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Dec 10 21:14:25 volumio-nanopi kernel: loop0: detected capacity change from 0 to 832312 Dec 10 21:14:25 volumio-nanopi kernel: EXT4-fs (mmcblk0p3): recovery complete Dec 10 21:14:25 volumio-nanopi kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Dec 10 21:14:25 volumio-nanopi kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038 (0x7fffffff) Dec 10 21:14:25 volumio-nanopi systemd[1]: Inserted module 'autofs4' Dec 10 21:14:25 volumio-nanopi 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) Dec 10 21:14:25 volumio-nanopi systemd[1]: Detected architecture arm. Dec 10 21:14:25 volumio-nanopi systemd[1]: Set hostname to . Dec 10 21:14:25 volumio-nanopi 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. Dec 10 21:14:25 volumio-nanopi kernel: random: systemd: uninitialized urandom read (16 bytes read) Dec 10 21:14:25 volumio-nanopi kernel: random: systemd: uninitialized urandom read (16 bytes read) Dec 10 21:14:25 volumio-nanopi kernel: random: systemd: uninitialized urandom read (16 bytes read) Dec 10 21:14:25 volumio-nanopi systemd[1]: Created slice system-systemd\x2dfsck.slice. Dec 10 21:14:25 volumio-nanopi systemd[1]: Started Forward Password Requests to Wall Directory Watch. Dec 10 21:14:25 volumio-nanopi systemd[1]: Reached target System Time Synchronized. Dec 10 21:14:25 volumio-nanopi systemd[1]: Listening on udev Control Socket. Dec 10 21:14:25 volumio-nanopi systemd[1]: Listening on Journal Socket (/dev/log). Dec 10 21:14:25 volumio-nanopi systemd[1]: Listening on Journal Socket. Dec 10 21:14:25 volumio-nanopi kernel: RPC: Registered named UNIX socket transport module. Dec 10 21:14:25 volumio-nanopi kernel: RPC: Registered udp transport module. Dec 10 21:14:25 volumio-nanopi kernel: RPC: Registered tcp transport module. Dec 10 21:14:25 volumio-nanopi kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Dec 10 21:14:25 volumio-nanopi kernel: random: systemd: uninitialized urandom read (16 bytes read) Dec 10 21:14:25 volumio-nanopi kernel: random: systemd: uninitialized urandom read (16 bytes read) Dec 10 21:14:25 volumio-nanopi kernel: random: systemd: uninitialized urandom read (16 bytes read) Dec 10 21:14:25 volumio-nanopi systemd-journald[434]: Journal started Dec 10 21:14:25 volumio-nanopi systemd-journald[434]: Runtime journal (/run/log/journal/b8e23c24fa1d772592f70e9d6664bf5c) is 3.7M, max 30.0M, 26.2M free. Dec 10 21:14:25 volumio-nanopi fake-hwclock[422]: Current system time: 2025-12-11 05:14:24 Dec 10 21:14:25 volumio-nanopi fake-hwclock[422]: fake-hwclock saved clock information is in the past: 2025-12-11 04:16:34 Dec 10 21:14:25 volumio-nanopi fake-hwclock[422]: To set system time to this saved clock anyway, use "force" Dec 10 21:14:25 volumio-nanopi systemd[1]: Mounted /var/spool/cups. Dec 10 21:14:25 volumio-nanopi systemd[1]: Mounted /var/log. Dec 10 21:14:25 volumio-nanopi systemd-udevd[453]: Network interface NamePolicy= disabled on kernel command line, ignoring. Dec 10 21:14:25 volumio-nanopi systemd[1]: Mounted /tmp. Dec 10 21:14:25 volumio-nanopi systemd[1]: Mounting /var/spool/cups/tmp... Dec 10 21:14:25 volumio-nanopi systemd[1]: Starting Flush Journal to Persistent Storage... Dec 10 21:14:25 volumio-nanopi systemd[1]: Mounted /var/spool/cups/tmp. Dec 10 21:14:25 volumio-nanopi systemd[1]: Started udev Kernel Device Manager. Dec 10 21:14:25 volumio-nanopi systemd-journald[434]: Runtime journal (/run/log/journal/b8e23c24fa1d772592f70e9d6664bf5c) is 3.7M, max 30.0M, 26.2M free. Dec 10 21:14:26 volumio-nanopi systemd[1]: Started Flush Journal to Persistent Storage. Dec 10 21:14:26 volumio-nanopi systemd[1]: Started udev Coldplug all Devices. Dec 10 21:14:26 volumio-nanopi systemd[1]: Starting Helper to synchronize boot up for ifupdown... Dec 10 21:14:26 volumio-nanopi kernel: random: systemd: uninitialized urandom read (16 bytes read) Dec 10 21:14:26 volumio-nanopi kernel: random: systemd-journal: uninitialized urandom read (16 bytes read) Dec 10 21:14:26 volumio-nanopi systemd[1]: Starting Show Plymouth Boot Screen... Dec 10 21:14:26 volumio-nanopi kernel: random: systemd-journal: uninitialized urandom read (16 bytes read) Dec 10 21:14:27 volumio-nanopi systemd[1]: plymouth-start.service: Succeeded. Dec 10 21:14:27 volumio-nanopi systemd[1]: Started Show Plymouth Boot Screen. Dec 10 21:14:27 volumio-nanopi kernel: random: systemd: uninitialized urandom read (16 bytes read) Dec 10 21:14:27 volumio-nanopi systemd-udevd[460]: Using default interface naming scheme 'v240'. Dec 10 21:14:27 volumio-nanopi kernel: sunxi_cedrus: module is from the staging directory, the quality is unknown, you have been warned. Dec 10 21:14:27 volumio-nanopi kernel: cedrus 1c0e000.video-codec: Device registered as /dev/video0 Dec 10 21:14:27 volumio-nanopi systemd-udevd[460]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Dec 10 21:14:27 volumio-nanopi systemd-udevd[460]: link_config: could not get ethtool features for eth0 Dec 10 21:14:27 volumio-nanopi systemd-udevd[460]: Could not set offload features of eth0: Device or resource busy Dec 10 21:14:28 volumio-nanopi kernel: Registered IR keymap rc-empty Dec 10 21:14:28 volumio-nanopi kernel: rc rc0: sunxi-ir as /devices/platform/soc/1f02000.ir/rc/rc0 Dec 10 21:14:28 volumio-nanopi kernel: rc rc0: lirc_dev: driver sunxi-ir registered at minor = 0, raw IR receiver, no transmitter Dec 10 21:14:28 volumio-nanopi kernel: input: sunxi-ir as /devices/platform/soc/1f02000.ir/rc/rc0/input1 Dec 10 21:14:28 volumio-nanopi kernel: sunxi-ir 1f02000.ir: initialized sunXi IR driver Dec 10 21:14:28 volumio-nanopi kernel: debugfs: File 'Capture' in directory 'dapm' already present! Dec 10 21:14:29 volumio-nanopi systemd-udevd[465]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Dec 10 21:14:29 volumio-nanopi systemd-udevd[461]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Dec 10 21:14:29 volumio-nanopi systemd-udevd[467]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Dec 10 21:14:30 volumio-nanopi systemd[1]: Found device /dev/mmcblk0p1. Dec 10 21:14:30 volumio-nanopi systemd[1]: Found device /dev/ttyS0. Dec 10 21:14:31 volumio-nanopi systemd[1]: Started Helper to synchronize boot up for ifupdown. Dec 10 21:14:31 volumio-nanopi systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Dec 10 21:14:31 volumio-nanopi systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Dec 10 21:14:31 volumio-nanopi systemd[1]: Starting Show Plymouth Boot Screen... Dec 10 21:14:31 volumio-nanopi systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Dec 10 21:14:31 volumio-nanopi systemd[1]: Condition check resulted in Huge Pages File System being skipped. Dec 10 21:14:31 volumio-nanopi systemd[1]: Starting File System Check on /dev/mmcblk0p1... Dec 10 21:14:31 volumio-nanopi systemd[1]: plymouth-start.service: Succeeded. Dec 10 21:14:31 volumio-nanopi systemd[1]: Started Show Plymouth Boot Screen. Dec 10 21:14:31 volumio-nanopi systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Dec 10 21:14:31 volumio-nanopi systemd[1]: Reached target Local Encrypted Volumes. Dec 10 21:14:31 volumio-nanopi systemd[1]: Reached target Paths. Dec 10 21:14:31 volumio-nanopi systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Dec 10 21:14:31 volumio-nanopi systemd[1]: Started File System Check Daemon to report status. Dec 10 21:14:31 volumio-nanopi systemd-fsck[666]: fsck.fat 4.1 (2017-01-24) Dec 10 21:14:31 volumio-nanopi systemd-fsck[666]: /dev/mmcblk0p1: 256 files, 65583/120958 clusters Dec 10 21:14:31 volumio-nanopi systemd[1]: Started File System Check on /dev/mmcblk0p1. Dec 10 21:14:32 volumio-nanopi systemd[1]: Mounting /boot... Dec 10 21:14:32 volumio-nanopi systemd[1]: Mounted /boot. Dec 10 21:14:32 volumio-nanopi systemd[1]: Reached target Local File Systems. Dec 10 21:14:32 volumio-nanopi systemd[1]: Started ifup for eth0. Dec 10 21:14:32 volumio-nanopi systemd[1]: Starting Create Volatile Files and Directories... Dec 10 21:14:32 volumio-nanopi systemd[1]: Starting Preprocess NFS configuration... Dec 10 21:14:32 volumio-nanopi systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Dec 10 21:14:32 volumio-nanopi systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Dec 10 21:14:32 volumio-nanopi systemd[1]: Starting Raise network interfaces... Dec 10 21:14:32 volumio-nanopi systemd[1]: Received SIGRTMIN+20 from PID 326 (plymouthd). Dec 10 21:14:32 volumio-nanopi systemd[1]: plymouth-read-write.service: Succeeded. Dec 10 21:14:32 volumio-nanopi systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Dec 10 21:14:32 volumio-nanopi systemd[1]: nfs-config.service: Succeeded. Dec 10 21:14:32 volumio-nanopi systemd[1]: Started Preprocess NFS configuration. Dec 10 21:14:32 volumio-nanopi systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Dec 10 21:14:32 volumio-nanopi systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Dec 10 21:14:32 volumio-nanopi systemd[1]: Reached target NFS client services. Dec 10 21:14:32 volumio-nanopi systemd[1]: Started Create Volatile Files and Directories. Dec 10 21:14:32 volumio-nanopi systemd[1]: Starting RPC bind portmap service... Dec 10 21:14:32 volumio-nanopi systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Dec 10 21:14:32 volumio-nanopi systemd[1]: Starting Update UTMP about System Boot/Shutdown... Dec 10 21:14:32 volumio-nanopi systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Dec 10 21:14:32 volumio-nanopi systemd[1]: Started RPC bind portmap service. Dec 10 21:14:32 volumio-nanopi systemd[1]: Reached target RPC Port Mapper. Dec 10 21:14:32 volumio-nanopi systemd[1]: Reached target Remote File Systems (Pre). Dec 10 21:14:32 volumio-nanopi systemd[1]: Reached target Remote File Systems. Dec 10 21:14:32 volumio-nanopi systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Dec 10 21:14:32 volumio-nanopi systemd[1]: Started Update UTMP about System Boot/Shutdown. Dec 10 21:14:32 volumio-nanopi systemd[1]: Reached target System Initialization. Dec 10 21:14:32 volumio-nanopi systemd[1]: Listening on triggerhappy.socket. Dec 10 21:14:32 volumio-nanopi systemd[1]: Listening on D-Bus System Message Bus Socket. Dec 10 21:14:32 volumio-nanopi systemd[1]: Started Daily Cleanup of Temporary Directories. Dec 10 21:14:32 volumio-nanopi systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Dec 10 21:14:32 volumio-nanopi systemd[1]: Reached target Sockets. Dec 10 21:14:32 volumio-nanopi systemd[1]: Reached target Basic System. Dec 10 21:14:32 volumio-nanopi systemd[1]: Starting Volumio Time Update Utility... Dec 10 21:14:32 volumio-nanopi systemd[1]: Starting Wireless Services... Dec 10 21:14:32 volumio-nanopi systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Dec 10 21:14:32 volumio-nanopi systemd[1]: Started Volumio Log Rotation Service. Dec 10 21:14:32 volumio-nanopi systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Dec 10 21:14:32 volumio-nanopi kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Dec 10 21:14:32 volumio-nanopi systemd[1]: Starting DHCP Client Daemon... Dec 10 21:14:33 volumio-nanopi kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Dec 10 21:14:33 volumio-nanopi kernel: platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 Dec 10 21:14:33 volumio-nanopi kernel: platform regulatory.0: Falling back to sysfs fallback for: regulatory.db Dec 10 21:14:33 volumio-nanopi kernel: cfg80211: failed to load regulatory.db Dec 10 21:14:33 volumio-nanopi systemd[1]: Starting triggerhappy global hotkey daemon... Dec 10 21:14:33 volumio-nanopi volumio-time-update[698]: volumio-time-update-util: Fetching time from Volumio... Dec 10 21:14:33 volumio-nanopi systemd[1]: Starting Login Service... Dec 10 21:14:33 volumio-nanopi systemd[1]: Started Manage Sound Card State (restore and store). Dec 10 21:14:33 volumio-nanopi systemd[1]: Starting Save/Restore Sound Card State... Dec 10 21:14:33 volumio-nanopi systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Dec 10 21:14:33 volumio-nanopi alsactl[716]: alsactl 1.1.8 daemon started Dec 10 21:14:33 volumio-nanopi systemd[1]: Started Volumio Iptables Module. Dec 10 21:14:33 volumio-nanopi ifup[680]: command failed: No such device (-19) Dec 10 21:14:33 volumio-nanopi sh[673]: command failed: No such device (-19) Dec 10 21:14:33 volumio-nanopi systemd[1]: Started UPnP Renderer front-end to MPD. Dec 10 21:14:33 volumio-nanopi systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Dec 10 21:14:33 volumio-nanopi thd[705]: Unable to parse trigger line: Dec 10 21:14:33 volumio-nanopi thd[705]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Dec 10 21:14:33 volumio-nanopi thd[705]: Unable to parse trigger line: Dec 10 21:14:33 volumio-nanopi thd[705]: Found socket passed from systemd Dec 10 21:14:33 volumio-nanopi systemd[1]: Started volumio-remote-updater.service. Dec 10 21:14:33 volumio-nanopi systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Dec 10 21:14:33 volumio-nanopi systemd[1]: Started Daily apt download activities. Dec 10 21:14:33 volumio-nanopi systemd[1]: Started Daily apt upgrade and clean activities. Dec 10 21:14:33 volumio-nanopi systemd[1]: Reached target Timers. Dec 10 21:14:33 volumio-nanopi systemd[1]: Started D-Bus System Message Bus. Dec 10 21:14:33 volumio-nanopi systemd[1]: Starting WPA supplicant... Dec 10 21:14:33 volumio-nanopi systemd[1]: Started triggerhappy global hotkey daemon. Dec 10 21:14:33 volumio-nanopi systemd[1]: Started Save/Restore Sound Card State. Dec 10 21:14:33 volumio-nanopi systemd[1]: Reached target Sound Card. Dec 10 21:14:34 volumio-nanopi sh[673]: sending commands to master dhcpcd process Dec 10 21:14:34 volumio-nanopi dhcpcd[760]: sending commands to master dhcpcd process Dec 10 21:14:34 volumio-nanopi ifup[680]: command failed: No such device (-19) Dec 10 21:14:34 volumio-nanopi avahi-daemon[731]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Dec 10 21:14:35 volumio-nanopi avahi-daemon[731]: Successfully dropped root privileges. Dec 10 21:14:35 volumio-nanopi avahi-daemon[731]: avahi-daemon 0.7 starting up. Dec 10 21:14:35 volumio-nanopi systemd-logind[713]: New seat seat0. Dec 10 21:14:35 volumio-nanopi systemd-logind[713]: Watching system buttons on /dev/input/event0 (r_gpio_keys) Dec 10 21:14:35 volumio-nanopi dhcpcd[702]: no interfaces have a carrier Dec 10 21:14:35 volumio-nanopi dhcpcd[702]: no interfaces have a carrier Dec 10 21:14:35 volumio-nanopi dhcpcd[702]: forked to background, child pid 801 Dec 10 21:14:35 volumio-nanopi dhcpcd[702]: forked to background, child pid 801 Dec 10 21:14:35 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet eth0: PHY [0.1:01] driver [Generic PHY] (irq=POLL) Dec 10 21:14:35 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet eth0: Register MEM_TYPE_PAGE_POOL RxQ-0 Dec 10 21:14:35 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet eth0: No Safety Features support found Dec 10 21:14:35 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet eth0: No MAC Management Counters available Dec 10 21:14:35 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet eth0: PTP not supported by HW Dec 10 21:14:35 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet eth0: configuring for phy/mii link mode Dec 10 21:14:35 volumio-nanopi kernel: dwmac-sun8i 1c30000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx Dec 10 21:14:35 volumio-nanopi dhcpcd[801]: eth0: waiting for carrier Dec 10 21:14:35 volumio-nanopi dhcpcd[801]: eth0: carrier acquired Dec 10 21:14:35 volumio-nanopi dhcpcd[801]: DUID 00:01:00:01:2d:f7:7c:63:02:81:12:34:3a:73 Dec 10 21:14:35 volumio-nanopi dhcpcd[801]: eth0: IAID 12:34:3a:73 Dec 10 21:14:35 volumio-nanopi dhcpcd[801]: eth0: adding address fe80::81:12ff:fe34:3a73 Dec 10 21:14:35 volumio-nanopi dhcpcd[801]: ipv6_addaddr1: Permission denied Dec 10 21:14:35 volumio-nanopi dhcpcd[801]: control command: /sbin/dhcpcd eth0 Dec 10 21:14:35 volumio-nanopi dhcpcd[801]: eth0: carrier lost Dec 10 21:14:35 volumio-nanopi dhcpcd[801]: eth0: carrier acquired Dec 10 21:14:35 volumio-nanopi dhcpcd[801]: eth0: IAID 12:34:3a:73 Dec 10 21:14:36 volumio-nanopi dhcpcd[801]: eth0: rebinding lease of 192.168.254.100 Dec 10 21:14:36 volumio-nanopi dhcpcd[801]: eth0: soliciting an IPv6 router Dec 10 21:14:36 volumio-nanopi dhcpcd[801]: eth0: probing address 192.168.254.100/24 Dec 10 21:14:36 volumio-nanopi systemd[1]: Started DHCP Client Daemon. Dec 10 21:14:36 volumio-nanopi avahi-daemon[731]: Successfully called chroot(). Dec 10 21:14:36 volumio-nanopi avahi-daemon[731]: Successfully dropped remaining capabilities. Dec 10 21:14:37 volumio-nanopi avahi-daemon[731]: Loading service file /services/volumio.service. Dec 10 21:14:37 volumio-nanopi avahi-daemon[731]: Network interface enumeration completed. Dec 10 21:14:37 volumio-nanopi haveged[697]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K Dec 10 21:14:37 volumio-nanopi haveged[697]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848 Dec 10 21:14:37 volumio-nanopi haveged[697]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.0018 Dec 10 21:14:37 volumio-nanopi haveged[697]: haveged: fills: 0, generated: 0 Dec 10 21:14:37 volumio-nanopi avahi-daemon[731]: Server startup complete. Host name is volumio-nanopi.local. Local service cookie is 2164015726. Dec 10 21:14:37 volumio-nanopi avahi-daemon[731]: Service "Volumio-NanoPi" (/services/volumio.service) successfully established. Dec 10 21:14:37 volumio-nanopi systemd-udevd[461]: Process '/sbin/crda' failed with exit code 249. Dec 10 21:14:37 volumio-nanopi systemd[1]: Started Login Service. Dec 10 21:14:37 volumio-nanopi systemd[1]: Started Avahi mDNS/DNS-SD Stack. Dec 10 21:14:37 volumio-nanopi sh[673]: eth0=eth0 Dec 10 21:14:37 volumio-nanopi ifup[680]: command failed: No such device (-19) Dec 10 21:14:38 volumio-nanopi loadcpufreq[727]: Loading cpufreq kernel modules...done (none). Dec 10 21:14:38 volumio-nanopi systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Dec 10 21:14:38 volumio-nanopi systemd[1]: Starting LSB: set CPUFreq kernel parameters... Dec 10 21:14:38 volumio-nanopi systemd[1]: Started WPA supplicant. Dec 10 21:14:38 volumio-nanopi wpa_supplicant[742]: Successfully initialized wpa_supplicant Dec 10 21:14:39 volumio-nanopi systemd[1]: iptables.service: Succeeded. Dec 10 21:14:39 volumio-nanopi cpufrequtils[893]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Dec 10 21:14:39 volumio-nanopi systemd[1]: Started LSB: set CPUFreq kernel parameters. Dec 10 21:14:39 volumio-nanopi systemd[1]: Started Raise network interfaces. Dec 10 21:14:39 volumio-nanopi systemd[1]: Reached target Network. Dec 10 21:14:39 volumio-nanopi volumio-remote-updater[728]: Error: No active session Dec 10 21:14:39 volumio-nanopi systemd[1]: Starting Network Time Service... Dec 10 21:14:39 volumio-nanopi volumio-remote-updater[728]: [2025-12-10 21:14:39] [info] asio async_connect error: system:111 (Connection refused) Dec 10 21:14:39 volumio-nanopi volumio-remote-updater[728]: [2025-12-10 21:14:39] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 10 21:14:39 volumio-nanopi volumio-remote-updater[728]: [2025-12-10 21:14:39] [error] handle_connect error: Underlying Transport Error Dec 10 21:14:39 volumio-nanopi systemd[1]: Starting Permit User Sessions... Dec 10 21:14:39 volumio-nanopi systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Dec 10 21:14:39 volumio-nanopi systemd[1]: Reached target Network is Online. Dec 10 21:14:39 volumio-nanopi systemd[1]: Starting LSB: Brings up/down network automatically... Dec 10 21:14:39 volumio-nanopi systemd[1]: Starting /etc/rc.local Compatibility... Dec 10 21:14:39 volumio-nanopi volumio-time-update[698]: volumio-time-update-util: Date not found in response Dec 10 21:14:39 volumio-nanopi volumio-time-update[698]: volumio-time-update-util: Retrying in 5 seconds... Dec 10 21:14:39 volumio-nanopi systemd[1]: Starting Samba NMB Daemon... Dec 10 21:14:39 volumio-nanopi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 10 21:14:40 volumio-nanopi systemd[1]: Started /etc/rc.local Compatibility. Dec 10 21:14:40 volumio-nanopi systemd[1]: Started Permit User Sessions. Dec 10 21:14:40 volumio-nanopi systemd[1]: Starting Terminate Plymouth Boot Screen... Dec 10 21:14:40 volumio-nanopi systemd[1]: Starting Hold until boot process finishes up... Dec 10 21:14:40 volumio-nanopi systemd[1]: plymouth-quit.service: Succeeded. Dec 10 21:14:40 volumio-nanopi systemd[1]: Started Terminate Plymouth Boot Screen. Dec 10 21:14:40 volumio-nanopi systemd[1]: plymouth-quit-wait.service: Succeeded. Dec 10 21:14:40 volumio-nanopi systemd[1]: Started Hold until boot process finishes up. Dec 10 21:14:40 volumio-nanopi systemd[1]: Received SIGRTMIN+21 from PID 326 (n/a). Dec 10 21:14:40 volumio-nanopi systemd[1]: Received SIGRTMIN+21 from PID 326 (n/a). Dec 10 21:14:40 volumio-nanopi systemd[1]: Started Getty on tty1. Dec 10 21:14:40 volumio-nanopi systemd[1]: Started Serial Getty on ttyS0. Dec 10 21:14:40 volumio-nanopi systemd[1]: Reached target Login Prompts. Dec 10 21:14:40 volumio-nanopi ifplugd(eth0)[968]: ifplugd 0.28 initializing. Dec 10 21:14:40 volumio-nanopi ifplugd(eth0)[968]: Using interface eth0/02:81:12:34:3A:73 with driver (version: Jan_2016) Dec 10 21:14:40 volumio-nanopi ifplugd(eth0)[968]: Using detection mode: SIOCETHTOOL Dec 10 21:14:40 volumio-nanopi ifplugd(eth0)[968]: Initialization complete, link beat detected. Dec 10 21:14:40 volumio-nanopi ifplugd(eth0)[968]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Dec 10 21:14:40 volumio-nanopi ntpd[940]: ntpd 4.2.8p12@1.3728-o (1): Starting Dec 10 21:14:40 volumio-nanopi ntpd[940]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Dec 10 21:14:40 volumio-nanopi systemd[1]: Started Network Time Service. Dec 10 21:14:41 volumio-nanopi ifplugd(eth0)[968]: client: ifup: interface eth0 already configured Dec 10 21:14:41 volumio-nanopi ifplugd(eth0)[968]: Program executed successfully. Dec 10 21:14:41 volumio-nanopi ifplugd[942]: Network Interface Plugging Daemon...start eth0...done. Dec 10 21:14:41 volumio-nanopi systemd[1]: Started LSB: Brings up/down network automatically. Dec 10 21:14:41 volumio-nanopi ntpd[972]: proto: precision = 2.417 usec (-19) Dec 10 21:14:41 volumio-nanopi ntpd[972]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Dec 10 21:14:41 volumio-nanopi ntpd[972]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Dec 10 21:14:41 volumio-nanopi ntpd[972]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1080 days ago Dec 10 21:14:41 volumio-nanopi ntpd[972]: Listen and drop on 0 v6wildcard [::]:123 Dec 10 21:14:41 volumio-nanopi ntpd[972]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Dec 10 21:14:41 volumio-nanopi ntpd[972]: Listen normally on 2 lo 127.0.0.1:123 Dec 10 21:14:41 volumio-nanopi ntpd[972]: Listening on routing socket on fd #19 for interface updates Dec 10 21:14:41 volumio-nanopi ntpd[972]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 10 21:14:41 volumio-nanopi ntpd[972]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 10 21:14:41 volumio-nanopi volumio[724]: Could not open config: /tmp/upmpdcli.conf Dec 10 21:14:41 volumio-nanopi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 10 21:14:41 volumio-nanopi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 10 21:14:42 volumio-nanopi dhcpcd[801]: eth0: leased 192.168.254.100 for 14400 seconds Dec 10 21:14:42 volumio-nanopi dhcpcd[801]: eth0: adding route to 192.168.254.0/24 Dec 10 21:14:42 volumio-nanopi dhcpcd[801]: eth0: adding default route via 192.168.254.254 Dec 10 21:14:42 volumio-nanopi avahi-daemon[731]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.254.100. Dec 10 21:14:42 volumio-nanopi avahi-daemon[731]: New relevant interface eth0.IPv4 for mDNS. Dec 10 21:14:42 volumio-nanopi avahi-daemon[731]: Registering new address record for 192.168.254.100 on eth0.IPv4. Dec 10 21:14:42 volumio-nanopi ntpd[972]: Soliciting pool server 172.234.37.140 Dec 10 21:14:43 volumio-nanopi ntpd[972]: Listen normally on 3 eth0 192.168.254.100:123 Dec 10 21:14:43 volumio-nanopi ntpd[972]: new interface(s) found: waking up resolver Dec 10 21:14:43 volumio-nanopi ntpd[972]: Soliciting pool server 172.233.189.68 Dec 10 21:14:43 volumio-nanopi kernel: random: crng init done Dec 10 21:14:43 volumio-nanopi kernel: random: 243 urandom warning(s) missed due to ratelimiting Dec 10 21:14:43 volumio-nanopi ntpd[972]: ntpd exiting on signal 15 (Terminated) Dec 10 21:14:43 volumio-nanopi ntpd[972]: 172.233.189.68 local addr 192.168.254.100 -> Dec 10 21:14:43 volumio-nanopi systemd[1]: Stopping Network Time Service... Dec 10 21:14:43 volumio-nanopi systemd[1]: ntp.service: Succeeded. Dec 10 21:14:43 volumio-nanopi systemd[1]: Stopped Network Time Service. Dec 10 21:14:43 volumio-nanopi systemd[1]: Starting Network Time Service... Dec 10 21:14:43 volumio-nanopi ntpd[1015]: ntpd 4.2.8p12@1.3728-o (1): Starting Dec 10 21:14:43 volumio-nanopi ntpd[1015]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 104:103 Dec 10 21:14:43 volumio-nanopi systemd[1]: Started Network Time Service. Dec 10 21:14:43 volumio-nanopi ntpd[1021]: proto: precision = 2.583 usec (-18) Dec 10 21:14:43 volumio-nanopi ntpd[1021]: Listen and drop on 0 v6wildcard [::]:123 Dec 10 21:14:43 volumio-nanopi ntpd[1021]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Dec 10 21:14:43 volumio-nanopi ntpd[1021]: Listen normally on 2 lo 127.0.0.1:123 Dec 10 21:14:43 volumio-nanopi ntpd[1021]: Listen normally on 3 eth0 192.168.254.100:123 Dec 10 21:14:43 volumio-nanopi ntpd[1021]: Listening on routing socket on fd #20 for interface updates Dec 10 21:14:43 volumio-nanopi ntpd[1021]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 10 21:14:43 volumio-nanopi ntpd[1021]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 10 21:14:44 volumio-nanopi volumio-remote-updater[728]: [2025-12-10 21:14:44] [info] asio async_connect error: system:111 (Connection refused) Dec 10 21:14:44 volumio-nanopi volumio-remote-updater[728]: [2025-12-10 21:14:44] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 10 21:14:44 volumio-nanopi volumio-remote-updater[728]: [2025-12-10 21:14:44] [error] handle_connect error: Underlying Transport Error Dec 10 21:14:44 volumio-nanopi kernel: vcc3v0: disabling Dec 10 21:14:44 volumio-nanopi kernel: vcc5v0: disabling Dec 10 21:14:44 volumio-nanopi volumio-time-update[698]: volumio-time-update-util: Fetching time from Volumio... Dec 10 21:14:45 volumio-nanopi volumio-time-update[698]: volumio-time-update-util: Setting system time to: 2025-12-10 20:17:17 Dec 10 21:14:45 volumio-nanopi nmbd[953]: [2025/12/10 21:14:45.596950, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Dec 10 21:14:45 volumio-nanopi nmbd[953]: started asyncdns process 1034 Dec 10 21:14:45 volumio-nanopi nmbd[953]: [2025/12/10 21:14:45.631800, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 10 21:14:45 volumio-nanopi systemd[1]: Started Samba NMB Daemon. Dec 10 21:14:45 volumio-nanopi nmbd[953]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Dec 10 21:14:45 volumio-nanopi systemd[1]: Starting Samba Winbind Daemon... Dec 10 21:14:46 volumio-nanopi sudo[1033]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-12-10 20:17:17 Dec 10 21:14:46 volumio-nanopi sudo[1033]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 21:14:46 volumio-nanopi dbus-daemon[737]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.5' (uid=0 pid=1037 comm="timedatectl set-time 2025-12-10 20:17:17 ") Dec 10 21:14:46 volumio-nanopi systemd[1]: Starting Time & Date Service... Dec 10 21:14:47 volumio-nanopi dbus-daemon[737]: [system] Successfully activated service 'org.freedesktop.timedate1' Dec 10 21:14:47 volumio-nanopi systemd[1]: Started Time & Date Service. Dec 10 20:48:17 volumio-nanopi volumio[1061]: verbose: New Socket.io Connection to 192.168.254.100:3000 from 192.168.254.114 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Dec 10 20:48:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 20:48:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 20:48:18 volumio-nanopi volumio[1061]: info: Discovery: Getting this device information Dec 10 20:48:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetState Dec 10 20:48:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 10 20:48:18 volumio-nanopi volumio[1061]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Dec 10 20:48:18 volumio-nanopi volumio[1061]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 10 20:48:18 volumio-nanopi volumio[1061]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Dec 10 20:48:19 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetState Dec 10 20:48:23 volumio-nanopi volumio[1061]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.114 UA: Mozilla/5.0 (Linux; Android 14; T614D Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.171 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 10 20:48:23 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 10 20:48:23 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetVisibleSources Dec 10 20:48:23 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 20:48:23 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetState Dec 10 20:48:23 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 10 20:48:23 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 10 20:48:23 volumio-nanopi volumio[1061]: info: Received Get System Info Dec 10 20:48:23 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 20:48:23 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 20:48:24 volumio-nanopi volumio[1061]: info: Discovery: Getting this device information Dec 10 20:48:24 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetState Dec 10 20:48:24 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 10 20:48:24 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetState Dec 10 20:48:24 volumio-nanopi volumio[1061]: info: Listing playlists Dec 10 20:48:24 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetQueue Dec 10 20:48:24 volumio-nanopi volumio[1061]: info: CoreStateMachine::getQueue Dec 10 20:48:24 volumio-nanopi volumio[1061]: info: CorePlayQueue::getQueue Dec 10 20:48:24 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:29 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:48:58 volumio-nanopi volumio[1061]: info: CorePlayQueue::getQueue Dec 10 20:48:58 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:48:58 volumio-nanopi volumio[1061]: info: [1765428538524] ControllerPandora::ExpireOldTracks::reaper Dec 10 20:48:58 volumio-nanopi volumio[1061]: info: [1765428538527] [Pandora] ExpireOldTracks::reaper: No victims found: Expiring zero tracks. Don't worry -- Jason will return. Dec 10 20:49:05 volumio-nanopi volumio[1061]: verbose: New Socket.io Connection to 192.168.254.100:3000 from 192.168.254.114 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Dec 10 20:49:05 volumio-nanopi volumio[1061]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Dec 10 20:49:05 volumio-nanopi volumio[1061]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 10 20:49:05 volumio-nanopi volumio[1061]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Dec 10 20:49:06 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:06 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 1 Dec 10 20:49:06 volumio-nanopi volumio[1061]: info: Prefetching next song Dec 10 20:49:06 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 20:49:06 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 20:49:06 volumio-nanopi volumio[1061]: info: Discovery: Getting this device information Dec 10 20:49:06 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetState Dec 10 20:49:06 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 10 20:49:06 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: [1765428554174] ControllerPandora::pandoraListener Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Dec 10 20:49:14 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Dec 10 20:49:14 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 35 milliseconds Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 19 milliseconds Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 11 milliseconds Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: [1765428554235] ControllerPandora::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null,"trackType":"mp3"} Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: CURRENT POSITION 0 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::syncState stateService stop Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::syncState currentStatus play Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::play index undefined Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 1 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::setConsumeUpdateService pandora Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 1 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 1 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 1 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::startPlaybackTimer Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 1 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: [1765428554449] ControllerPandora::clearAddPlayTrack Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ControllerMpd::clear Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand clear Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ------------------------------ 274ms Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ------------------------------ 256ms Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Dec 10 20:49:14 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Dec 10 20:49:14 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Dec 10 20:49:14 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Dec 10 20:49:14 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:14 volumio-nanopi volumio[1061]: error: updateQueue error: null Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: sendMpdCommand clear took 99 milliseconds Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 42 milliseconds Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 36 milliseconds Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ------------------------------ 21ms Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:14 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: [1765428554567] ControllerPandora::checkForExpiredStations Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: [1765428554568] [Pandora] checkForExpiredStations: Stations expired Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: [1765428554571] ControllerPandora::PandoraHandler::fillStationData Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 1 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 1 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ------------------------------ 223ms Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: ------------------------------ 220ms Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Dec 10 20:49:14 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Dec 10 20:49:14 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:14 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:15 volumio-nanopi volumio[1061]: error: updateQueue error: null Dec 10 20:49:15 volumio-nanopi volumio[1061]: error: updateQueue error: null Dec 10 20:49:15 volumio-nanopi volumio[1061]: error: updateQueue error: null Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: ------------------------------ 513ms Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: ------------------------------ 320ms Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: ------------------------------ 316ms Dec 10 20:49:15 volumio-nanopi volumio[1061]: verbose: New Socket.io Connection to 192.168.254.100 from 192.168.254.114 UA: Mozilla/5.0 (Linux; Android 14; T614D Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.171 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: camilladsp spawned new process with pid 5505, instance 1, run: true Dec 10 20:49:15 volumio-nanopi volumio[1061]: error: FusionDsp - WebSocket error: [object Object] Dec 10 20:49:15 volumio-nanopi volumio[1061]: error: FusionDsp - WebSocket error: [object Object] Dec 10 20:49:15 volumio-nanopi volumio[1061]: error: FusionDsp - WebSocket error: [object Object] Dec 10 20:49:15 volumio-nanopi volumio[1061]: error: FusionDsp - WebSocket error: [object Object] Dec 10 20:49:15 volumio-nanopi volumio[1061]: error: FusionDsp - WebSocket error: [object Object] Dec 10 20:49:15 volumio-nanopi volumio[1061]: error: FusionDsp - WebSocket error: [object Object] Dec 10 20:49:15 volumio-nanopi volumio[1061]: error: FusionDsp - WebSocket error: [object Object] Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetVisibleSources Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetState Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: Received Get System Info Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: Discovery: Getting this device information Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetState Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetState Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: Listing playlists Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetQueue Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreStateMachine::getQueue Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CorePlayQueue::getQueue Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CorePlayQueue::getQueue Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: [1765428555859] ControllerPandora::removeTrack Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreStateMachine::removeQueueItem Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CorePlayQueue::removeQueueItem 0 Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CorePlayQueue::saveQueue Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushQueue Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: [1765428555898] [Pandora] removeTrack: Removed track with uri: /pandora/stationToken=113294779785159402trackId=7753080632694049574 at queue index: 0 Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:15 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: [1765428555935] ControllerPandora::appendTracksToMpd Dec 10 20:49:15 volumio-nanopi volumio[1061]: info: [1765428555939] [Pandora] appendTracksToMpd: Added 1 track(s) to mpd Dec 10 20:49:15 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand addid Dec 10 20:49:15 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand play Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Dec 10 20:49:16 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 240 milliseconds Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: sendMpdCommand addid took 197 milliseconds Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: sendMpdCommand play took 196 milliseconds Dec 10 20:49:16 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: [1765428556155] ControllerPandora::pushState Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:16 volumio-nanopi volumio[1061]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null,"trackType":"mp3"} Dec 10 20:49:16 volumio-nanopi volumio[1061]: verbose: CURRENT POSITION 0 Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreStateMachine::syncState stateService stop Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreStateMachine::syncState currentStatus stop Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: No code Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreStateMachine::setConsumeUpdateService pandora Dec 10 20:49:16 volumio-nanopi volumio[1061]: verbose: MPD COMMAND [object Object] Dec 10 20:49:16 volumio-nanopi volumio[1061]: verbose: MPD COMMAND [object Object] Dec 10 20:49:16 volumio-nanopi volumio[1061]: verbose: MPD COMMAND [object Object] Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: [1765428556227] ControllerPandora::pushState Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:16 volumio-nanopi volumio[1061]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"Gnosis","name":"Gnosis","artist":"Russian Circles","album":"Gnosis","albumart":"http://mediaserver-cont-usc-mp1-1-v4v6.pandora.com/images/7f/b2/46/80/829f469abfcb8d1c906e5846/1080W_1080H.jpg","realUri":"http://t2-2.p-cdn.us/access/4140235201445085986.mp3?version=5&lid=1075995428&token=Y4GiHMaeKxC8YbhsDbzcrr3Bs%2BAWMLUqxpO6L4saw%2FB%2FB9pxZaNzPW0NdKydNA026AdCF2I9G%2BTSIm3cmGfVsnNMygh%2FNrd606zDBftVLE7edZmWsqbh%2BfOfRtV2o94uYYeFp6ADa2N5wpeQKO1Qt9z97oskI%2FXV2%2BGuulv%2FzM%2FPVWmLJjbmV%2B7RNEUTXSnnD9RhbaxKkQW5xcBPpW0df1W8hnNyNkZXOtPDOks9IkO%2BVgoX3gTpGaQK4oEgeGgdhjS5N5ZPy6iIcPzp8Ao3AnhSgfBpOTpxL1reERcyNBg69Ze%2F8F9f27qsuEUBR%2B3glredayCh%2B3VR31vqkbEhPg%3D%3D","isStreaming":true,"duration":468,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t2-2.p-cdn.us/access/4140235201445085986.mp3?version=5&lid=1075995428&token=Y4GiHMaeKxC8YbhsDbzcrr3Bs%2BAWMLUqxpO6L4saw%2FB%2FB9pxZaNzPW0NdKydNA026AdCF2I9G%2BTSIm3cmGfVsnNMygh%2FNrd606zDBftVLE7edZmWsqbh%2BfOfRtV2o94uYYeFp6ADa2N5wpeQKO1Qt9z97oskI%2FXV2%2BGuulv%2FzM%2FPVWmLJjbmV%2B7RNEUTXSnnD9RhbaxKkQW5xcBPpW0df1W8hnNyNkZXOtPDOks9IkO%2BVgoX3gTpGaQK4oEgeGgdhjS5N5ZPy6iIcPzp8Ao3AnhSgfBpOTpxL1reERcyNBg69Ze%2F8F9f27qsuEUBR%2B3glredayCh%2B3VR31vqkbEhPg%3D%3D","seek":0,"status":"play"} Dec 10 20:49:16 volumio-nanopi volumio[1061]: verbose: CURRENT POSITION 0 Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreStateMachine::syncState stateService play Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreStateMachine::syncState currentStatus stop Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreStateMachine::setConsumeUpdateService pandora Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: [1765428556296] ControllerPandora::fetchAndAddTracks Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: [1765428556299] ControllerPandora::getStationTracks Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CorePlayQueue::getQueue Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: [1765428556306] [Pandora] PandoraHandler::getSongMaxDiff: -4 Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: [1765428556310] ControllerPandora::fetchAndAddTracks::getSqInfo Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: [1765428556312] ControllerPandora::getStationTracks Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CorePlayQueue::getQueue Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CorePlayQueue::getQueue Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: [1765428556320] [Pandora] fetchAndAddTracks: diff1: -4 sQPos1: 0 Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: [1765428556321] [Pandora] fetchAndAddTracks: Fetching tracks Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: [1765428556325] ControllerPandora::PandoraHandler::fillStationData Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Dec 10 20:49:16 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Dec 10 20:49:16 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Dec 10 20:49:16 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Dec 10 20:49:16 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: ------------------------------ 334ms Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: ------------------------------ 136ms Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: ------------------------------ 131ms Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: ------------------------------ 127ms Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Dec 10 20:49:16 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Dec 10 20:49:16 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Dec 10 20:49:16 volumio-nanopi volumio[1061]: ---------------------------- MPD announces system playlist update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: Ignoring MPD Status Update Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: ------------------------------ 360ms Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: ------------------------------ 349ms Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: ------------------------------ 345ms Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: ------------------------------ 341ms Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 10 20:49:16 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: [1765428558018] ControllerPandora::pandoraListener Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: Dec 10 20:49:18 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: Dec 10 20:49:18 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: Dec 10 20:49:18 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: Dec 10 20:49:18 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: [1765428558072] ControllerPandora::PandoraHandler::fetchTracks::fetchStationPlaylist Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: Dec 10 20:49:18 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 155 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 150 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 145 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 140 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 134 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: Dec 10 20:49:18 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: Dec 10 20:49:18 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: Dec 10 20:49:18 volumio-nanopi volumio[1061]: ---------------------------- MPD announces state update: player Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::getState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 77 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand playlistinfo took 66 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand playlistinfo took 65 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand playlistinfo took 64 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand playlistinfo took 64 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand playlistinfo took 64 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 54 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 49 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand status took 43 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseState Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: [1765428558296] ControllerPandora::pushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2731,"duration":468,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Gnosis","artist":"Russian Circles","album":"Gnosis","uri":"http://t2-2.p-cdn.us/access/4140235201445085986.mp3?version=5&lid=1075995428&token=Y4GiHMaeKxC8YbhsDbzcrr3Bs%2BAWMLUqxpO6L4saw%2FB%2FB9pxZaNzPW0NdKydNA026AdCF2I9G%2BTSIm3cmGfVsnNMygh%2FNrd606zDBftVLE7edZmWsqbh%2BfOfRtV2o94uYYeFp6ADa2N5wpeQKO1Qt9z97oskI%2FXV2%2BGuulv%2FzM%2FPVWmLJjbmV%2B7RNEUTXSnnD9RhbaxKkQW5xcBPpW0df1W8hnNyNkZXOtPDOks9IkO%2BVgoX3gTpGaQK4oEgeGgdhjS5N5ZPy6iIcPzp8Ao3AnhSgfBpOTpxL1reERcyNBg69Ze%2F8F9f27qsuEUBR%2B3glredayCh%2B3VR31vqkbEhPg%3D%3D","trackType":"mp3"} Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: CURRENT POSITION 0 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreStateMachine::syncState stateService play Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreStateMachine::syncState currentStatus play Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: Received an update from plugin. extracting info from payload Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreStateMachine::pushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioPushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreStateMachine::setConsumeUpdateService pandora Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ------------------------------ 375ms Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ------------------------------ 368ms Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ------------------------------ 362ms Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ------------------------------ 356ms Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand playlistinfo took 141 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand playlistinfo took 126 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand playlistinfo took 126 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: sendMpdCommand playlistinfo took 125 milliseconds Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ControllerMpd::pushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::servicePushState Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CorePlayQueue::getTrack 0 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ------------------------------ 281ms Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ------------------------------ 246ms Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ------------------------------ 240ms Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: ------------------------------ 234ms Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: FusionDsp - volume level for loudness 82 gain applied 0.00 Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: FusionDsp - Loudness is ON true Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreCommandRouter::volumioGetQueue Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CoreStateMachine::getQueue Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: CorePlayQueue::getQueue Dec 10 20:49:18 volumio-nanopi volumio[1061]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 10 20:49:47 volumio-nanopi volumio[1061]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 10 20:49:47 volumio-nanopi volumio[1061]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 10 20:49:54 volumio-nanopi volumio[1061]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 20:49:54 volumio-nanopi volumio[1061]: SyntaxError: Unexpected end of JSON input Dec 10 20:49:54 volumio-nanopi volumio[1061]: at JSON.parse () Dec 10 20:49:54 volumio-nanopi volumio[1061]: at Request._callback (/data/plugins/music_service/pandora/node_modules/anesidora/anesidora.js:41:31) Dec 10 20:49:54 volumio-nanopi volumio[1061]: at Request.self.callback (/data/plugins/music_service/pandora/node_modules/request/request.js:185:22) Dec 10 20:49:54 volumio-nanopi volumio[1061]: at Request.emit (events.js:400:28) Dec 10 20:49:54 volumio-nanopi volumio[1061]: at Request. (/data/plugins/music_service/pandora/node_modules/request/request.js:1154:10) Dec 10 20:49:54 volumio-nanopi volumio[1061]: at Request.emit (events.js:400:28) Dec 10 20:49:54 volumio-nanopi volumio[1061]: at IncomingMessage. (/data/plugins/music_service/pandora/node_modules/request/request.js:1076:12) Dec 10 20:49:54 volumio-nanopi volumio[1061]: at Object.onceWrapper (events.js:519:28) Dec 10 20:49:54 volumio-nanopi volumio[1061]: at IncomingMessage.emit (events.js:412:35) Dec 10 20:49:54 volumio-nanopi volumio[1061]: at IncomingMessage. (/data/plugins/music_service/pandora/node_modules/request/request.js:993:23) Dec 10 20:49:54 volumio-nanopi volumio[1061]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 20:49:59 volumio-nanopi sudo[5633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-10 20:48 Dec 10 20:49:59 volumio-nanopi sudo[5633]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 17 Nov 2025 09:38:04 PM CET" VOLUMIO_VERSION="3.875" VOLUMIO_HARDWARE="orangepipc" VOLUMIO_DEVICENAME="Orange Pi PC" VOLUMIO_HASH="f14a1b6604a50dfb96eb025c18ac7629"