-- Logs begin at Fri 2025-12-26 15:35:40 CET, end at Fri 2025-12-26 15:36:49 CET. -- Dec 26 15:35:40 volumio-nano kernel: Booting Linux on physical CPU 0x0 Dec 26 15:35:40 volumio-nano kernel: Linux version 6.6.62-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #1816 SMP Mon Nov 18 15:33:33 GMT 2024 Dec 26 15:35:40 volumio-nano kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d Dec 26 15:35:40 volumio-nano kernel: CPU: div instructions available: patching division code Dec 26 15:35:40 volumio-nano kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache Dec 26 15:35:40 volumio-nano kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.1 Dec 26 15:35:40 volumio-nano kernel: random: crng init done Dec 26 15:35:40 volumio-nano kernel: Memory policy: Data cache writealloc Dec 26 15:35:40 volumio-nano kernel: Reserved memory: created CMA memory pool at 0x0000000029400000, size 64 MiB Dec 26 15:35:40 volumio-nano kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Dec 26 15:35:40 volumio-nano kernel: OF: reserved mem: 0x0000000029400000..0x000000002d3fffff (65536 KiB) map reusable linux,cma Dec 26 15:35:40 volumio-nano kernel: OF: reserved mem: 0x000000003ef64fe0..0x000000003ef653cf (0 KiB) nomap non-reusable nvram@0 Dec 26 15:35:40 volumio-nano kernel: Zone ranges: Dec 26 15:35:40 volumio-nano kernel: DMA [mem 0x0000000000000000-0x000000002fffffff] Dec 26 15:35:40 volumio-nano kernel: Normal empty Dec 26 15:35:40 volumio-nano kernel: HighMem [mem 0x0000000030000000-0x000000007fffffff] Dec 26 15:35:40 volumio-nano kernel: Movable zone start for each node Dec 26 15:35:40 volumio-nano kernel: Early memory node ranges Dec 26 15:35:40 volumio-nano kernel: node 0: [mem 0x0000000000000000-0x0000000037ffffff] Dec 26 15:35:40 volumio-nano kernel: node 0: [mem 0x0000000040000000-0x000000007fffffff] Dec 26 15:35:40 volumio-nano kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff] Dec 26 15:35:40 volumio-nano kernel: percpu: Embedded 18 pages/cpu s42004 r8192 d23532 u73728 Dec 26 15:35:40 volumio-nano kernel: pcpu-alloc: s42004 r8192 d23532 u73728 alloc=18*4096 Dec 26 15:35:40 volumio-nano kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 26 15:35:40 volumio-nano kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:5E:58:53 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=588d7464-4f54-4b1c-baea-aec51e0a0599 imgfile=/volumio_current.sqsh bootpart=UUID=DD4C-0179 datapart=UUID=6cd03fa6-aa19-4310-be0c-2f442be4138f uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Dec 26 15:35:40 volumio-nano kernel: cgroup: Disabling memory control group subsystem Dec 26 15:35:40 volumio-nano kernel: Unknown kernel command line parameters "splash nodebug numa_policy=interleave imgpart=UUID=588d7464-4f54-4b1c-baea-aec51e0a0599 imgfile=/volumio_current.sqsh bootpart=UUID=DD4C-0179 datapart=UUID=6cd03fa6-aa19-4310-be0c-2f442be4138f uuidconfig=cmdline.txt pcie_aspm=off bootdelay=7 use_kmsg=no", will be passed to user space. Dec 26 15:35:40 volumio-nano kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: Built 1 zonelists, mobility grouping on. Total pages: 489792 Dec 26 15:35:40 volumio-nano kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 26 15:35:40 volumio-nano kernel: software IO TLB: area num 4. Dec 26 15:35:40 volumio-nano kernel: software IO TLB: mapped [mem 0x0000000024200000-0x0000000028200000] (64MB) Dec 26 15:35:40 volumio-nano kernel: Memory: 1767036K/1966080K available (12288K kernel code, 1527K rwdata, 3492K rodata, 2048K init, 628K bss, 133508K reserved, 65536K cma-reserved, 1179648K highmem) Dec 26 15:35:40 volumio-nano kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 26 15:35:40 volumio-nano kernel: ftrace: allocating 38825 entries in 114 pages Dec 26 15:35:40 volumio-nano kernel: ftrace: allocated 114 pages with 4 groups Dec 26 15:35:40 volumio-nano kernel: trace event string verifier disabled Dec 26 15:35:40 volumio-nano kernel: rcu: Hierarchical RCU implementation. Dec 26 15:35:40 volumio-nano kernel: Rude variant of Tasks RCU enabled. Dec 26 15:35:40 volumio-nano kernel: Tracing variant of Tasks RCU enabled. Dec 26 15:35:40 volumio-nano kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. Dec 26 15:35:40 volumio-nano kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Dec 26 15:35:40 volumio-nano kernel: GIC: Using split EOI/Deactivate mode Dec 26 15:35:40 volumio-nano kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Dec 26 15:35:40 volumio-nano kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Dec 26 15:35:40 volumio-nano kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Dec 26 15:35:40 volumio-nano kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Dec 26 15:35:40 volumio-nano kernel: Switching to timer-based delay loop, resolution 18ns Dec 26 15:35:40 volumio-nano kernel: Console: colour dummy device 80x30 Dec 26 15:35:40 volumio-nano kernel: printk: console [tty1] enabled Dec 26 15:35:40 volumio-nano kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000) Dec 26 15:35:40 volumio-nano kernel: CPU: Testing write buffer coherency: ok Dec 26 15:35:40 volumio-nano kernel: CPU0: Spectre BHB: enabling loop workaround for all CPUs Dec 26 15:35:40 volumio-nano kernel: pid_max: default: 32768 minimum: 301 Dec 26 15:35:40 volumio-nano kernel: LSM: initializing lsm=capability,integrity Dec 26 15:35:40 volumio-nano kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Dec 26 15:35:40 volumio-nano kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 26 15:35:40 volumio-nano kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 26 15:35:40 volumio-nano kernel: Setting up static identity map for 0x200000 - 0x20003c Dec 26 15:35:40 volumio-nano kernel: rcu: Hierarchical SRCU implementation. Dec 26 15:35:40 volumio-nano kernel: rcu: Max phase no-delay instances is 1000. Dec 26 15:35:40 volumio-nano kernel: smp: Bringing up secondary CPUs ... Dec 26 15:35:40 volumio-nano kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Dec 26 15:35:40 volumio-nano kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Dec 26 15:35:40 volumio-nano kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Dec 26 15:35:40 volumio-nano kernel: smp: Brought up 1 node, 4 CPUs Dec 26 15:35:40 volumio-nano kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS). Dec 26 15:35:40 volumio-nano kernel: CPU: All CPU(s) started in HYP mode. Dec 26 15:35:40 volumio-nano kernel: CPU: Virtualization extensions available. Dec 26 15:35:40 volumio-nano kernel: devtmpfs: initialized Dec 26 15:35:40 volumio-nano kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0 Dec 26 15:35:40 volumio-nano kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Dec 26 15:35:40 volumio-nano kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: pinctrl core: initialized pinctrl subsystem Dec 26 15:35:40 volumio-nano kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 26 15:35:40 volumio-nano kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Dec 26 15:35:40 volumio-nano kernel: audit: initializing netlink subsys (disabled) Dec 26 15:35:40 volumio-nano kernel: audit: type=2000 audit(0.010:1): state=initialized audit_enabled=0 res=1 Dec 26 15:35:40 volumio-nano kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 26 15:35:40 volumio-nano kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Dec 26 15:35:40 volumio-nano kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Dec 26 15:35:40 volumio-nano kernel: Serial: AMBA PL011 UART driver Dec 26 15:35:40 volumio-nano kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled Dec 26 15:35:40 volumio-nano kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2024-11-11T15:48:13, variant start Dec 26 15:35:40 volumio-nano kernel: raspberrypi-firmware soc:firmware: Firmware hash is 903570ba72a9e117f92e5499de439f59dd96e417 Dec 26 15:35:40 volumio-nano kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Dec 26 15:35:40 volumio-nano kernel: bcm2835-dma fe007000.dma-controller: DMA legacy API manager, dmachans=0x1 Dec 26 15:35:40 volumio-nano kernel: SCSI subsystem initialized Dec 26 15:35:40 volumio-nano kernel: usbcore: registered new interface driver usbfs Dec 26 15:35:40 volumio-nano kernel: usbcore: registered new interface driver hub Dec 26 15:35:40 volumio-nano kernel: usbcore: registered new device driver usb Dec 26 15:35:40 volumio-nano kernel: pps_core: LinuxPPS API ver. 1 registered Dec 26 15:35:40 volumio-nano kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Dec 26 15:35:40 volumio-nano kernel: PTP clock support registered Dec 26 15:35:40 volumio-nano kernel: vgaarb: loaded Dec 26 15:35:40 volumio-nano kernel: clocksource: Switched to clocksource arch_sys_counter Dec 26 15:35:40 volumio-nano kernel: VFS: Disk quotas dquot_6.6.0 Dec 26 15:35:40 volumio-nano kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Dec 26 15:35:40 volumio-nano kernel: FS-Cache: Loaded Dec 26 15:35:40 volumio-nano kernel: CacheFiles: Loaded Dec 26 15:35:40 volumio-nano kernel: NET: Registered PF_INET protocol family Dec 26 15:35:40 volumio-nano kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: TCP: Hash tables configured (established 8192 bind 8192) Dec 26 15:35:40 volumio-nano kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Dec 26 15:35:40 volumio-nano kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 26 15:35:40 volumio-nano kernel: RPC: Registered named UNIX socket transport module. Dec 26 15:35:40 volumio-nano kernel: RPC: Registered udp transport module. Dec 26 15:35:40 volumio-nano kernel: RPC: Registered tcp transport module. Dec 26 15:35:40 volumio-nano kernel: RPC: Registered tcp-with-tls transport module. Dec 26 15:35:40 volumio-nano kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Dec 26 15:35:40 volumio-nano kernel: PCI: CLS 0 bytes, default 64 Dec 26 15:35:40 volumio-nano kernel: Trying to unpack rootfs image as initramfs... Dec 26 15:35:40 volumio-nano kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available Dec 26 15:35:40 volumio-nano kernel: Freeing initrd memory: 28132K Dec 26 15:35:40 volumio-nano kernel: Initialise system trusted keyrings Dec 26 15:35:40 volumio-nano kernel: workingset: timestamp_bits=14 max_order=19 bucket_order=5 Dec 26 15:35:40 volumio-nano kernel: zbud: loaded Dec 26 15:35:40 volumio-nano kernel: NFS: Registering the id_resolver key type Dec 26 15:35:40 volumio-nano kernel: Key type id_resolver registered Dec 26 15:35:40 volumio-nano kernel: Key type id_legacy registered Dec 26 15:35:40 volumio-nano kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Dec 26 15:35:40 volumio-nano kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Dec 26 15:35:40 volumio-nano kernel: Key type asymmetric registered Dec 26 15:35:40 volumio-nano kernel: Asymmetric key parser 'x509' registered Dec 26 15:35:40 volumio-nano kernel: bounce: pool size: 64 pages Dec 26 15:35:40 volumio-nano kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Dec 26 15:35:40 volumio-nano kernel: io scheduler mq-deadline registered Dec 26 15:35:40 volumio-nano kernel: io scheduler kyber registered Dec 26 15:35:40 volumio-nano kernel: io scheduler bfq registered Dec 26 15:35:40 volumio-nano kernel: pinctrl-bcm2835 fe200000.gpio: GPIO_OUT persistence: yes Dec 26 15:35:40 volumio-nano kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: Dec 26 15:35:40 volumio-nano kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] Dec 26 15:35:40 volumio-nano kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x067fffffff -> 0x0080000000 Dec 26 15:35:40 volumio-nano kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x007fffffff -> 0x0400000000 Dec 26 15:35:40 volumio-nano kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 Dec 26 15:35:40 volumio-nano kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 26 15:35:40 volumio-nano kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x67fffffff] (bus address [0x80000000-0xffffffff]) Dec 26 15:35:40 volumio-nano kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 Dec 26 15:35:40 volumio-nano kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Dec 26 15:35:40 volumio-nano kernel: PCI: bus0: Fast back to back transfers disabled Dec 26 15:35:40 volumio-nano kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Dec 26 15:35:40 volumio-nano kernel: pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator Dec 26 15:35:40 volumio-nano kernel: pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator Dec 26 15:35:40 volumio-nano kernel: pci_bus 0000:01: supply vpcie12v not found, using dummy regulator Dec 26 15:35:40 volumio-nano kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) Dec 26 15:35:40 volumio-nano kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 Dec 26 15:35:40 volumio-nano kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Dec 26 15:35:40 volumio-nano kernel: pci 0000:01:00.0: PME# supported from D0 D3cold Dec 26 15:35:40 volumio-nano kernel: PCI: bus1: Fast back to back transfers disabled Dec 26 15:35:40 volumio-nano kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 Dec 26 15:35:40 volumio-nano kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] Dec 26 15:35:40 volumio-nano kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] Dec 26 15:35:40 volumio-nano kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Dec 26 15:35:40 volumio-nano kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] Dec 26 15:35:40 volumio-nano kernel: pci 0000:00:00.0: Max Payload Size set to 256/ 512 (was 128), Max Read Rq 512 Dec 26 15:35:40 volumio-nano kernel: pci 0000:01:00.0: Max Payload Size set to 256/ 256 (was 128), Max Read Rq 512 Dec 26 15:35:40 volumio-nano kernel: pcieport 0000:00:00.0: enabling device (0000 -> 0002) Dec 26 15:35:40 volumio-nano kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 45 Dec 26 15:35:40 volumio-nano kernel: bcm2708_fb soc:fb: FB found 1 display(s) Dec 26 15:35:40 volumio-nano kernel: Console: switching to colour frame buffer device 80x30 Dec 26 15:35:40 volumio-nano kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480 Dec 26 15:35:40 volumio-nano kernel: iproc-rng200 fe104000.rng: hwrng registered Dec 26 15:35:40 volumio-nano kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Dec 26 15:35:40 volumio-nano kernel: brd: module loaded Dec 26 15:35:40 volumio-nano kernel: loop: module loaded Dec 26 15:35:40 volumio-nano kernel: Loading iSCSI transport class v2.0-870. Dec 26 15:35:40 volumio-nano kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 Dec 26 15:35:40 volumio-nano kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus Dec 26 15:35:40 volumio-nano kernel: usbcore: registered new device driver r8152-cfgselector Dec 26 15:35:40 volumio-nano kernel: usbcore: registered new interface driver r8152 Dec 26 15:35:40 volumio-nano kernel: usbcore: registered new interface driver lan78xx Dec 26 15:35:40 volumio-nano kernel: usbcore: registered new interface driver smsc95xx Dec 26 15:35:40 volumio-nano kernel: xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142) Dec 26 15:35:40 volumio-nano kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Dec 26 15:35:40 volumio-nano kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 Dec 26 15:35:40 volumio-nano kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0700240000000890 Dec 26 15:35:40 volumio-nano kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Dec 26 15:35:40 volumio-nano kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 Dec 26 15:35:40 volumio-nano kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed Dec 26 15:35:40 volumio-nano kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Dec 26 15:35:40 volumio-nano kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 26 15:35:40 volumio-nano kernel: usb usb1: Product: xHCI Host Controller Dec 26 15:35:40 volumio-nano kernel: usb usb1: Manufacturer: Linux 6.6.62-v7l+ xhci-hcd Dec 26 15:35:40 volumio-nano kernel: usb usb1: SerialNumber: 0000:01:00.0 Dec 26 15:35:40 volumio-nano kernel: hub 1-0:1.0: USB hub found Dec 26 15:35:40 volumio-nano kernel: hub 1-0:1.0: 1 port detected Dec 26 15:35:40 volumio-nano kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Dec 26 15:35:40 volumio-nano kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 26 15:35:40 volumio-nano kernel: usb usb2: Product: xHCI Host Controller Dec 26 15:35:40 volumio-nano kernel: usb usb2: Manufacturer: Linux 6.6.62-v7l+ xhci-hcd Dec 26 15:35:40 volumio-nano kernel: usb usb2: SerialNumber: 0000:01:00.0 Dec 26 15:35:40 volumio-nano kernel: hub 2-0:1.0: USB hub found Dec 26 15:35:40 volumio-nano kernel: hub 2-0:1.0: 4 ports detected Dec 26 15:35:40 volumio-nano kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Dec 26 15:35:40 volumio-nano kernel: dwc_otg: FIQ enabled Dec 26 15:35:40 volumio-nano kernel: dwc_otg: NAK holdoff enabled Dec 26 15:35:40 volumio-nano kernel: dwc_otg: FIQ split-transaction FSM enabled Dec 26 15:35:40 volumio-nano kernel: Module dwc_common_port init Dec 26 15:35:40 volumio-nano kernel: usbcore: registered new interface driver uas Dec 26 15:35:40 volumio-nano kernel: usbcore: registered new interface driver usb-storage Dec 26 15:35:40 volumio-nano kernel: mousedev: PS/2 mouse device common for all mice Dec 26 15:35:40 volumio-nano kernel: sdhci: Secure Digital Host Controller Interface driver Dec 26 15:35:40 volumio-nano kernel: sdhci: Copyright(c) Pierre Ossman Dec 26 15:35:40 volumio-nano kernel: sdhci-pltfm: SDHCI platform and OF driver helper Dec 26 15:35:40 volumio-nano kernel: ledtrig-cpu: registered to indicate activity on CPUs Dec 26 15:35:40 volumio-nano kernel: hid: raw HID events driver (C) Jiri Kosina Dec 26 15:35:40 volumio-nano kernel: usbcore: registered new interface driver usbhid Dec 26 15:35:40 volumio-nano kernel: usbhid: USB HID core driver Dec 26 15:35:40 volumio-nano kernel: Initializing XFRM netlink socket Dec 26 15:35:40 volumio-nano kernel: NET: Registered PF_PACKET protocol family Dec 26 15:35:40 volumio-nano kernel: Key type dns_resolver registered Dec 26 15:35:40 volumio-nano kernel: Registering SWP/SWPB emulation handler Dec 26 15:35:40 volumio-nano kernel: registered taskstats version 1 Dec 26 15:35:40 volumio-nano kernel: Loading compiled-in X.509 certificates Dec 26 15:35:40 volumio-nano kernel: Key type .fscrypt registered Dec 26 15:35:40 volumio-nano kernel: Key type fscrypt-provisioning registered Dec 26 15:35:40 volumio-nano kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Dec 26 15:35:40 volumio-nano kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Dec 26 15:35:40 volumio-nano kernel: fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 51, base_baud = 0) is a PL011 rev2 Dec 26 15:35:40 volumio-nano kernel: serial serial0: tty port ttyAMA1 registered Dec 26 15:35:40 volumio-nano kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Dec 26 15:35:40 volumio-nano kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Dec 26 15:35:40 volumio-nano kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Dec 26 15:35:40 volumio-nano kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Dec 26 15:35:40 volumio-nano kernel: of_cfs_init Dec 26 15:35:40 volumio-nano kernel: of_cfs_init: OK Dec 26 15:35:40 volumio-nano kernel: clk: Disabling unused clocks Dec 26 15:35:40 volumio-nano kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Dec 26 15:35:40 volumio-nano kernel: Freeing unused kernel image (initmem) memory: 2048K Dec 26 15:35:40 volumio-nano kernel: Run /init as init process Dec 26 15:35:40 volumio-nano kernel: with arguments: Dec 26 15:35:40 volumio-nano kernel: /init Dec 26 15:35:40 volumio-nano kernel: splash Dec 26 15:35:40 volumio-nano kernel: nodebug Dec 26 15:35:40 volumio-nano kernel: with environment: Dec 26 15:35:40 volumio-nano kernel: HOME=/ Dec 26 15:35:40 volumio-nano kernel: TERM=linux Dec 26 15:35:40 volumio-nano kernel: numa_policy=interleave Dec 26 15:35:40 volumio-nano kernel: imgpart=UUID=588d7464-4f54-4b1c-baea-aec51e0a0599 Dec 26 15:35:40 volumio-nano kernel: imgfile=/volumio_current.sqsh Dec 26 15:35:40 volumio-nano kernel: bootpart=UUID=DD4C-0179 Dec 26 15:35:40 volumio-nano kernel: datapart=UUID=6cd03fa6-aa19-4310-be0c-2f442be4138f Dec 26 15:35:40 volumio-nano kernel: uuidconfig=cmdline.txt Dec 26 15:35:40 volumio-nano kernel: pcie_aspm=off Dec 26 15:35:40 volumio-nano kernel: bootdelay=7 Dec 26 15:35:40 volumio-nano kernel: use_kmsg=no Dec 26 15:35:40 volumio-nano kernel: mmc1: new high speed SDIO card at address 0001 Dec 26 15:35:40 volumio-nano kernel: mmc0: new ultra high speed DDR50 SDHC card at address aaaa Dec 26 15:35:40 volumio-nano kernel: mmcblk0: mmc0:aaaa SA08G 7.40 GiB Dec 26 15:35:40 volumio-nano kernel: mmcblk0: p1 p2 p3 Dec 26 15:35:40 volumio-nano kernel: mmcblk0: mmc0:aaaa SA08G 7.40 GiB (quirks 0x00004000) Dec 26 15:35:40 volumio-nano kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Dec 26 15:35:40 volumio-nano kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.20 Dec 26 15:35:40 volumio-nano kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Dec 26 15:35:40 volumio-nano kernel: usb 1-1: Product: USB2.0 Hub Dec 26 15:35:40 volumio-nano kernel: hub 1-1:1.0: USB hub found Dec 26 15:35:40 volumio-nano kernel: hub 1-1:1.0: 4 ports detected Dec 26 15:35:40 volumio-nano kernel: fuse: init (API version 7.39) Dec 26 15:35:40 volumio-nano kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 26 15:35:40 volumio-nano kernel: EXT4-fs (mmcblk0p2): recovery complete Dec 26 15:35:40 volumio-nano kernel: EXT4-fs (mmcblk0p2): mounted filesystem 588d7464-4f54-4b1c-baea-aec51e0a0599 r/w with ordered data mode. Quota mode: none. Dec 26 15:35:40 volumio-nano kernel: loop0: detected capacity change from 0 to 1005568 Dec 26 15:35:40 volumio-nano kernel: EXT4-fs (mmcblk0p3): recovery complete Dec 26 15:35:40 volumio-nano kernel: EXT4-fs (mmcblk0p3): mounted filesystem 6cd03fa6-aa19-4310-be0c-2f442be4138f r/w with ordered data mode. Quota mode: none. Dec 26 15:35:40 volumio-nano systemd[1]: System time before build time, advancing clock. Dec 26 15:35:40 volumio-nano kernel: NET: Registered PF_INET6 protocol family Dec 26 15:35:40 volumio-nano kernel: Segment Routing with IPv6 Dec 26 15:35:40 volumio-nano kernel: In-situ OAM (IOAM) with IPv6 Dec 26 15:35:40 volumio-nano 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 26 15:35:40 volumio-nano systemd[1]: Detected architecture arm. Dec 26 15:35:40 volumio-nano systemd[1]: Set hostname to . Dec 26 15:35:40 volumio-nano 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 26 15:35:40 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_oled.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 26 15:35:40 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_oled.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Dec 26 15:35:40 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_lirc.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 26 15:35:40 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_lirc.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Dec 26 15:35:40 volumio-nano systemd[1]: Listening on Journal Audit Socket. Dec 26 15:35:40 volumio-nano systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Dec 26 15:35:40 volumio-nano kernel: i2c_dev: i2c /dev entries driver Dec 26 15:35:40 volumio-nano systemd-journald[308]: Journal started Dec 26 15:35:40 volumio-nano systemd-journald[308]: Runtime journal (/run/log/journal/26288ad12cf0817baa21aee262cc2d39) is 3.7M, max 30.0M, 26.2M free. Dec 26 15:35:40 volumio-nano systemd-modules-load[307]: Inserted module 'i2c_dev' Dec 26 15:35:40 volumio-nano fake-hwclock[303]: Fri Dec 26 14:35:40 UTC 2025 Dec 26 15:35:40 volumio-nano systemd[1]: Started Load/Save Random Seed. Dec 26 15:35:40 volumio-nano systemd[1]: dynamicswap.service: Succeeded. Dec 26 15:35:40 volumio-nano systemd[1]: Started Create System Users. Dec 26 15:35:40 volumio-nano systemd[1]: Starting Create Static Device Nodes in /dev... Dec 26 15:35:40 volumio-nano systemd[1]: Started udev Coldplug all Devices. Dec 26 15:35:40 volumio-nano systemd[1]: Started Create Static Device Nodes in /dev. Dec 26 15:35:40 volumio-nano systemd[1]: Reached target Local File Systems (Pre). Dec 26 15:35:40 volumio-nano systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Dec 26 15:35:40 volumio-nano systemd[1]: Mounting /tmp... Dec 26 15:35:40 volumio-nano systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Dec 26 15:35:40 volumio-nano systemd[1]: Mounting /var/log... Dec 26 15:35:40 volumio-nano systemd[1]: Mounting /var/spool/cups... Dec 26 15:35:40 volumio-nano systemd[1]: Starting udev Kernel Device Manager... Dec 26 15:35:40 volumio-nano systemd[1]: Starting Helper to synchronize boot up for ifupdown... Dec 26 15:35:40 volumio-nano systemd[1]: Mounted /tmp. Dec 26 15:35:40 volumio-nano systemd[1]: Mounted /var/log. Dec 26 15:35:40 volumio-nano systemd[1]: Mounted /var/spool/cups. Dec 26 15:35:40 volumio-nano systemd[1]: Mounting /var/spool/cups/tmp... Dec 26 15:35:40 volumio-nano systemd[1]: Starting Flush Journal to Persistent Storage... Dec 26 15:35:40 volumio-nano systemd[1]: Mounted /var/spool/cups/tmp. Dec 26 15:35:40 volumio-nano systemd-udevd[333]: Network interface NamePolicy= disabled on kernel command line, ignoring. Dec 26 15:35:40 volumio-nano systemd-journald[308]: Runtime journal (/run/log/journal/26288ad12cf0817baa21aee262cc2d39) is 3.7M, max 30.0M, 26.2M free. Dec 26 15:35:40 volumio-nano systemd[1]: Started Flush Journal to Persistent Storage. Dec 26 15:35:40 volumio-nano systemd[1]: Started udev Kernel Device Manager. Dec 26 15:35:40 volumio-nano systemd[1]: Starting Show Plymouth Boot Screen... Dec 26 15:35:40 volumio-nano systemd-udevd[352]: Using default interface naming scheme 'v240'. Dec 26 15:35:40 volumio-nano kernel: mc: Linux media interface: v0.10 Dec 26 15:35:40 volumio-nano systemd-udevd[352]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Dec 26 15:35:40 volumio-nano kernel: rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000 Dec 26 15:35:40 volumio-nano kernel: rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem Dec 26 15:35:40 volumio-nano kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Dec 26 15:35:40 volumio-nano kernel: videodev: Linux video capture interface: v2.00 Dec 26 15:35:40 volumio-nano kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Dec 26 15:35:40 volumio-nano kernel: [vc_sm_connected_init]: start Dec 26 15:35:40 volumio-nano kernel: [vc_sm_connected_init]: installed successfully Dec 26 15:35:40 volumio-nano kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Dec 26 15:35:40 volumio-nano kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Dec 26 15:35:40 volumio-nano kernel: rpivid feb10000.codec: Device registered as /dev/video19 Dec 26 15:35:40 volumio-nano kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Dec 26 15:35:40 volumio-nano kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Dec 26 15:35:40 volumio-nano systemd[1]: plymouth-start.service: Succeeded. Dec 26 15:35:40 volumio-nano systemd[1]: Started Show Plymouth Boot Screen. Dec 26 15:35:40 volumio-nano kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Dec 26 15:35:40 volumio-nano kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Dec 26 15:35:40 volumio-nano kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Dec 26 15:35:40 volumio-nano kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Dec 26 15:35:40 volumio-nano kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Dec 26 15:35:40 volumio-nano kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Dec 26 15:35:40 volumio-nano kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Dec 26 15:35:40 volumio-nano kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Dec 26 15:35:40 volumio-nano kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Dec 26 15:35:40 volumio-nano kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Dec 26 15:35:40 volumio-nano kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Dec 26 15:35:40 volumio-nano kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Dec 26 15:35:40 volumio-nano kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Dec 26 15:35:40 volumio-nano kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Dec 26 15:35:40 volumio-nano kernel: Bluetooth: Core ver 2.22 Dec 26 15:35:40 volumio-nano kernel: NET: Registered PF_BLUETOOTH protocol family Dec 26 15:35:40 volumio-nano kernel: Bluetooth: HCI device and connection manager initialized Dec 26 15:35:40 volumio-nano kernel: Bluetooth: HCI socket layer initialized Dec 26 15:35:40 volumio-nano kernel: Bluetooth: L2CAP socket layer initialized Dec 26 15:35:40 volumio-nano kernel: Bluetooth: SCO socket layer initialized Dec 26 15:35:40 volumio-nano kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Dec 26 15:35:40 volumio-nano kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Dec 26 15:35:40 volumio-nano kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Dec 26 15:35:40 volumio-nano kernel: Bluetooth: HCI UART driver ver 2.3 Dec 26 15:35:40 volumio-nano kernel: Bluetooth: HCI UART protocol H4 registered Dec 26 15:35:40 volumio-nano kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Dec 26 15:35:40 volumio-nano kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Dec 26 15:35:41 volumio-nano kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Dec 26 15:35:41 volumio-nano kernel: Bluetooth: HCI UART protocol Broadcom registered Dec 26 15:35:41 volumio-nano kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Dec 26 15:35:41 volumio-nano kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Dec 26 15:35:41 volumio-nano kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Dec 26 15:35:41 volumio-nano kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Dec 26 15:35:41 volumio-nano kernel: uart-pl011 fe201000.serial: no DMA platform data Dec 26 15:35:41 volumio-nano kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Dec 26 15:35:41 volumio-nano kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Dec 26 15:35:41 volumio-nano kernel: usbcore: registered new interface driver brcmfmac Dec 26 15:35:40 volumio-nano systemd[1]: Found device /dev/disk/by-uuid/DD4C-0179. Dec 26 15:35:40 volumio-nano systemd[1]: Starting File System Check on /dev/disk/by-uuid/DD4C-0179... Dec 26 15:35:41 volumio-nano systemd-fsck[479]: fsck.fat 4.1 (2017-01-24) Dec 26 15:35:41 volumio-nano systemd-fsck[479]: /dev/mmcblk0p1: 404 files, 21029/48842 clusters Dec 26 15:35:40 volumio-nano systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Dec 26 15:35:40 volumio-nano systemd[1]: Reached target Paths. Dec 26 15:35:40 volumio-nano systemd[1]: Reached target Local Encrypted Volumes. Dec 26 15:35:40 volumio-nano systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Dec 26 15:35:41 volumio-nano systemd-udevd[353]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Dec 26 15:35:41 volumio-nano systemd[1]: Started File System Check on /dev/disk/by-uuid/DD4C-0179. Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Dec 26 15:35:41 volumio-nano kernel: Bluetooth: hci0: BCM: chip id 107 Dec 26 15:35:41 volumio-nano kernel: Bluetooth: hci0: BCM: features 0x2f Dec 26 15:35:41 volumio-nano kernel: Bluetooth: hci0: BCM4345C0 Dec 26 15:35:41 volumio-nano kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Dec 26 15:35:41 volumio-nano kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Dec 26 15:35:41 volumio-nano kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Dec 26 15:35:41 volumio-nano kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 Dec 26 15:35:41 volumio-nano kernel: alsactl[520]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Dec 26 15:35:41 volumio-nano systemd[1]: Created slice system-bthelper.slice. Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Dec 26 15:35:41 volumio-nano systemd-udevd[346]: Using default interface naming scheme 'v240'. Dec 26 15:35:41 volumio-nano systemd-udevd[346]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Dec 26 15:35:41 volumio-nano systemd[1]: Starting Show Plymouth Boot Screen... Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in Huge Pages File System being skipped. Dec 26 15:35:41 volumio-nano systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Dec 26 15:35:41 volumio-nano systemd[1]: Mounting /boot... Dec 26 15:35:41 volumio-nano systemd[1]: Started File System Check Daemon to report status. Dec 26 15:35:41 volumio-nano systemd[1]: Starting Load/Save RF Kill Switch Status... Dec 26 15:35:41 volumio-nano systemd[1]: Mounted /boot. Dec 26 15:35:41 volumio-nano systemd[1]: plymouth-start.service: Succeeded. Dec 26 15:35:41 volumio-nano systemd[1]: Started Show Plymouth Boot Screen. Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Dec 26 15:35:41 volumio-nano systemd[1]: Reached target Local File Systems. Dec 26 15:35:41 volumio-nano systemd[1]: Starting Create Volatile Files and Directories... Dec 26 15:35:41 volumio-nano systemd[1]: Started ifup for eth0. Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Dec 26 15:35:41 volumio-nano systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Dec 26 15:35:41 volumio-nano systemd[1]: Starting Preprocess NFS configuration... Dec 26 15:35:41 volumio-nano systemd[1]: Started Load/Save RF Kill Switch Status. Dec 26 15:35:41 volumio-nano systemd[1]: Received SIGRTMIN+20 from PID 193 (plymouthd). Dec 26 15:35:41 volumio-nano systemd[1]: plymouth-read-write.service: Succeeded. Dec 26 15:35:41 volumio-nano systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Dec 26 15:35:41 volumio-nano systemd[1]: nfs-config.service: Succeeded. Dec 26 15:35:41 volumio-nano systemd[1]: Started Preprocess NFS configuration. Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Dec 26 15:35:41 volumio-nano systemd[1]: Reached target NFS client services. Dec 26 15:35:41 volumio-nano systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Dec 26 15:35:41 volumio-nano systemd[1]: Started Create Volatile Files and Directories. Dec 26 15:35:41 volumio-nano kernel: 8021q: 802.1Q VLAN Support v1.8 Dec 26 15:35:41 volumio-nano systemd[1]: Starting RPC bind portmap service... Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Dec 26 15:35:41 volumio-nano systemd[1]: Starting Update UTMP about System Boot/Shutdown... Dec 26 15:35:41 volumio-nano systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Dec 26 15:35:41 volumio-nano systemd[1]: Started ifup for wlan0. Dec 26 15:35:41 volumio-nano kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Dec 26 15:35:41 volumio-nano systemd[1]: Started Update UTMP about System Boot/Shutdown. Dec 26 15:35:41 volumio-nano dhcpcd[562]: eth0: waiting for carrier Dec 26 15:35:41 volumio-nano sh[541]: eth0: waiting for carrier Dec 26 15:35:41 volumio-nano systemd[1]: Reached target System Initialization. Dec 26 15:35:41 volumio-nano systemd[1]: Started Daily Cleanup of Temporary Directories. Dec 26 15:35:41 volumio-nano systemd[1]: Listening on triggerhappy.socket. Dec 26 15:35:41 volumio-nano kernel: bcmgenet fd580000.ethernet eth0: Link is Down Dec 26 15:35:41 volumio-nano kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Dec 26 15:35:41 volumio-nano systemd[1]: Started Daily apt download activities. Dec 26 15:35:41 volumio-nano systemd[1]: Started Daily apt upgrade and clean activities. Dec 26 15:35:41 volumio-nano systemd[1]: Reached target Timers. Dec 26 15:35:41 volumio-nano systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Dec 26 15:35:41 volumio-nano systemd[1]: Listening on D-Bus System Message Bus Socket. Dec 26 15:35:41 volumio-nano systemd[1]: Reached target Sockets. Dec 26 15:35:41 volumio-nano systemd[1]: Reached target Basic System. Dec 26 15:35:41 volumio-nano systemd[1]: Starting Volumio Time Update Utility... Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Dec 26 15:35:41 volumio-nano systemd[1]: Started volumio-remote-updater.service. Dec 26 15:35:41 volumio-nano systemd[1]: Started NanoSound OLED Diplay Service. Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Dec 26 15:35:41 volumio-nano systemd[1]: Started Volumio Iptables Module. Dec 26 15:35:41 volumio-nano systemd[1]: Started Volumio Log Rotation Service. Dec 26 15:35:41 volumio-nano systemd[1]: Started Manage Sound Card State (restore and store). Dec 26 15:35:41 volumio-nano systemd[1]: Starting triggerhappy global hotkey daemon... Dec 26 15:35:41 volumio-nano systemd[1]: Starting Wireless Services... Dec 26 15:35:41 volumio-nano alsactl[607]: alsactl 1.1.8 daemon started Dec 26 15:35:41 volumio-nano volumio-time-update[598]: volumio-time-update-util: Fetching time from Volumio... Dec 26 15:35:41 volumio-nano systemd[1]: Starting Save/Restore Sound Card State... Dec 26 15:35:41 volumio-nano systemd[1]: Started UPnP Renderer front-end to MPD. Dec 26 15:35:41 volumio-nano systemd[1]: Starting Configure Bluetooth Modems connected by UART... Dec 26 15:35:41 volumio-nano systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Dec 26 15:35:41 volumio-nano systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Dec 26 15:35:41 volumio-nano systemd[1]: Starting Login Service... Dec 26 15:35:41 volumio-nano systemd[1]: Started D-Bus System Message Bus. Dec 26 15:35:41 volumio-nano systemd[1]: Starting WPA supplicant... Dec 26 15:35:41 volumio-nano systemd[1]: Started NanoSound LIRC Service. Dec 26 15:35:41 volumio-nano systemd[1]: Starting dhcpcd on all interfaces... Dec 26 15:35:41 volumio-nano systemd[1]: Started RPC bind portmap service. Dec 26 15:35:41 volumio-nano systemd[1]: Reached target RPC Port Mapper. Dec 26 15:35:41 volumio-nano systemd[1]: Reached target Remote File Systems (Pre). Dec 26 15:35:41 volumio-nano systemd[1]: Reached target Remote File Systems. Dec 26 15:35:41 volumio-nano systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Dec 26 15:35:41 volumio-nano thd[608]: Unable to parse trigger line: Dec 26 15:35:41 volumio-nano thd[608]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Dec 26 15:35:41 volumio-nano thd[608]: Unable to parse trigger line: Dec 26 15:35:41 volumio-nano thd[608]: Found socket passed from systemd Dec 26 15:35:42 volumio-nano kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 26 15:35:42 volumio-nano systemd-logind[618]: New seat seat0. Dec 26 15:35:42 volumio-nano kernel: Bluetooth: hci0: BCM: features 0x2f Dec 26 15:35:42 volumio-nano kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Dec 26 15:35:42 volumio-nano kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Dec 26 15:35:42 volumio-nano dhcpcd[622]: Not running dhcpcd because /etc/network/interfaces Dec 26 15:35:42 volumio-nano dhcpcd[622]: defines some interfaces that will use a Dec 26 15:35:42 volumio-nano dhcpcd[622]: DHCP client or static address Dec 26 15:35:42 volumio-nano avahi-daemon[617]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Dec 26 15:35:42 volumio-nano avahi-daemon[617]: Successfully dropped root privileges. Dec 26 15:35:42 volumio-nano avahi-daemon[617]: avahi-daemon 0.7 starting up. Dec 26 15:35:42 volumio-nano dbus-daemon[619]: [system] Successfully activated service 'org.freedesktop.systemd1' Dec 26 15:35:42 volumio-nano systemd[1]: Started Login Service. Dec 26 15:35:42 volumio-nano avahi-daemon[617]: Successfully called chroot(). Dec 26 15:35:42 volumio-nano avahi-daemon[617]: Successfully dropped remaining capabilities. Dec 26 15:35:42 volumio-nano systemd[1]: Started triggerhappy global hotkey daemon. Dec 26 15:35:42 volumio-nano wpa_supplicant[620]: Successfully initialized wpa_supplicant Dec 26 15:35:42 volumio-nano systemd[1]: Started Save/Restore Sound Card State. Dec 26 15:35:42 volumio-nano systemd[1]: hciuart.service: Succeeded. Dec 26 15:35:42 volumio-nano systemd[1]: Started Configure Bluetooth Modems connected by UART. Dec 26 15:35:42 volumio-nano systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Dec 26 15:35:42 volumio-nano systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Dec 26 15:35:42 volumio-nano systemd[1]: Failed to start dhcpcd on all interfaces. Dec 26 15:35:42 volumio-nano avahi-daemon[617]: Loading service file /services/volumio.service. Dec 26 15:35:42 volumio-nano avahi-daemon[617]: Network interface enumeration completed. Dec 26 15:35:42 volumio-nano avahi-daemon[617]: Server startup complete. Host name is volumio-nano.local. Local service cookie is 1425155768. Dec 26 15:35:42 volumio-nano avahi-daemon[617]: Service "Volumio-Nano" (/services/volumio.service) successfully established. Dec 26 15:35:42 volumio-nano sh[577]: wlan0=wlan0 Dec 26 15:35:42 volumio-nano systemd[1]: Started Avahi mDNS/DNS-SD Stack. Dec 26 15:35:42 volumio-nano systemd[1]: Started WPA supplicant. Dec 26 15:35:42 volumio-nano volumio-remote-updater[599]: Error: No active session Dec 26 15:35:42 volumio-nano volumio-remote-updater[599]: [2025-12-26 15:35:42] [info] asio async_connect error: system:111 (Connection refused) Dec 26 15:35:42 volumio-nano volumio-remote-updater[599]: [2025-12-26 15:35:42] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 26 15:35:42 volumio-nano volumio-remote-updater[599]: [2025-12-26 15:35:42] [error] handle_connect error: Underlying Transport Error Dec 26 15:35:42 volumio-nano systemd[1]: Starting Raspberry Pi bluetooth helper... Dec 26 15:35:42 volumio-nano systemd[1]: Reached target Sound Card. Dec 26 15:35:42 volumio-nano volumio[611]: Could not open config: /tmp/upmpdcli.conf Dec 26 15:35:42 volumio-nano systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 26 15:35:42 volumio-nano volumio-time-update[598]: volumio-time-update-util: Date not found in response Dec 26 15:35:42 volumio-nano volumio-time-update[598]: volumio-time-update-util: Retrying in 5 seconds... Dec 26 15:35:42 volumio-nano systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 26 15:35:42 volumio-nano bthelper[672]: Raspberry Pi BDADDR already set Dec 26 15:35:42 volumio-nano systemd[1]: Started Raspberry Pi bluetooth helper. Dec 26 15:35:42 volumio-nano systemd[1]: Starting Bluetooth service... Dec 26 15:35:42 volumio-nano loadcpufreq[623]: Loading cpufreq kernel modules...done (none). Dec 26 15:35:42 volumio-nano systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Dec 26 15:35:42 volumio-nano systemd[1]: Starting LSB: set CPUFreq kernel parameters... Dec 26 15:35:42 volumio-nano systemd[1]: iptables.service: Succeeded. Dec 26 15:35:43 volumio-nano haveged[576]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Dec 26 15:35:43 volumio-nano haveged[576]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Dec 26 15:35:43 volumio-nano haveged[576]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00159 Dec 26 15:35:43 volumio-nano haveged[576]: haveged: fills: 0, generated: 0 Dec 26 15:35:43 volumio-nano bluetoothd[711]: Bluetooth daemon 5.50 Dec 26 15:35:43 volumio-nano cpufrequtils[712]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Dec 26 15:35:43 volumio-nano systemd[1]: Started LSB: set CPUFreq kernel parameters. Dec 26 15:35:43 volumio-nano bluetoothd[711]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Dec 26 15:35:43 volumio-nano systemd[1]: Started Bluetooth service. Dec 26 15:35:43 volumio-nano systemd[1]: Reached target Bluetooth. Dec 26 15:35:43 volumio-nano bluetoothd[711]: Starting SDP server Dec 26 15:35:43 volumio-nano kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Dec 26 15:35:43 volumio-nano kernel: Bluetooth: BNEP filters: protocol multicast Dec 26 15:35:43 volumio-nano kernel: Bluetooth: BNEP socket layer initialized Dec 26 15:35:43 volumio-nano dbus-daemon[619]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=711 comm="/usr/lib/bluetooth/bluetoothd ") Dec 26 15:35:43 volumio-nano bluetoothd[711]: Bluetooth management interface 1.22 initialized Dec 26 15:35:43 volumio-nano kernel: Bluetooth: MGMT ver 1.22 Dec 26 15:35:43 volumio-nano bluetoothd[711]: Sap driver initialization failed. Dec 26 15:35:43 volumio-nano bluetoothd[711]: sap-server: Operation not permitted (1) Dec 26 15:35:43 volumio-nano systemd[1]: Starting Hostname Service... Dec 26 15:35:43 volumio-nano systemd[1]: Started Helper to synchronize boot up for ifupdown. Dec 26 15:35:43 volumio-nano bluetoothd[711]: Failed to set privacy: Rejected (0x0b) Dec 26 15:35:43 volumio-nano systemd[1]: Starting Raise network interfaces... Dec 26 15:35:43 volumio-nano dbus-daemon[619]: [system] Successfully activated service 'org.freedesktop.hostname1' Dec 26 15:35:43 volumio-nano systemd[1]: Started Hostname Service. Dec 26 15:35:43 volumio-nano systemd[1]: Started Raise network interfaces. Dec 26 15:35:43 volumio-nano systemd[1]: Reached target Network. Dec 26 15:35:43 volumio-nano systemd[1]: Starting OpenBSD Secure Shell server... Dec 26 15:35:43 volumio-nano systemd[1]: Starting Permit User Sessions... Dec 26 15:35:43 volumio-nano systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Dec 26 15:35:43 volumio-nano systemd[1]: Starting Network Time Service... Dec 26 15:35:43 volumio-nano systemd[1]: Reached target Network is Online. Dec 26 15:35:43 volumio-nano systemd[1]: Starting Samba NMB Daemon... Dec 26 15:35:43 volumio-nano systemd[1]: Starting LSB: Brings up/down network automatically... Dec 26 15:35:43 volumio-nano systemd[1]: Starting /etc/rc.local Compatibility... Dec 26 15:35:43 volumio-nano systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 26 15:35:43 volumio-nano systemd[1]: Started /etc/rc.local Compatibility. Dec 26 15:35:43 volumio-nano systemd[1]: Started Permit User Sessions. Dec 26 15:35:43 volumio-nano systemd[1]: Starting Terminate Plymouth Boot Screen... Dec 26 15:35:43 volumio-nano systemd[1]: Starting Hold until boot process finishes up... Dec 26 15:35:43 volumio-nano systemd[1]: Received SIGRTMIN+21 from PID 193 (plymouthd). Dec 26 15:35:43 volumio-nano systemd[1]: plymouth-quit.service: Succeeded. Dec 26 15:35:43 volumio-nano systemd[1]: Started Terminate Plymouth Boot Screen. Dec 26 15:35:43 volumio-nano systemd[1]: plymouth-quit-wait.service: Succeeded. Dec 26 15:35:43 volumio-nano systemd[1]: Started Hold until boot process finishes up. Dec 26 15:35:43 volumio-nano systemd[1]: Received SIGRTMIN+21 from PID 193 (n/a). Dec 26 15:35:43 volumio-nano ifplugd(eth0)[822]: ifplugd 0.28 initializing. Dec 26 15:35:43 volumio-nano ifplugd(eth0)[822]: Using interface eth0/DC:A6:32:5E:58:53 with driver (version: 6.6.62-v7l+) Dec 26 15:35:43 volumio-nano systemd[1]: Started Getty on tty1. Dec 26 15:35:43 volumio-nano ifplugd(eth0)[822]: Using detection mode: SIOCETHTOOL Dec 26 15:35:43 volumio-nano systemd[1]: Reached target Login Prompts. Dec 26 15:35:43 volumio-nano ifplugd(eth0)[822]: Initialization complete, link beat not detected. Dec 26 15:35:43 volumio-nano ntpd[792]: ntpd 4.2.8p12@1.3728-o (1): Starting Dec 26 15:35:43 volumio-nano ntpd[792]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Dec 26 15:35:43 volumio-nano systemd[1]: Started Network Time Service. Dec 26 15:35:43 volumio-nano ntpd[824]: proto: precision = 0.815 usec (-20) Dec 26 15:35:43 volumio-nano sshd[823]: Server listening on 0.0.0.0 port 22. Dec 26 15:35:43 volumio-nano sshd[823]: Server listening on :: port 22. Dec 26 15:35:43 volumio-nano systemd[1]: Started OpenBSD Secure Shell server. Dec 26 15:35:43 volumio-nano ntpd[824]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Dec 26 15:35:43 volumio-nano ntpd[824]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Dec 26 15:35:43 volumio-nano ntpd[824]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 364 days ago Dec 26 15:35:43 volumio-nano ntpd[824]: Listen and drop on 0 v6wildcard [::]:123 Dec 26 15:35:43 volumio-nano ntpd[824]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Dec 26 15:35:43 volumio-nano ntpd[824]: Listen normally on 2 lo 127.0.0.1:123 Dec 26 15:35:43 volumio-nano ntpd[824]: Listening on routing socket on fd #19 for interface updates Dec 26 15:35:43 volumio-nano ntpd[824]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 26 15:35:43 volumio-nano ntpd[824]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 26 15:35:43 volumio-nano ifplugd[794]: Network Interface Plugging Daemon...start eth0...done. Dec 26 15:35:43 volumio-nano systemd[1]: Started LSB: Brings up/down network automatically. Dec 26 15:35:44 volumio-nano kernel: export_store: invalid GPIO 6 Dec 26 15:35:44 volumio-nano systemd[1]: nanosound_oled.service: Main process exited, code=exited, status=1/FAILURE Dec 26 15:35:44 volumio-nano systemd[1]: nanosound_oled.service: Failed with result 'exit-code'. Dec 26 15:35:44 volumio-nano systemd[1]: nanosound_lirc.service: Main process exited, code=exited, status=1/FAILURE Dec 26 15:35:44 volumio-nano systemd[1]: nanosound_lirc.service: Failed with result 'exit-code'. Dec 26 15:35:44 volumio-nano nmbd[799]: [2025/12/26 15:35:44.315618, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Dec 26 15:35:44 volumio-nano nmbd[799]: started asyncdns process 828 Dec 26 15:35:44 volumio-nano nmbd[799]: [2025/12/26 15:35:44.317198, 0] ../lib/util/become_daemon.c:149(daemon_status) Dec 26 15:35:44 volumio-nano nmbd[799]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Dec 26 15:35:44 volumio-nano nmbd[799]: [2025/12/26 15:35:44.317330, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Dec 26 15:35:44 volumio-nano nmbd[799]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Dec 26 15:35:44 volumio-nano wireless.js[609]: Cleaning previous... Dec 26 15:35:44 volumio-nano sudo[836]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Dec 26 15:35:44 volumio-nano sudo[836]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:44 volumio-nano sudo[836]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:44 volumio-nano sudo[838]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Dec 26 15:35:44 volumio-nano sudo[838]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:45 volumio-nano ntpd[824]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Dec 26 15:35:45 volumio-nano sudo[838]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:45 volumio-nano wireless.js[609]: Stopped aP Dec 26 15:35:45 volumio-nano sudo[845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 26 15:35:45 volumio-nano sudo[845]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:45 volumio-nano sudo[845]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:45 volumio-nano kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 26 15:35:45 volumio-nano sudo[847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 26 15:35:45 volumio-nano sudo[847]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:45 volumio-nano sudo[847]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:45 volumio-nano sudo[854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 26 15:35:45 volumio-nano sudo[854]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:45 volumio-nano sudo[854]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:45 volumio-nano sudo[856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 26 15:35:45 volumio-nano sudo[856]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:45 volumio-nano ntpd[824]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Dec 26 15:35:46 volumio-nano systemd[1]: systemd-rfkill.service: Succeeded. Dec 26 15:35:46 volumio-nano ntpd[824]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Dec 26 15:35:47 volumio-nano sudo[856]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:47 volumio-nano wireless.js[609]: SETTING APPROPRIATE REG DOMAIN: DE Dec 26 15:35:47 volumio-nano sudo[861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 26 15:35:47 volumio-nano sudo[861]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:47 volumio-nano sudo[861]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:47 volumio-nano sudo[863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Dec 26 15:35:47 volumio-nano sudo[863]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:47 volumio-nano sudo[863]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:47 volumio-nano wireless.js[609]: SUCCESSFULLY SET NEW REGDOMAIN: DE Dec 26 15:35:47 volumio-nano wireless.js[609]: Start wireless flow Dec 26 15:35:47 volumio-nano wireless.js[609]: Stopped hotspot (if there).. Dec 26 15:35:47 volumio-nano sudo[868]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Dec 26 15:35:47 volumio-nano sudo[868]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:47 volumio-nano sudo[868]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:47 volumio-nano volumio-remote-updater[599]: [2025-12-26 15:35:47] [info] asio async_connect error: system:111 (Connection refused) Dec 26 15:35:47 volumio-nano volumio-remote-updater[599]: [2025-12-26 15:35:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 26 15:35:47 volumio-nano volumio-remote-updater[599]: [2025-12-26 15:35:47] [error] handle_connect error: Underlying Transport Error Dec 26 15:35:47 volumio-nano sudo[870]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Dec 26 15:35:47 volumio-nano sudo[870]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:47 volumio-nano volumio-time-update[598]: volumio-time-update-util: Fetching time from Volumio... Dec 26 15:35:47 volumio-nano volumio-time-update[598]: volumio-time-update-util: Date not found in response Dec 26 15:35:47 volumio-nano volumio-time-update[598]: volumio-time-update-util: Retrying in 5 seconds... Dec 26 15:35:47 volumio-nano ntpd[824]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Dec 26 15:35:47 volumio-nano bthelper[672]: Changing power off succeeded Dec 26 15:35:48 volumio-nano bthelper[672]: [CHG] Controller DC:A6:32:5E:58:57 Class: 0x0000041c Dec 26 15:35:48 volumio-nano bthelper[672]: Changing power on succeeded Dec 26 15:35:48 volumio-nano sudo[870]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:48 volumio-nano wireless.js[609]: DHCP IP Dec 26 15:35:48 volumio-nano wireless.js[609]: Start ap Dec 26 15:35:48 volumio-nano wpa_supplicant[885]: Successfully initialized wpa_supplicant Dec 26 15:35:48 volumio-nano sudo[886]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Dec 26 15:35:48 volumio-nano sudo[886]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:48 volumio-nano dhcpcd[887]: dev: loaded udev Dec 26 15:35:48 volumio-nano kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 26 15:35:48 volumio-nano dhcpcd-run-hooks[905]: wlan0: starting wpa_supplicant Dec 26 15:35:48 volumio-nano dhcpcd-run-hooks[910]: wlan0: failed to start wpa_supplicant Dec 26 15:35:48 volumio-nano dhcpcd-run-hooks[911]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Dec 26 15:35:48 volumio-nano dhcpcd[887]: wlan0: connected to Access Point `' Dec 26 15:35:48 volumio-nano dhcpcd[887]: no interfaces have a carrier Dec 26 15:35:48 volumio-nano dhcpcd[887]: forked to background, child pid 921 Dec 26 15:35:48 volumio-nano dhcpcd[921]: eth0: waiting for carrier Dec 26 15:35:48 volumio-nano dhcpcd[921]: wlan0: waiting for carrier Dec 26 15:35:48 volumio-nano sudo[886]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:49 volumio-nano wireless.js[609]: trying... Dec 26 15:35:49 volumio-nano sudo[923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:35:49 volumio-nano sudo[923]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:49 volumio-nano sudo[923]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:50 volumio-nano wireless.js[609]: trying... Dec 26 15:35:50 volumio-nano sudo[926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:35:50 volumio-nano sudo[926]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:50 volumio-nano sudo[926]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:51 volumio-nano wireless.js[609]: trying... Dec 26 15:35:51 volumio-nano sudo[929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:35:51 volumio-nano sudo[929]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:51 volumio-nano sudo[929]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:52 volumio-nano wireless.js[609]: trying... Dec 26 15:35:52 volumio-nano sudo[932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:35:52 volumio-nano sudo[932]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:52 volumio-nano sudo[932]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:52 volumio-nano volumio-time-update[598]: volumio-time-update-util: Fetching time from Volumio... Dec 26 15:35:52 volumio-nano volumio-time-update[598]: volumio-time-update-util: Date not found in response Dec 26 15:35:52 volumio-nano volumio-time-update[598]: volumio-time-update-util: Retrying in 5 seconds... Dec 26 15:35:53 volumio-nano wireless.js[609]: trying... Dec 26 15:35:53 volumio-nano sudo[940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:35:53 volumio-nano sudo[940]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:53 volumio-nano sudo[940]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:54 volumio-nano wireless.js[609]: trying... Dec 26 15:35:54 volumio-nano sudo[943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:35:54 volumio-nano sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:54 volumio-nano sudo[943]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:54 volumio-nano wpa_supplicant[909]: wlan0: Trying to associate with SSID 'uha-buero' Dec 26 15:35:54 volumio-nano dhcpcd[921]: wlan0: carrier acquired Dec 26 15:35:54 volumio-nano dhcpcd[921]: wlan0: connected to Access Point `uha-buero' Dec 26 15:35:54 volumio-nano wpa_supplicant[909]: wlan0: Associated with 62:b5:8d:01:0a:00 Dec 26 15:35:54 volumio-nano wpa_supplicant[909]: wlan0: CTRL-EVENT-CONNECTED - Connection to 62:b5:8d:01:0a:00 completed [id=0 id_str=] Dec 26 15:35:54 volumio-nano wpa_supplicant[909]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Dec 26 15:35:54 volumio-nano wpa_supplicant[909]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Dec 26 15:35:54 volumio-nano dhcpcd[921]: DUID 00:01:00:01:2a:5e:eb:92:dc:a6:32:5e:58:55 Dec 26 15:35:54 volumio-nano dhcpcd[921]: wlan0: IAID 32:5e:58:55 Dec 26 15:35:54 volumio-nano dhcpcd[921]: wlan0: adding address fe80::dea6:32ff:fe5e:5855 Dec 26 15:35:54 volumio-nano dhcpcd[921]: ipv6_addaddr1: Permission denied Dec 26 15:35:54 volumio-nano dhcpcd[921]: wlan0: carrier lost Dec 26 15:35:54 volumio-nano dhcpcd[921]: wlan0: carrier acquired Dec 26 15:35:54 volumio-nano dhcpcd[921]: wlan0: IAID 32:5e:58:55 Dec 26 15:35:54 volumio-nano dhcpcd[921]: wlan0: soliciting an IPv6 router Dec 26 15:35:55 volumio-nano dhcpcd[921]: wlan0: rebinding lease of 10.10.11.123 Dec 26 15:35:55 volumio-nano dhcpcd[921]: wlan0: probing address 10.10.11.123/24 Dec 26 15:35:55 volumio-nano wpa_supplicant[909]: RRM: Ignoring radio measurement request: Not RRM network Dec 26 15:35:55 volumio-nano volumio-remote-updater[599]: [2025-12-26 15:35:55] [info] asio async_connect error: system:111 (Connection refused) Dec 26 15:35:55 volumio-nano volumio-remote-updater[599]: [2025-12-26 15:35:55] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 26 15:35:55 volumio-nano volumio-remote-updater[599]: [2025-12-26 15:35:55] [error] handle_connect error: Underlying Transport Error Dec 26 15:35:55 volumio-nano wireless.js[609]: trying... Dec 26 15:35:55 volumio-nano sudo[958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:35:55 volumio-nano sudo[958]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:55 volumio-nano sudo[958]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:56 volumio-nano wireless.js[609]: trying... Dec 26 15:35:56 volumio-nano sudo[961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:35:56 volumio-nano sudo[961]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:56 volumio-nano sudo[961]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:57 volumio-nano wireless.js[609]: trying... Dec 26 15:35:57 volumio-nano sudo[964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:35:57 volumio-nano sudo[964]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:57 volumio-nano sudo[964]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:57 volumio-nano volumio-time-update[598]: volumio-time-update-util: Fetching time from Volumio... Dec 26 15:35:57 volumio-nano volumio-time-update[598]: volumio-time-update-util: Date not found in response Dec 26 15:35:57 volumio-nano volumio-time-update[598]: volumio-time-update-util: Retrying in 5 seconds... Dec 26 15:35:58 volumio-nano wireless.js[609]: trying... Dec 26 15:35:58 volumio-nano sudo[972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:35:58 volumio-nano sudo[972]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:58 volumio-nano sudo[972]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:59 volumio-nano wireless.js[609]: trying... Dec 26 15:35:59 volumio-nano sudo[975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:35:59 volumio-nano sudo[975]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:35:59 volumio-nano sudo[975]: pam_unix(sudo:session): session closed for user root Dec 26 15:35:59 volumio-nano dhcpcd[921]: wlan0: leased 10.10.11.123 for 864000 seconds Dec 26 15:35:59 volumio-nano avahi-daemon[617]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.10.11.123. Dec 26 15:35:59 volumio-nano dhcpcd[921]: wlan0: adding route to 10.10.11.0/24 Dec 26 15:35:59 volumio-nano avahi-daemon[617]: New relevant interface wlan0.IPv4 for mDNS. Dec 26 15:35:59 volumio-nano dhcpcd[921]: wlan0: adding default route via 10.10.11.98 Dec 26 15:35:59 volumio-nano avahi-daemon[617]: Registering new address record for 10.10.11.123 on wlan0.IPv4. Dec 26 15:35:59 volumio-nano systemd[1]: Stopping Network Time Service... Dec 26 15:35:59 volumio-nano ntpd[824]: ntpd exiting on signal 15 (Terminated) Dec 26 15:35:59 volumio-nano systemd[1]: ntp.service: Succeeded. Dec 26 15:35:59 volumio-nano systemd[1]: Stopped Network Time Service. Dec 26 15:35:59 volumio-nano systemd[1]: Starting Network Time Service... Dec 26 15:35:59 volumio-nano ntpd[1008]: ntpd 4.2.8p12@1.3728-o (1): Starting Dec 26 15:35:59 volumio-nano ntpd[1008]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 Dec 26 15:35:59 volumio-nano systemd[1]: Started Network Time Service. Dec 26 15:35:59 volumio-nano ntpd[1014]: proto: precision = 0.815 usec (-20) Dec 26 15:35:59 volumio-nano ntpd[1014]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Dec 26 15:35:59 volumio-nano ntpd[1014]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Dec 26 15:35:59 volumio-nano ntpd[1014]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 364 days ago Dec 26 15:35:59 volumio-nano ntpd[1014]: Listen and drop on 0 v6wildcard [::]:123 Dec 26 15:35:59 volumio-nano ntpd[1014]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Dec 26 15:35:59 volumio-nano ntpd[1014]: Listen normally on 2 lo 127.0.0.1:123 Dec 26 15:35:59 volumio-nano ntpd[1014]: Listen normally on 3 wlan0 10.10.11.123:123 Dec 26 15:35:59 volumio-nano ntpd[1014]: Listening on routing socket on fd #20 for interface updates Dec 26 15:35:59 volumio-nano ntpd[1014]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 26 15:35:59 volumio-nano ntpd[1014]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 26 15:36:00 volumio-nano wireless.js[609]: trying... Dec 26 15:36:00 volumio-nano sudo[1017]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 15:36:00 volumio-nano sudo[1017]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:00 volumio-nano sudo[1017]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:00 volumio-nano wireless.js[609]: Connected to: ----uha-buero Dec 26 15:36:00 volumio-nano wireless.js[609]: ---- Dec 26 15:36:00 volumio-nano sudo[1020]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 15:36:00 volumio-nano sudo[1020]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:00 volumio-nano sudo[1020]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:00 volumio-nano wireless.js[609]: ... joined AP, wlan0 IPv4 is 10.10.11.123, ipV6 is undefined Dec 26 15:36:00 volumio-nano wireless.js[609]: It's done! AP Dec 26 15:36:00 volumio-nano kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 26 15:36:00 volumio-nano systemd[1]: Started Wireless Services. Dec 26 15:36:00 volumio-nano systemd[1]: Started Volumio Backend Module. Dec 26 15:36:00 volumio-nano systemd[1]: Started Volumio Cpu Tweaker. Dec 26 15:36:00 volumio-nano volumio-cpu-tweak[1027]: Setting RT Priority for mpd Dec 26 15:36:00 volumio-nano volumio-cpu-tweak[1027]: pid 35's current scheduling policy: SCHED_OTHER Dec 26 15:36:00 volumio-nano volumio-cpu-tweak[1027]: pid 35's current scheduling priority: 0 Dec 26 15:36:00 volumio-nano volumio-cpu-tweak[1027]: Setting MPD Affinity Dec 26 15:36:00 volumio-nano volumio-cpu-tweak[1027]: pid 3's current affinity mask: f Dec 26 15:36:00 volumio-nano volumio-cpu-tweak[1027]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Dec 26 15:36:00 volumio-nano volumio-cpu-tweak[1027]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Dec 26 15:36:00 volumio-nano systemd[1]: volumio_cpu_tweak.service: Succeeded. Dec 26 15:36:00 volumio-nano ntpd[1014]: Soliciting pool server 46.4.54.78 Dec 26 15:36:01 volumio-nano ntpd[1014]: Soliciting pool server 45.92.216.108 Dec 26 15:36:01 volumio-nano ntpd[1014]: Soliciting pool server 49.13.223.236 Dec 26 15:36:02 volumio-nano volumio[1026]: info: ------------------------------------------- Dec 26 15:36:02 volumio-nano volumio[1026]: info: ----- Volumio3 ---- Dec 26 15:36:02 volumio-nano volumio[1026]: info: ------------------------------------------- Dec 26 15:36:02 volumio-nano volumio[1026]: info: ----- System startup ---- Dec 26 15:36:02 volumio-nano volumio[1026]: info: ------------------------------------------- Dec 26 15:36:02 volumio-nano ntpd[1014]: Soliciting pool server 85.215.166.214 Dec 26 15:36:02 volumio-nano ntpd[1014]: Soliciting pool server 116.203.244.102 Dec 26 15:36:02 volumio-nano ntpd[1014]: Soliciting pool server 62.128.1.19 Dec 26 15:36:02 volumio-nano volumio[1026]: info: MYVOLUMIO Environment detected Dec 26 15:36:02 volumio-nano volumio-time-update[598]: volumio-time-update-util: Fetching time from Volumio... Dec 26 15:36:02 volumio-nano volumio[1026]: info: Plugin folders cleanup Dec 26 15:36:02 volumio-nano volumio[1026]: info: Scanning into folder /volumio/app/plugins/ Dec 26 15:36:02 volumio-nano volumio[1026]: info: Scanning category audio_interface Dec 26 15:36:02 volumio-nano volumio[1026]: info: Scanning category miscellanea Dec 26 15:36:02 volumio-nano volumio[1026]: info: Scanning category music_service Dec 26 15:36:02 volumio-nano volumio[1026]: info: Scanning category plugins.json Dec 26 15:36:02 volumio-nano volumio[1026]: info: Scanning category system_controller Dec 26 15:36:02 volumio-nano volumio[1026]: info: Scanning category user_interface Dec 26 15:36:02 volumio-nano volumio[1026]: info: Scanning into folder /data/plugins/ Dec 26 15:36:02 volumio-nano volumio[1026]: info: Scanning category audio_interface Dec 26 15:36:02 volumio-nano volumio[1026]: info: Scanning category miscellanea Dec 26 15:36:02 volumio-nano volumio[1026]: info: Plugin folders cleanup completed Dec 26 15:36:02 volumio-nano volumio[1026]: info: ------------------------------------------- Dec 26 15:36:02 volumio-nano volumio[1026]: info: ----- Core plugins startup ---- Dec 26 15:36:02 volumio-nano volumio[1026]: info: ------------------------------------------- Dec 26 15:36:02 volumio-nano volumio[1026]: info: Loading plugins from folder /volumio/app/plugins/ Dec 26 15:36:02 volumio-nano volumio[1026]: info: Adding plugin upnp to MyMusic Plugins Dec 26 15:36:02 volumio-nano volumio[1026]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 26 15:36:02 volumio-nano volumio[1026]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 26 15:36:02 volumio-nano volumio[1026]: info: Loading plugins from folder /data/plugins/ Dec 26 15:36:02 volumio-nano volumio[1026]: info: Loading plugin "system"... Dec 26 15:36:02 volumio-nano volumio-time-update[598]: volumio-time-update-util: Setting system time to: 2025-12-26 15:36:29 Dec 26 15:36:02 volumio-nano sudo[1058]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-12-26 15:36:29 Dec 26 15:36:02 volumio-nano sudo[1058]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:02 volumio-nano volumio[1026]: info: Loading plugin "appearance"... Dec 26 15:36:02 volumio-nano dbus-daemon[619]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.9' (uid=0 pid=1062 comm="timedatectl set-time 2025-12-26 15:36:29 ") Dec 26 15:36:03 volumio-nano systemd[1]: Starting Time & Date Service... Dec 26 15:36:03 volumio-nano dbus-daemon[619]: [system] Successfully activated service 'org.freedesktop.timedate1' Dec 26 15:36:03 volumio-nano systemd[1]: Started Time & Date Service. Dec 26 15:36:29 volumio-nano systemd-timedated[1063]: Changed local time to Fri Dec 26 15:36:29 2025 Dec 26 15:36:29 volumio-nano sudo[1058]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:29 volumio-nano volumio-time-update[598]: volumio-time-update-util: System time updated successfully. Dec 26 15:36:29 volumio-nano systemd[1]: Started Volumio Time Update Utility. Dec 26 15:36:29 volumio-nano ntpd[1014]: Soliciting pool server 78.46.87.46 Dec 26 15:36:29 volumio-nano ntpd[1014]: Soliciting pool server 162.159.200.123 Dec 26 15:36:29 volumio-nano ntpd[1014]: Soliciting pool server 144.76.162.246 Dec 26 15:36:29 volumio-nano ntpd[1014]: Soliciting pool server 37.120.190.215 Dec 26 15:36:29 volumio-nano volumio[1026]: info: Loading plugin "network"... Dec 26 15:36:29 volumio-nano volumio[1026]: info: Refreshing Cached IP Addresses Dec 26 15:36:29 volumio-nano sudo[1065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 15:36:29 volumio-nano sudo[1065]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:29 volumio-nano sudo[1065]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:29 volumio-nano sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 15:36:29 volumio-nano sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:29 volumio-nano sudo[1067]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:29 volumio-nano volumio[1026]: info: Loading plugin "services"... Dec 26 15:36:29 volumio-nano volumio[1026]: info: Loading plugin "alsa_controller"... Dec 26 15:36:29 volumio-nano sudo[1076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 26 15:36:29 volumio-nano sudo[1076]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:29 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 15:36:29 volumio-nano volumio[1026]: info: Loading plugin "wizard"... Dec 26 15:36:29 volumio-nano volumio[1026]: info: Loading plugin "networkfs"... Dec 26 15:36:29 volumio-nano volumio[1026]: info: Starting Udev Watcher for removable devices Dec 26 15:36:29 volumio-nano sudo[1093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=mmedia,password=mmedia,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.10.11.100/Archiv_Audio /mnt/NAS/Archiv_Audio Dec 26 15:36:29 volumio-nano sudo[1093]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:30 volumio-nano volumio[1026]: info: Ignoring mount for partition: BOOT Dec 26 15:36:30 volumio-nano volumio[1026]: info: Ignoring mount for partition: volumio Dec 26 15:36:30 volumio-nano volumio[1026]: info: Ignoring mount for partition: volumio_data Dec 26 15:36:30 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 15:36:30 volumio-nano volumio[1026]: info: Loading plugin "volumio_command_line_client"... Dec 26 15:36:30 volumio-nano volumio[1026]: info: Loading plugin "upnp"... Dec 26 15:36:30 volumio-nano volumio[1026]: info: [1766759790050] Starting Upmpd Daemon Dec 26 15:36:30 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 15:36:30 volumio-nano volumio[1026]: info: Loading plugin "my_music"... Dec 26 15:36:30 volumio-nano volumio[1026]: info: Loading plugin "mpd"... Dec 26 15:36:30 volumio-nano kernel: Key type cifs.spnego registered Dec 26 15:36:30 volumio-nano kernel: Key type cifs.idmap registered Dec 26 15:36:30 volumio-nano kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Dec 26 15:36:30 volumio-nano kernel: CIFS: Attempting to mount //10.10.11.100/Archiv_Audio Dec 26 15:36:30 volumio-nano nmbd[799]: [2025/12/26 15:36:30.164391, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 26 15:36:30 volumio-nano nmbd[799]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Dec 26 15:36:30 volumio-nano systemd[1]: Started Samba NMB Daemon. Dec 26 15:36:30 volumio-nano systemd[1]: Starting Samba Winbind Daemon... Dec 26 15:36:30 volumio-nano kernel: cryptd: max_cpu_qlen set to 1000 Dec 26 15:36:30 volumio-nano volumio[1026]: info: Loading plugin "upnp_browser"... Dec 26 15:36:30 volumio-nano winbindd[1117]: [2025/12/26 15:36:30.497146, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Dec 26 15:36:30 volumio-nano winbindd[1117]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 26 15:36:30 volumio-nano winbindd[1117]: [2025/12/26 15:36:30.520574, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 26 15:36:30 volumio-nano systemd[1]: Started Samba Winbind Daemon. Dec 26 15:36:30 volumio-nano winbindd[1117]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Dec 26 15:36:30 volumio-nano ntpd[1014]: Soliciting pool server 139.144.71.56 Dec 26 15:36:30 volumio-nano ntpd[1014]: Soliciting pool server 168.119.211.223 Dec 26 15:36:30 volumio-nano ntpd[1014]: Soliciting pool server 212.132.97.26 Dec 26 15:36:30 volumio-nano systemd[1]: Starting Samba SMB Daemon... Dec 26 15:36:30 volumio-nano sudo[1093]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:30 volumio-nano volumio[1026]: info: Starting UPNP Browser Dec 26 15:36:30 volumio-nano volumio[1026]: info: Loading plugin "alarm-clock"... Dec 26 15:36:30 volumio-nano smbd[1139]: [2025/12/26 15:36:30.918206, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 26 15:36:30 volumio-nano smbd[1139]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Dec 26 15:36:30 volumio-nano systemd[1]: Started Samba SMB Daemon. Dec 26 15:36:30 volumio-nano systemd[1]: Reached target Multi-User System. Dec 26 15:36:30 volumio-nano systemd[1]: Reached target Graphical Interface. Dec 26 15:36:30 volumio-nano systemd[1]: Started Argon One Fan and Button Service. Dec 26 15:36:31 volumio-nano systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "airplay_emulation"... Dec 26 15:36:31 volumio-nano volumio[1026]: info: Starting Shairport Sync Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "last_100"... Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "webradio"... Dec 26 15:36:31 volumio-nano systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 26 15:36:31 volumio-nano systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 26 15:36:31 volumio-nano systemd[1]: Startup finished in 12.613s (kernel) + 26.201s (userspace) = 38.815s. Dec 26 15:36:31 volumio-nano volumio-remote-updater[599]: [2025-12-26 15:36:31] [connect] Successful connection Dec 26 15:36:31 volumio-nano kernel: export_store: invalid GPIO 4 Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "i2s_dacs"... Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "volumiodiscovery"... Dec 26 15:36:31 volumio-nano volumio[1026]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 26 15:36:31 volumio-nano volumio[1026]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 15:36:31 volumio-nano volumio[1026]: *** WARNING *** For more information see Dec 26 15:36:31 volumio-nano node[1026]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 26 15:36:31 volumio-nano volumio[1026]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 26 15:36:31 volumio-nano volumio[1026]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 15:36:31 volumio-nano volumio[1026]: *** WARNING *** For more information see Dec 26 15:36:31 volumio-nano node[1026]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 15:36:31 volumio-nano node[1026]: *** WARNING *** For more information see Dec 26 15:36:31 volumio-nano node[1026]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 26 15:36:31 volumio-nano node[1026]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 15:36:31 volumio-nano node[1026]: *** WARNING *** For more information see Dec 26 15:36:31 volumio-nano volumio[1026]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 26 15:36:31 volumio-nano volumio[1026]: info: Discovery: Started advertising with name: Volumio-Nano Dec 26 15:36:31 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "outputs"... Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "albumart"... Dec 26 15:36:31 volumio-nano volumio[1026]: info: Plugin example_plugin is not enabled Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "inputs"... Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "updater_comm"... Dec 26 15:36:31 volumio-nano volumio[1026]: info: Plugin mpdemulation is not enabled Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "rest_api"... Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "websocket"... Dec 26 15:36:31 volumio-nano volumio[1026]: Forking 3 albumart workers Dec 26 15:36:31 volumio-nano volumio[1026]: info: Starting Socket.io Server version 2.3.0 Dec 26 15:36:31 volumio-nano volumio[1026]: info: Loading plugin "fusiondsp"... Dec 26 15:36:31 volumio-nano ntpd[1014]: Soliciting pool server 162.159.200.1 Dec 26 15:36:31 volumio-nano ntpd[1014]: Soliciting pool server 202.61.195.221 Dec 26 15:36:31 volumio-nano volumio[1026]: info: Applying required configuration parameters for plugin fusiondsp Dec 26 15:36:32 volumio-nano volumio[1026]: Starting albumart workers Dec 26 15:36:32 volumio-nano volumio[1026]: Starting albumart workers Dec 26 15:36:32 volumio-nano volumio[1026]: info: Loading plugin "nanosound"... Dec 26 15:36:32 volumio-nano volumio[1026]: Starting albumart workers Dec 26 15:36:32 volumio-nano ntpd[1014]: Soliciting pool server 129.250.35.251 Dec 26 15:36:32 volumio-nano ntpd[1014]: Soliciting pool server 2a01:4f8:261:4d07::1 Dec 26 15:36:32 volumio-nano volumio[1026]: info: Starting NanoSound Plug-in Dec 26 15:36:32 volumio-nano volumio[1026]: info: Applying required configuration parameters for plugin nanosound Dec 26 15:36:32 volumio-nano volumio[1026]: info: Starting NanoSound Dec 26 15:36:32 volumio-nano volumio[1026]: info: Loading i18n strings for locale de Dec 26 15:36:32 volumio-nano volumio[1026]: Updating browse sources language Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::initPlayerControls Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 15:36:32 volumio-nano volumio[1026]: Express server listening on port 3000 Dec 26 15:36:32 volumio-nano volumio[1026]: [Metrics] WebUI: 5s 611.02ms Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreStateMachine::resetVolumioState Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreStateMachine::getcurrentVolume Dec 26 15:36:32 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 15:36:32 volumio-nano volumio[1026]: info: Volumio Network Manager: Network status updated: 2 Dec 26 15:36:33 volumio-nano volumio-remote-updater[599]: [2025-12-26 15:36:33] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766759791 101 Dec 26 15:36:33 volumio-nano sudo[1076]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:33 volumio-nano volumio[1026]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Dec 26 15:36:33 volumio-nano volumio[1026]: verbose: New Socket.io Connection to 10.10.11.123:3000 from 10.10.11.117 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Dec 26 15:36:33 volumio-nano volumio[1026]: verbose: New Socket.io Connection to 10.10.11.123:3000 from 10.10.11.119 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 26 15:36:33 volumio-nano volumio[1026]: 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 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: Reloading queue from file Dec 26 15:36:33 volumio-nano volumio[1026]: info: Setting Device type: Raspberry PI Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreStateMachine::setRepeat null single undefined Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreStateMachine::pushState Dec 26 15:36:33 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioPushState Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreStateMachine::setRandom false Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreStateMachine::pushState Dec 26 15:36:33 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioPushState Dec 26 15:36:33 volumio-nano volumio[1026]: info: VolumeController:: Volume=0 Mute =true Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreStateMachine::pushState Dec 26 15:36:33 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioPushState Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreStateMachine::updateTrackBlock Dec 26 15:36:33 volumio-nano volumio[1026]: info: CorePlayQueue::getTrackBlock Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 15:36:33 volumio-nano volumio[1026]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 26 15:36:33 volumio-nano volumio[1026]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03111 Dec 26 15:36:33 volumio-nano volumio[1026]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Dec 26 15:36:33 volumio-nano volumio[1026]: info: Discovery: adding 7dffdc1d-e743-4b64-aa02-f475b96e89f1 Dec 26 15:36:33 volumio-nano volumio[1026]: info: Discovery: Found device Volumio-Nano Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioGetState Dec 26 15:36:33 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:33 volumio-nano volumio[1026]: info: Discovery: adding e85f0ecf-1007-4717-ae70-fee7266851dc Dec 26 15:36:33 volumio-nano volumio[1026]: info: Discovery: Found device VolumioWecker Dec 26 15:36:33 volumio-nano volumio[1026]: info: Discovery: Connecting to remote: 10.10.11.117 Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioGetState Dec 26 15:36:33 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:33 volumio-nano volumio[1026]: info: VolumeController:: Volume=0 Mute =true Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreStateMachine::pushState Dec 26 15:36:33 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioPushState Dec 26 15:36:33 volumio-nano volumio[1026]: info: Completed loading Core Plugins Dec 26 15:36:33 volumio-nano volumio[1026]: info: Preparing to generate the ALSA configuration file Dec 26 15:36:33 volumio-nano volumio[1026]: info: Discovery: adding 40c8af57-15a1-42f4-a7ab-76f112d8219f Dec 26 15:36:33 volumio-nano volumio[1026]: info: Discovery: Found device VolumioBoss Dec 26 15:36:33 volumio-nano volumio[1026]: info: Discovery: Connecting to remote: 10.10.11.119 Dec 26 15:36:33 volumio-nano volumio[1026]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 26 15:36:33 volumio-nano volumio[1026]: info: Reading ALSA contributions from plugins. Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioGetState Dec 26 15:36:33 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:33 volumio-nano volumio[1026]: info: Asound.conf file written Dec 26 15:36:33 volumio-nano sudo[1224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 26 15:36:33 volumio-nano sudo[1224]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:33 volumio-nano sudo[1224]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:33 volumio-nano volumio[1026]: info: Output device has changed, restarting MPD Dec 26 15:36:33 volumio-nano volumio[1026]: info: Output device has changed, restarting Shairport Sync Dec 26 15:36:33 volumio-nano sudo[1229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano sudo[1229]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:33 volumio-nano sudo[1229]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:33 volumio-nano sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 15:36:33 volumio-nano sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:33 volumio-nano volumio[1026]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 15:36:33 volumio-nano volumio[1026]: info: ___________ START PLUGINS ___________ Dec 26 15:36:33 volumio-nano volumio[1026]: info: ControllerMpd::onStart: Initializing MPD Dec 26 15:36:33 volumio-nano volumio[1026]: info: Creating MPD Configuration file Dec 26 15:36:33 volumio-nano sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 15:36:33 volumio-nano sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 15:36:33 volumio-nano volumio[1026]: info: [1766759793487] CoreMusicLibrary::Adding element Medienserver Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 15:36:33 volumio-nano volumio[1026]: info: UPNP Browser: Client initialized successfully Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:33 volumio-nano sudo[1239]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:33 volumio-nano sudo[1241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 15:36:33 volumio-nano sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:33 volumio-nano systemd[1]: Listening on mpd.socket. Dec 26 15:36:33 volumio-nano systemd[1]: Starting Music Player Daemon... Dec 26 15:36:33 volumio-nano volumio[1026]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 15:36:33 volumio-nano systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 26 15:36:33 volumio-nano systemd[1]: mpd.service: Succeeded. Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:33 volumio-nano systemd[1]: Stopped Music Player Daemon. Dec 26 15:36:33 volumio-nano systemd[1]: Starting Music Player Daemon... Dec 26 15:36:33 volumio-nano volumio[1026]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 15:36:33 volumio-nano volumio[1026]: info: [1766759793572] CoreMusicLibrary::Adding element Last_100 Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 15:36:33 volumio-nano volumio[1026]: info: [1766759793574] CoreMusicLibrary::Adding element Webradio Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 15:36:33 volumio-nano volumio[1026]: info: Initializing BBC Radios Dec 26 15:36:33 volumio-nano sudo[1248]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 26 15:36:33 volumio-nano sudo[1248]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:33 volumio-nano sudo[1248]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 26 15:36:33 volumio-nano sudo[1248]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: Loading i18n strings for locale de Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: FusionDsp - mixtype--------------------- Hardware Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:33 volumio-nano sudo[1265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop nanosound_lirc Dec 26 15:36:33 volumio-nano volumio[1026]: info: NanoSound - Creating button triggers Dec 26 15:36:33 volumio-nano kernel: export_store: invalid GPIO 16 Dec 26 15:36:33 volumio-nano volumio[1026]: info: NanoSound - Creating button triggers for DAC2 Dec 26 15:36:33 volumio-nano volumio[1026]: info: playPause on pin 16 Dec 26 15:36:33 volumio-nano volumio[1026]: error: Plugin nanosound failed to start! Error: EINVAL: invalid argument, write Dec 26 15:36:33 volumio-nano sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:33 volumio-nano volumio[1026]: info: Cannot retrieve data for calling home Dec 26 15:36:33 volumio-nano sudo[1267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop nanosound_rotary Dec 26 15:36:33 volumio-nano sudo[1267]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:33 volumio-nano sudo[1265]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:33 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_rotary.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 26 15:36:33 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_rotary.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Dec 26 15:36:33 volumio-nano volumio[1026]: info: Preparing to generate the ALSA configuration file Dec 26 15:36:33 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_rotary.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 26 15:36:33 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_rotary.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Dec 26 15:36:33 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_rotary.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 26 15:36:33 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_rotary.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Dec 26 15:36:33 volumio-nano sudo[1267]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:33 volumio-nano volumio[1026]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 26 15:36:33 volumio-nano volumio[1026]: info: Reading ALSA contributions from plugins. Dec 26 15:36:33 volumio-nano volumio[1026]: info: Discovery: Connected to remote: 10.10.11.119 Dec 26 15:36:33 volumio-nano volumio[1026]: info: MPD Permissions set Dec 26 15:36:33 volumio-nano volumio[1026]: info: MPD Permissions set Dec 26 15:36:33 volumio-nano volumio[1026]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:33 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:34 volumio-nano volumio[1026]: info: Discovery: Connected to remote: 10.10.11.117 Dec 26 15:36:34 volumio-nano volumio[1026]: info: Starting Shairport Sync Dec 26 15:36:34 volumio-nano volumio[1026]: info: Starting Shairport Sync Dec 26 15:36:34 volumio-nano volumio[1026]: info: Starting Shairport Sync Dec 26 15:36:34 volumio-nano sudo[1279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 15:36:34 volumio-nano sudo[1279]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:34 volumio-nano sudo[1281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioGetState Dec 26 15:36:34 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:34 volumio-nano sudo[1281]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:34 volumio-nano systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 26 15:36:34 volumio-nano systemd[1]: shairport-sync.service: Succeeded. Dec 26 15:36:34 volumio-nano systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 26 15:36:34 volumio-nano sudo[1284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 15:36:34 volumio-nano sudo[1284]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:34 volumio-nano volumio[1026]: info: Asound.conf file unchanged, so no further update is needed Dec 26 15:36:34 volumio-nano volumio[1026]: info: Output device has changed, restarting MPD Dec 26 15:36:34 volumio-nano volumio[1026]: info: Output device has changed, restarting Shairport Sync Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:34 volumio-nano sudo[1289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 15:36:34 volumio-nano sudo[1289]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:34 volumio-nano systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 26 15:36:34 volumio-nano sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 15:36:34 volumio-nano sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:34 volumio-nano sudo[1289]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:34 volumio-nano sudo[1279]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:34 volumio-nano volumio[1026]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 15:36:34 volumio-nano systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 26 15:36:34 volumio-nano systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 26 15:36:34 volumio-nano systemd[1]: mpd.service: Succeeded. Dec 26 15:36:34 volumio-nano systemd[1]: Stopped Music Player Daemon. Dec 26 15:36:34 volumio-nano systemd[1]: shairport-sync.service: Succeeded. Dec 26 15:36:34 volumio-nano systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 26 15:36:34 volumio-nano volumio[1026]: info: MPD Permissions set Dec 26 15:36:34 volumio-nano volumio[1026]: info: Shairport-Sync Started Dec 26 15:36:34 volumio-nano volumio[1026]: Error adding Membership: Error: addMembership EINVAL Dec 26 15:36:34 volumio-nano sudo[1284]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:34 volumio-nano systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 26 15:36:34 volumio-nano systemd[1]: Starting Music Player Daemon... Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:34 volumio-nano sudo[1281]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:34 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:34 volumio-nano volumio[1026]: info: Shairport-Sync Started Dec 26 15:36:34 volumio-nano volumio[1026]: info: Shairport-Sync Started Dec 26 15:36:34 volumio-nano volumio[1026]: info: Starting Shairport Sync Dec 26 15:36:34 volumio-nano sudo[1307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 15:36:34 volumio-nano sudo[1307]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:34 volumio-nano systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 26 15:36:34 volumio-nano systemd[1]: shairport-sync.service: Succeeded. Dec 26 15:36:34 volumio-nano sudo[1299]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 26 15:36:34 volumio-nano systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 26 15:36:34 volumio-nano sudo[1299]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:34 volumio-nano sudo[1299]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 26 15:36:34 volumio-nano sudo[1299]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:34 volumio-nano systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 26 15:36:34 volumio-nano sudo[1307]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:34 volumio-nano volumio[1026]: info: Shairport-Sync Started Dec 26 15:36:34 volumio-nano sudo[1316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start nanosound_rotary Dec 26 15:36:34 volumio-nano sudo[1316]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:34 volumio-nano sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start nanosound_lirc Dec 26 15:36:34 volumio-nano sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:34 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_rotary.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 26 15:36:34 volumio-nano systemd[1]: Configuration file /lib/systemd/system/nanosound_rotary.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Dec 26 15:36:34 volumio-nano systemd[1]: Started NanoSound Rotary Volume Control. Dec 26 15:36:34 volumio-nano sudo[1316]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:34 volumio-nano volumio[1026]: info: NanoSound Rotary correctly started Dec 26 15:36:34 volumio-nano systemd[1]: Started NanoSound LIRC Service. Dec 26 15:36:34 volumio-nano sudo[1318]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:35 volumio-nano volumio[1026]: info: NanoSound lirc correctly started Dec 26 15:36:35 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioGetState Dec 26 15:36:35 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:35 volumio-nano kernel: export_store: invalid GPIO 17 Dec 26 15:36:35 volumio-nano systemd[1]: nanosound_lirc.service: Main process exited, code=exited, status=1/FAILURE Dec 26 15:36:35 volumio-nano systemd[1]: nanosound_lirc.service: Failed with result 'exit-code'. Dec 26 15:36:36 volumio-nano ntpd[1014]: receive: Unexpected origin timestamp 0xecf91bf3.8f55186e does not match aorg 0000000000.00000000 from server@139.144.71.56 xmt 0xecf91bf4.072e8aa9 Dec 26 15:36:36 volumio-nano ntpd[1014]: receive: Unexpected origin timestamp 0xecf91bf3.8f540b3a does not match aorg 0000000000.00000000 from server@168.119.211.223 xmt 0xecf91bf4.07877caa Dec 26 15:36:36 volumio-nano ntpd[1014]: receive: Unexpected origin timestamp 0xecf91bf3.8f55e6d3 does not match aorg 0000000000.00000000 from server@144.76.162.246 xmt 0xecf91bf4.07731840 Dec 26 15:36:36 volumio-nano ntpd[1014]: receive: Unexpected origin timestamp 0xecf91bf3.8f587d97 does not match aorg 0000000000.00000000 from server@46.4.54.78 xmt 0xecf91bf4.078b86b2 Dec 26 15:36:36 volumio-nano volumio[1026]: info: camilladsp service started and running in background, instance 1 Dec 26 15:36:36 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 15:36:36 volumio-nano volumio[1026]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Dec 26 15:36:36 volumio-nano volumio[1026]: info: FusionDsp loaded Dec 26 15:36:36 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 15:36:36 volumio-nano volumio[1026]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 26 15:36:36 volumio-nano volumio[1026]: info: Adding Signal Path Element [object Object] Dec 26 15:36:36 volumio-nano volumio[1026]: info: Adding fusiondspeq DSP Signal Path Element Dec 26 15:36:36 volumio-nano sudo[1334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 26 15:36:36 volumio-nano sudo[1334]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:36 volumio-nano volumio[1026]: info: FusionDsp - ---- installed callbackRead Dec 26 15:36:36 volumio-nano volumio[1026]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 26 15:36:36 volumio-nano volumio[1026]: info: FusionDsp - crossfeed chumoy Dec 26 15:36:36 volumio-nano volumio[1026]: info: FusionDsp - Loudness is ON true Dec 26 15:36:36 volumio-nano volumio[1026]: error: FusionDsp - WebSocket error: [object Object] Dec 26 15:36:36 volumio-nano volumio[1026]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Dec 26 15:36:36 volumio-nano mpd[1312]: Dec 26 15:36 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 26 15:36:36 volumio-nano systemd[1]: Started FusionDsp Daemon. Dec 26 15:36:36 volumio-nano sudo[1334]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:36 volumio-nano systemd[1]: Started Music Player Daemon. Dec 26 15:36:36 volumio-nano sudo[1291]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:36 volumio-nano sudo[1231]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:36 volumio-nano sudo[1241]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:36 volumio-nano volumio[1026]: info: Completed starting Core Plugins Dec 26 15:36:36 volumio-nano volumio[1026]: info: ------------------------------------------- Dec 26 15:36:36 volumio-nano volumio[1026]: info: ----- MyVolumio plugins startup ---- Dec 26 15:36:36 volumio-nano volumio[1026]: info: ------------------------------------------- Dec 26 15:36:36 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 26 15:36:36 volumio-nano volumio[1026]: error: MPD error: The expression evaluated to a falsy value: Dec 26 15:36:36 volumio-nano volumio[1026]: assert.ok(self.idling) Dec 26 15:36:36 volumio-nano volumio[1026]: error: The expression evaluated to a falsy value: Dec 26 15:36:36 volumio-nano volumio[1026]: assert.ok(self.idling) Dec 26 15:36:36 volumio-nano volumio[1026]: info: MPD running with PID1312 Dec 26 15:36:36 volumio-nano volumio[1026]: ,establishing connection Dec 26 15:36:36 volumio-nano volumio[1026]: error: MPD error: The expression evaluated to a falsy value: Dec 26 15:36:36 volumio-nano volumio[1026]: assert.ok(self.idling) Dec 26 15:36:36 volumio-nano volumio[1026]: error: The expression evaluated to a falsy value: Dec 26 15:36:36 volumio-nano volumio[1026]: assert.ok(self.idling) Dec 26 15:36:36 volumio-nano volumio[1026]: error: MPD error: The expression evaluated to a falsy value: Dec 26 15:36:36 volumio-nano volumio[1026]: assert.ok(self.idling) Dec 26 15:36:36 volumio-nano volumio[1026]: error: The expression evaluated to a falsy value: Dec 26 15:36:36 volumio-nano volumio[1026]: assert.ok(self.idling) Dec 26 15:36:36 volumio-nano volumio[1026]: error: updateQueue error: null Dec 26 15:36:37 volumio-nano volumio[1026]: verbose: New Socket.io Connection to 10.10.11.123 from 10.10.11.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioGetVisibleSources Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioGetState Dec 26 15:36:37 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioGetState Dec 26 15:36:37 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 26 15:36:37 volumio-nano volumio[1026]: info: Received Get System Info Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 15:36:37 volumio-nano volumio[1026]: info: Discovery: Getting this device information Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioGetState Dec 26 15:36:37 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioGetState Dec 26 15:36:37 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:37 volumio-nano volumio[1026]: info: Listing playlists Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioGetQueue Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreStateMachine::getQueue Dec 26 15:36:37 volumio-nano volumio[1026]: info: CorePlayQueue::getQueue Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 26 15:36:37 volumio-nano volumio[1026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 26 15:36:37 volumio-nano volumio[1026]: info: FusionDsp - no preset used Dec 26 15:36:37 volumio-nano volumio[1026]: info: FusionDsp - no preset used Dec 26 15:36:37 volumio-nano volumio[1026]: info: FusionDsp - no preset used Dec 26 15:36:37 volumio-nano systemd[1]: systemd-fsckd.service: Succeeded. Dec 26 15:36:37 volumio-nano volumio[1026]: info: FusionDsp - Buero.json,Büro.json Dec 26 15:36:37 volumio-nano volumio[1026]: info: FusionDsp - Buero.json,Büro.json Dec 26 15:36:37 volumio-nano volumio[1026]: info: FusionDsp - Buero.json,Büro.json Dec 26 15:36:38 volumio-nano sh[541]: timed out Dec 26 15:36:38 volumio-nano dhcpcd[562]: timed out Dec 26 15:36:38 volumio-nano sh[541]: dhcpcd exited Dec 26 15:36:38 volumio-nano dhcpcd[562]: dhcpcd exited Dec 26 15:36:38 volumio-nano sh[541]: ifup: failed to bring up eth0 Dec 26 15:36:38 volumio-nano systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Dec 26 15:36:38 volumio-nano systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Dec 26 15:36:39 volumio-nano volumio[1026]: info: VolumeController::SetAlsaVolume0 Dec 26 15:36:39 volumio-nano volumio[1026]: info: CoreStateMachine::pushState Dec 26 15:36:39 volumio-nano volumio[1026]: info: CorePlayQueue::getTrack 0 Dec 26 15:36:39 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 15:36:39 volumio-nano volumio[1026]: info: CoreCommandRouter::volumioPushState Dec 26 15:36:39 volumio-nano sudo[1350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 26 15:36:39 volumio-nano sudo[1350]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:39 volumio-nano volumio[1026]: info: FusionDsp - volume level for loudness 0 gain applied 23.00 Dec 26 15:36:39 volumio-nano volumio[1026]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 26 15:36:39 volumio-nano volumio[1026]: info: FusionDsp - crossfeed chumoy Dec 26 15:36:39 volumio-nano volumio[1026]: info: FusionDsp - Loudness is ON true Dec 26 15:36:39 volumio-nano sudo[1352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 26 15:36:39 volumio-nano sudo[1352]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:39 volumio-nano volumio[1026]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 26 15:36:39 volumio-nano sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 26 15:36:39 volumio-nano sudo[1356]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:39 volumio-nano systemd[1]: Started MPD Monitor Service. Dec 26 15:36:39 volumio-nano sudo[1350]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:39 volumio-nano volumio[1026]: info: Successfully started MPD Monitor Dec 26 15:36:39 volumio-nano mpd_monitor.sh[1357]: MPD Monitor Service: Starting MPD Monitor Service Dec 26 15:36:39 volumio-nano systemd[1]: Stopping MPD Monitor Service... Dec 26 15:36:39 volumio-nano systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 26 15:36:39 volumio-nano systemd[1]: mpd_monitor.service: Succeeded. Dec 26 15:36:39 volumio-nano systemd[1]: Stopped MPD Monitor Service. Dec 26 15:36:39 volumio-nano systemd[1]: Started MPD Monitor Service. Dec 26 15:36:39 volumio-nano sudo[1356]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:39 volumio-nano sudo[1352]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:39 volumio-nano volumio[1026]: info: Successfully started MPD Monitor Dec 26 15:36:39 volumio-nano volumio[1026]: info: Successfully started MPD Monitor Dec 26 15:36:39 volumio-nano mpd_monitor.sh[1362]: MPD Monitor Service: Starting MPD Monitor Service Dec 26 15:36:39 volumio-nano systemd[1]: systemd-hostnamed.service: Succeeded. Dec 26 15:36:40 volumio-nano sudo[1384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 15:36:40 volumio-nano sudo[1384]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:40 volumio-nano sudo[1384]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:40 volumio-nano sudo[1386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 15:36:40 volumio-nano sudo[1386]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:40 volumio-nano sudo[1386]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:40 volumio-nano sudo[1390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 26 15:36:40 volumio-nano sudo[1390]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:40 volumio-nano systemd[1]: Started UPnP Renderer front-end to MPD. Dec 26 15:36:40 volumio-nano sudo[1390]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:40 volumio-nano volumio[1026]: info: Upmpdcli Daemon Started Dec 26 15:36:40 volumio-nano volumio[1392]: Generating RSA private key, 4096 bit long modulus (2 primes) Dec 26 15:36:41 volumio-nano volumio[1026]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 26 15:36:45 volumio-nano volumio[1026]: info: Adding plugin bluetooth to MyMusic Plugins Dec 26 15:36:45 volumio-nano volumio[1026]: info: Adding plugin multiroom to MyMusic Plugins Dec 26 15:36:45 volumio-nano volumio[1026]: info: Adding plugin metavolumio to MyMusic Plugins Dec 26 15:36:45 volumio-nano volumio[1026]: info: Adding plugin cd_controller to MyMusic Plugins Dec 26 15:36:45 volumio-nano volumio[1026]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 26 15:36:45 volumio-nano volumio[1026]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 26 15:36:45 volumio-nano volumio[1026]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 26 15:36:45 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 26 15:36:46 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 26 15:36:46 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 26 15:36:46 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:46 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:46 volumio-nano volumio[1026]: info: Starting MyVolumio Remote Streaming Endpoints Dec 26 15:36:46 volumio-nano volumio[1026]: info: MyVolumio login type: Token Dec 26 15:36:46 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 26 15:36:46 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 26 15:36:46 volumio-nano volumio[1026]: info: Starting Streaming Service Transparent Proxy Dec 26 15:36:47 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 26 15:36:47 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 26 15:36:47 volumio-nano volumio[1026]: info: Streaming services startup Dec 26 15:36:47 volumio-nano volumio[1026]: info: Starting Streaming Daemon Dec 26 15:36:47 volumio-nano sudo[1415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 26 15:36:47 volumio-nano sudo[1415]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 15:36:47 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 26 15:36:47 volumio-nano sudo[1415]: pam_unix(sudo:session): session closed for user root Dec 26 15:36:47 volumio-nano volumio[1026]: error: Cannot start Volumio Streaming Daemon Dec 26 15:36:47 volumio-nano volumio[1026]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 26 15:36:47 volumio-nano volumio[1026]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 26 15:36:47 volumio-nano volumio[1026]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 26 15:36:47 volumio-nano volumio[1392]: ..........................................................................++++ Dec 26 15:36:47 volumio-nano volumio[1026]: STREAMING PROXY: Starting server on port 3245 Dec 26 15:36:47 volumio-nano volumio[1026]: Node JS runtime: 14 Dec 26 15:36:48 volumio-nano volumio[1026]: info: MyVolumio token set successfully Dec 26 15:36:48 volumio-nano volumio[1026]: info: MYVOLUMIO: Adding device Dec 26 15:36:48 volumio-nano volumio[1026]: info: MYVOLUMIO: Evaluating Server Dec 26 15:36:49 volumio-nano volumio[1026]: info: MyVolumio Plan changed: premium Dec 26 15:36:49 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Dec 26 15:36:49 volumio-nano volumio[1026]: info: Removing browser output: myVolumio user plan is not superstar Dec 26 15:36:49 volumio-nano volumio[1026]: info: Removing audio output: Dec 26 15:36:49 volumio-nano volumio[1026]: info: MYVOLUMIO: Adding device Dec 26 15:36:49 volumio-nano volumio[1026]: info: MYVOLUMIO: Evaluating Server Dec 26 15:36:49 volumio-nano volumio[1026]: info: Remote config written successfully Dec 26 15:36:49 volumio-nano volumio[1026]: info: Starting Tunnel 1 Dec 26 15:36:49 volumio-nano volumio[1026]: info: Starting Tunnel Connection Checker Dec 26 15:36:49 volumio-nano volumio[1026]: info: Completed starting MyVolumio Plugin Dec 26 15:36:49 volumio-nano volumio[1026]: info: MYVolumio Device enabled Dec 26 15:36:49 volumio-nano volumio[1026]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Dec 26 15:36:49 volumio-nano volumio[1026]: info: Setting Geolocation for MyVolumio to eu4 Dec 26 15:36:49 volumio-nano volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 15:36:49 volumio-nano volumio[1026]: [2025-12-26T14:36:49.414Z] @firebase/database: FIREBASE WARNING: Exception was thrown by user callback. TypeError: Cannot read property 'replace' of null Dec 26 15:36:49 volumio-nano volumio[1026]: at MyVolumioPluginManager.fetchPluginKeys (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:8044) Dec 26 15:36:49 volumio-nano volumio[1026]: at MyVolumioPluginManager.loadMyVolumioPlugins (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:11563) Dec 26 15:36:49 volumio-nano volumio[1026]: at MyVolumioPluginManager.myVolumioDeviceStatusChanged (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5527) Dec 26 15:36:49 volumio-nano volumio[1026]: at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6807 Dec 26 15:36:49 volumio-nano volumio[1026]: at /volumio/node_modules/v-conf/index.js:165:13 Dec 26 15:36:49 volumio-nano volumio[1026]: at /volumio/node_modules/multimap/index.js:150:9 Dec 26 15:36:49 volumio-nano volumio[1026]: at Array.forEach () Dec 26 15:36:49 volumio-nano volumio[1026]: at /volumio/node_modules/multimap/index.js:149:13 Dec 26 15:36:49 volumio-nano volumio[1026]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) Dec 26 15:36:49 volumio-nano volumio[1026]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5) Dec 26 15:36:49 volumio-nano volumio[1026]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10) Dec 26 15:36:49 volumio-nano volumio[1026]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20) Dec 26 15:36:49 volumio-nano volumio[1026]: at myVolumio.togglePremiumPlugins (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:36237) Dec 26 15:36:49 volumio-nano volumio[1026]: at /myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:17857 Dec 26 15:36:49 volumio-nano volumio[1026]: at /volumio/node_modules/@firebase/database/dist/index.node.cjs.js:4549:22 Dec 26 15:36:49 volumio-nano volumio[1026]: at exceptionGuard (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:698:9) Dec 26 15:36:49 volumio-nano volumio[1026]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 15:36:49 volumio-nano volumio[1026]: TypeError: Cannot read property 'replace' of null Dec 26 15:36:49 volumio-nano volumio[1026]: at MyVolumioPluginManager.fetchPluginKeys (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:8044) Dec 26 15:36:49 volumio-nano volumio[1026]: at MyVolumioPluginManager.loadMyVolumioPlugins (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:11563) Dec 26 15:36:49 volumio-nano volumio[1026]: at MyVolumioPluginManager.myVolumioDeviceStatusChanged (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5527) Dec 26 15:36:49 volumio-nano volumio[1026]: at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6807 Dec 26 15:36:49 volumio-nano volumio[1026]: at /volumio/node_modules/v-conf/index.js:165:13 Dec 26 15:36:49 volumio-nano volumio[1026]: at /volumio/node_modules/multimap/index.js:150:9 Dec 26 15:36:49 volumio-nano volumio[1026]: at Array.forEach () Dec 26 15:36:49 volumio-nano volumio[1026]: at /volumio/node_modules/multimap/index.js:149:13 Dec 26 15:36:49 volumio-nano volumio[1026]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) Dec 26 15:36:49 volumio-nano volumio[1026]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5) Dec 26 15:36:49 volumio-nano volumio[1026]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10) Dec 26 15:36:49 volumio-nano volumio[1026]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20) Dec 26 15:36:49 volumio-nano volumio[1026]: at myVolumio.togglePremiumPlugins (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:36237) Dec 26 15:36:49 volumio-nano volumio[1026]: at /myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:17857 Dec 26 15:36:49 volumio-nano volumio[1026]: at /volumio/node_modules/@firebase/database/dist/index.node.cjs.js:4549:22 Dec 26 15:36:49 volumio-nano volumio[1026]: at exceptionGuard (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:698:9) Dec 26 15:36:49 volumio-nano volumio[1026]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 15:36:49 volumio-nano sudo[1469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-26 15:35 Dec 26 15:36:49 volumio-nano sudo[1469]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"