-- Logs begin at Fri 2025-12-19 05:34:05 CET, end at Fri 2025-12-19 05:35:40 CET. -- Dec 19 05:34:05 volumio-7814a kernel: Booting Linux on physical CPU 0x0 Dec 19 05:34:05 volumio-7814a kernel: Linux version 6.6.62-v7+ (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:30:49 GMT 2024 Dec 19 05:34:05 volumio-7814a kernel: CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d Dec 19 05:34:05 volumio-7814a kernel: CPU: div instructions available: patching division code Dec 19 05:34:05 volumio-7814a kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache Dec 19 05:34:05 volumio-7814a kernel: OF: fdt: Machine model: Raspberry Pi Zero 2 W Rev 1.0 Dec 19 05:34:05 volumio-7814a kernel: random: crng init done Dec 19 05:34:05 volumio-7814a kernel: Memory policy: Data cache writealloc Dec 19 05:34:05 volumio-7814a kernel: Reserved memory: created CMA memory pool at 0x18400000, size 64 MiB Dec 19 05:34:05 volumio-7814a kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Dec 19 05:34:05 volumio-7814a kernel: OF: reserved mem: 0x18400000..0x1c3fffff (65536 KiB) map reusable linux,cma Dec 19 05:34:05 volumio-7814a kernel: Zone ranges: Dec 19 05:34:05 volumio-7814a kernel: DMA [mem 0x0000000000000000-0x000000001dffffff] Dec 19 05:34:05 volumio-7814a kernel: Normal empty Dec 19 05:34:05 volumio-7814a kernel: Movable zone start for each node Dec 19 05:34:05 volumio-7814a kernel: Early memory node ranges Dec 19 05:34:05 volumio-7814a kernel: node 0: [mem 0x0000000000000000-0x000000001dffffff] Dec 19 05:34:05 volumio-7814a kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000001dffffff] Dec 19 05:34:05 volumio-7814a kernel: percpu: Embedded 18 pages/cpu s41812 r8192 d23724 u73728 Dec 19 05:34:05 volumio-7814a kernel: pcpu-alloc: s41812 r8192 d23724 u73728 alloc=18*4096 Dec 19 05:34:05 volumio-7814a kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 19 05:34:05 volumio-7814a kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbswap=1 smsc95xx.macaddr=B8:27:EB:1A:EF:58 vc_mem.mem_base=0x1ec00000 vc_mem.mem_size=0x20000000 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=db7775c5-9234-4b9a-955e-7341a245d498 imgfile=/volumio_current.sqsh bootpart=UUID=F102-DE29 datapart=UUID=4112086d-38d3-4206-a7af-ef93bf4e4008 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 19 05:34:05 volumio-7814a kernel: cgroup: Disabling memory control group subsystem Dec 19 05:34:05 volumio-7814a kernel: Unknown kernel command line parameters "splash nodebug imgpart=UUID=db7775c5-9234-4b9a-955e-7341a245d498 imgfile=/volumio_current.sqsh bootpart=UUID=F102-DE29 datapart=UUID=4112086d-38d3-4206-a7af-ef93bf4e4008 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe bootdelay=7 use_kmsg=no", will be passed to user space. Dec 19 05:34:05 volumio-7814a kernel: Dentry cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: Inode-cache hash table entries: 32768 (order: 5, 131072 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: Built 1 zonelists, mobility grouping on. Total pages: 121800 Dec 19 05:34:05 volumio-7814a kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 19 05:34:05 volumio-7814a kernel: Memory: 374092K/491520K available (11264K kernel code, 1476K rwdata, 3260K rodata, 1024K init, 606K bss, 51892K reserved, 65536K cma-reserved) Dec 19 05:34:05 volumio-7814a kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 19 05:34:05 volumio-7814a kernel: ftrace: allocating 36457 entries in 107 pages Dec 19 05:34:05 volumio-7814a kernel: ftrace: allocated 107 pages with 5 groups Dec 19 05:34:05 volumio-7814a kernel: trace event string verifier disabled Dec 19 05:34:05 volumio-7814a kernel: rcu: Hierarchical RCU implementation. Dec 19 05:34:05 volumio-7814a kernel: Rude variant of Tasks RCU enabled. Dec 19 05:34:05 volumio-7814a kernel: Tracing variant of Tasks RCU enabled. Dec 19 05:34:05 volumio-7814a kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. Dec 19 05:34:05 volumio-7814a kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Dec 19 05:34:05 volumio-7814a kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Dec 19 05:34:05 volumio-7814a kernel: arch_timer: cp15 timer(s) running at 19.20MHz (phys). Dec 19 05:34:05 volumio-7814a kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns Dec 19 05:34:05 volumio-7814a kernel: sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns Dec 19 05:34:05 volumio-7814a kernel: Switching to timer-based delay loop, resolution 52ns Dec 19 05:34:05 volumio-7814a kernel: Console: colour dummy device 80x30 Dec 19 05:34:05 volumio-7814a kernel: printk: console [tty1] enabled Dec 19 05:34:05 volumio-7814a kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000) Dec 19 05:34:05 volumio-7814a kernel: CPU: Testing write buffer coherency: ok Dec 19 05:34:05 volumio-7814a kernel: pid_max: default: 32768 minimum: 301 Dec 19 05:34:05 volumio-7814a kernel: LSM: initializing lsm=capability,integrity Dec 19 05:34:05 volumio-7814a kernel: Mount-cache hash table entries: 1024 (order: 0, 4096 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Dec 19 05:34:05 volumio-7814a kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 19 05:34:05 volumio-7814a kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 19 05:34:05 volumio-7814a kernel: Setting up static identity map for 0x100000 - 0x10003c Dec 19 05:34:05 volumio-7814a kernel: rcu: Hierarchical SRCU implementation. Dec 19 05:34:05 volumio-7814a kernel: rcu: Max phase no-delay instances is 1000. Dec 19 05:34:05 volumio-7814a kernel: smp: Bringing up secondary CPUs ... Dec 19 05:34:05 volumio-7814a kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Dec 19 05:34:05 volumio-7814a kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Dec 19 05:34:05 volumio-7814a kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Dec 19 05:34:05 volumio-7814a kernel: smp: Brought up 1 node, 4 CPUs Dec 19 05:34:05 volumio-7814a kernel: SMP: Total of 4 processors activated (153.60 BogoMIPS). Dec 19 05:34:05 volumio-7814a kernel: CPU: All CPU(s) started in HYP mode. Dec 19 05:34:05 volumio-7814a kernel: CPU: Virtualization extensions available. Dec 19 05:34:05 volumio-7814a kernel: devtmpfs: initialized Dec 19 05:34:05 volumio-7814a kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4 Dec 19 05:34:05 volumio-7814a kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Dec 19 05:34:05 volumio-7814a kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: pinctrl core: initialized pinctrl subsystem Dec 19 05:34:05 volumio-7814a kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 19 05:34:05 volumio-7814a kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Dec 19 05:34:05 volumio-7814a kernel: audit: initializing netlink subsys (disabled) Dec 19 05:34:05 volumio-7814a kernel: audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 Dec 19 05:34:05 volumio-7814a kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 19 05:34:05 volumio-7814a kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Dec 19 05:34:05 volumio-7814a kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Dec 19 05:34:05 volumio-7814a kernel: Serial: AMBA PL011 UART driver Dec 19 05:34:05 volumio-7814a kernel: bcm2835-mbox 3f00b880.mailbox: mailbox enabled Dec 19 05:34:05 volumio-7814a kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2024-11-11T15:50:32, variant start Dec 19 05:34:05 volumio-7814a kernel: raspberrypi-firmware soc:firmware: Firmware hash is 903570ba72a9e117f92e5499de439f59dd96e417 Dec 19 05:34:05 volumio-7814a kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Dec 19 05:34:05 volumio-7814a kernel: bcm2835-dma 3f007000.dma-controller: DMA legacy API manager, dmachans=0x1 Dec 19 05:34:05 volumio-7814a kernel: SCSI subsystem initialized Dec 19 05:34:05 volumio-7814a kernel: usbcore: registered new interface driver usbfs Dec 19 05:34:05 volumio-7814a kernel: usbcore: registered new interface driver hub Dec 19 05:34:05 volumio-7814a kernel: usbcore: registered new device driver usb Dec 19 05:34:05 volumio-7814a kernel: pps_core: LinuxPPS API ver. 1 registered Dec 19 05:34:05 volumio-7814a kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Dec 19 05:34:05 volumio-7814a kernel: PTP clock support registered Dec 19 05:34:05 volumio-7814a kernel: clocksource: Switched to clocksource arch_sys_counter Dec 19 05:34:05 volumio-7814a kernel: VFS: Disk quotas dquot_6.6.0 Dec 19 05:34:05 volumio-7814a kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Dec 19 05:34:05 volumio-7814a kernel: FS-Cache: Loaded Dec 19 05:34:05 volumio-7814a kernel: CacheFiles: Loaded Dec 19 05:34:05 volumio-7814a kernel: NET: Registered PF_INET protocol family Dec 19 05:34:05 volumio-7814a kernel: IP idents hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: TCP established hash table entries: 4096 (order: 2, 16384 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: TCP bind hash table entries: 4096 (order: 4, 65536 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: TCP: Hash tables configured (established 4096 bind 4096) Dec 19 05:34:05 volumio-7814a kernel: UDP hash table entries: 256 (order: 1, 8192 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: UDP-Lite hash table entries: 256 (order: 1, 8192 bytes, linear) Dec 19 05:34:05 volumio-7814a kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 19 05:34:05 volumio-7814a kernel: RPC: Registered named UNIX socket transport module. Dec 19 05:34:05 volumio-7814a kernel: RPC: Registered udp transport module. Dec 19 05:34:05 volumio-7814a kernel: RPC: Registered tcp transport module. Dec 19 05:34:05 volumio-7814a kernel: RPC: Registered tcp-with-tls transport module. Dec 19 05:34:05 volumio-7814a kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Dec 19 05:34:05 volumio-7814a kernel: Trying to unpack rootfs image as initramfs... Dec 19 05:34:05 volumio-7814a kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available Dec 19 05:34:05 volumio-7814a kernel: Initialise system trusted keyrings Dec 19 05:34:05 volumio-7814a kernel: workingset: timestamp_bits=14 max_order=17 bucket_order=3 Dec 19 05:34:05 volumio-7814a kernel: zbud: loaded Dec 19 05:34:05 volumio-7814a kernel: NFS: Registering the id_resolver key type Dec 19 05:34:05 volumio-7814a kernel: Key type id_resolver registered Dec 19 05:34:05 volumio-7814a kernel: Key type id_legacy registered Dec 19 05:34:05 volumio-7814a kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Dec 19 05:34:05 volumio-7814a kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Dec 19 05:34:05 volumio-7814a kernel: Key type asymmetric registered Dec 19 05:34:05 volumio-7814a kernel: Asymmetric key parser 'x509' registered Dec 19 05:34:05 volumio-7814a kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Dec 19 05:34:05 volumio-7814a kernel: io scheduler mq-deadline registered Dec 19 05:34:05 volumio-7814a kernel: io scheduler kyber registered Dec 19 05:34:05 volumio-7814a kernel: io scheduler bfq registered Dec 19 05:34:05 volumio-7814a kernel: pinctrl-bcm2835 3f200000.gpio: GPIO_OUT persistence: yes Dec 19 05:34:05 volumio-7814a kernel: bcm2708_fb soc:fb: FB found 1 display(s) Dec 19 05:34:05 volumio-7814a kernel: Console: switching to colour frame buffer device 82x26 Dec 19 05:34:05 volumio-7814a kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 656x416 Dec 19 05:34:05 volumio-7814a kernel: bcm2835-rng 3f104000.rng: hwrng registered Dec 19 05:34:05 volumio-7814a kernel: vc-mem: phys_addr:0x00000000 mem_base=0x1ec00000 mem_size:0x20000000(512 MiB) Dec 19 05:34:05 volumio-7814a kernel: brd: module loaded Dec 19 05:34:05 volumio-7814a kernel: loop: module loaded Dec 19 05:34:05 volumio-7814a kernel: Loading iSCSI transport class v2.0-870. Dec 19 05:34:05 volumio-7814a kernel: usbcore: registered new interface driver lan78xx Dec 19 05:34:05 volumio-7814a kernel: usbcore: registered new interface driver smsc95xx Dec 19 05:34:05 volumio-7814a kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Dec 19 05:34:05 volumio-7814a kernel: Core Release: 2.80a Dec 19 05:34:05 volumio-7814a kernel: Setting default values for core params Dec 19 05:34:05 volumio-7814a kernel: Finished setting default values for core params Dec 19 05:34:05 volumio-7814a kernel: Freeing initrd memory: 28132K Dec 19 05:34:05 volumio-7814a kernel: Using Buffer DMA mode Dec 19 05:34:05 volumio-7814a kernel: Periodic Transfer Interrupt Enhancement - disabled Dec 19 05:34:05 volumio-7814a kernel: Multiprocessor Interrupt Enhancement - disabled Dec 19 05:34:05 volumio-7814a kernel: OTG VER PARAM: 0, OTG VER FLAG: 0 Dec 19 05:34:05 volumio-7814a kernel: Dedicated Tx FIFOs mode Dec 19 05:34:05 volumio-7814a kernel: Dec 19 05:34:05 volumio-7814a kernel: WARN::dwc_otg_hcd_init:1070: FIQ DMA bounce buffers: virt = 98514000 dma = 0xd8514000 len=9024 Dec 19 05:34:05 volumio-7814a kernel: FIQ FSM acceleration enabled for : Non-periodic Split Transactions Periodic Split Transactions High-Speed Isochronous Endpoints Interrupt/Control Split Transaction hack enabled Dec 19 05:34:05 volumio-7814a kernel: dwc_otg: Microframe scheduler enabled Dec 19 05:34:05 volumio-7814a kernel: Dec 19 05:34:05 volumio-7814a kernel: WARN::hcd_init_fiq:457: FIQ on core 1 Dec 19 05:34:05 volumio-7814a kernel: Dec 19 05:34:05 volumio-7814a kernel: WARN::hcd_init_fiq:458: FIQ ASM at 808886e4 length 36 Dec 19 05:34:05 volumio-7814a kernel: Dec 19 05:34:05 volumio-7814a kernel: WARN::hcd_init_fiq:496: MPHI regs_base at 9e810000 Dec 19 05:34:05 volumio-7814a kernel: dwc_otg 3f980000.usb: DWC OTG Controller Dec 19 05:34:05 volumio-7814a kernel: dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1 Dec 19 05:34:05 volumio-7814a kernel: dwc_otg 3f980000.usb: irq 89, io mem 0x00000000 Dec 19 05:34:05 volumio-7814a kernel: Init: Port Power? op_state=1 Dec 19 05:34:05 volumio-7814a kernel: Init: Power Port (0) Dec 19 05:34:05 volumio-7814a kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Dec 19 05:34:05 volumio-7814a kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Dec 19 05:34:05 volumio-7814a kernel: usb usb1: Product: DWC OTG Controller Dec 19 05:34:05 volumio-7814a kernel: usb usb1: Manufacturer: Linux 6.6.62-v7+ dwc_otg_hcd Dec 19 05:34:05 volumio-7814a kernel: usb usb1: SerialNumber: 3f980000.usb Dec 19 05:34:05 volumio-7814a kernel: hub 1-0:1.0: USB hub found Dec 19 05:34:05 volumio-7814a kernel: hub 1-0:1.0: 1 port detected Dec 19 05:34:05 volumio-7814a kernel: dwc_otg: FIQ enabled Dec 19 05:34:05 volumio-7814a kernel: dwc_otg: NAK holdoff enabled Dec 19 05:34:05 volumio-7814a kernel: dwc_otg: FIQ split-transaction FSM enabled Dec 19 05:34:05 volumio-7814a kernel: Module dwc_common_port init Dec 19 05:34:05 volumio-7814a kernel: usbcore: registered new interface driver usb-storage Dec 19 05:34:05 volumio-7814a kernel: mousedev: PS/2 mouse device common for all mice Dec 19 05:34:05 volumio-7814a kernel: sdhci: Secure Digital Host Controller Interface driver Dec 19 05:34:05 volumio-7814a kernel: sdhci: Copyright(c) Pierre Ossman Dec 19 05:34:05 volumio-7814a kernel: sdhci-pltfm: SDHCI platform and OF driver helper Dec 19 05:34:05 volumio-7814a kernel: ledtrig-cpu: registered to indicate activity on CPUs Dec 19 05:34:05 volumio-7814a kernel: hid: raw HID events driver (C) Jiri Kosina Dec 19 05:34:05 volumio-7814a kernel: usbcore: registered new interface driver usbhid Dec 19 05:34:05 volumio-7814a kernel: usbhid: USB HID core driver Dec 19 05:34:05 volumio-7814a kernel: bcm2835_vchiq 3f00b840.mailbox: there is not valid maps for state default Dec 19 05:34:05 volumio-7814a kernel: Initializing XFRM netlink socket Dec 19 05:34:05 volumio-7814a kernel: NET: Registered PF_PACKET protocol family Dec 19 05:34:05 volumio-7814a kernel: Key type dns_resolver registered Dec 19 05:34:05 volumio-7814a kernel: Registering SWP/SWPB emulation handler Dec 19 05:34:05 volumio-7814a kernel: registered taskstats version 1 Dec 19 05:34:05 volumio-7814a kernel: Loading compiled-in X.509 certificates Dec 19 05:34:05 volumio-7814a kernel: Key type .fscrypt registered Dec 19 05:34:05 volumio-7814a kernel: Key type fscrypt-provisioning registered Dec 19 05:34:05 volumio-7814a kernel: uart-pl011 3f201000.serial: cts_event_workaround enabled Dec 19 05:34:05 volumio-7814a kernel: 3f201000.serial: ttyAMA1 at MMIO 0x3f201000 (irq = 114, base_baud = 0) is a PL011 rev2 Dec 19 05:34:05 volumio-7814a kernel: serial serial0: tty port ttyAMA1 registered Dec 19 05:34:05 volumio-7814a kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Dec 19 05:34:05 volumio-7814a kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Dec 19 05:34:05 volumio-7814a kernel: mmc-bcm2835 3f300000.mmcnr: mmc_debug:0 mmc_debug2:0 Dec 19 05:34:05 volumio-7814a kernel: mmc-bcm2835 3f300000.mmcnr: DMA channel allocated Dec 19 05:34:05 volumio-7814a kernel: sdhost: log_buf @ c51fa257 (d8513000) Dec 19 05:34:05 volumio-7814a kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) Dec 19 05:34:05 volumio-7814a kernel: of_cfs_init Dec 19 05:34:05 volumio-7814a kernel: of_cfs_init: OK Dec 19 05:34:05 volumio-7814a kernel: clk: Disabling unused clocks Dec 19 05:34:05 volumio-7814a kernel: Freeing unused kernel image (initmem) memory: 1024K Dec 19 05:34:05 volumio-7814a kernel: Run /init as init process Dec 19 05:34:05 volumio-7814a kernel: with arguments: Dec 19 05:34:05 volumio-7814a kernel: /init Dec 19 05:34:05 volumio-7814a kernel: splash Dec 19 05:34:05 volumio-7814a kernel: nodebug Dec 19 05:34:05 volumio-7814a kernel: with environment: Dec 19 05:34:05 volumio-7814a kernel: HOME=/ Dec 19 05:34:05 volumio-7814a kernel: TERM=linux Dec 19 05:34:05 volumio-7814a kernel: imgpart=UUID=db7775c5-9234-4b9a-955e-7341a245d498 Dec 19 05:34:05 volumio-7814a kernel: imgfile=/volumio_current.sqsh Dec 19 05:34:05 volumio-7814a kernel: bootpart=UUID=F102-DE29 Dec 19 05:34:05 volumio-7814a kernel: datapart=UUID=4112086d-38d3-4206-a7af-ef93bf4e4008 Dec 19 05:34:05 volumio-7814a kernel: uuidconfig=cmdline.txt Dec 19 05:34:05 volumio-7814a kernel: pcie_aspm=off Dec 19 05:34:05 volumio-7814a kernel: pci=pcie_bus_safe Dec 19 05:34:05 volumio-7814a kernel: bootdelay=7 Dec 19 05:34:05 volumio-7814a kernel: use_kmsg=no Dec 19 05:34:05 volumio-7814a kernel: mmc0: host does not support reading read-only switch, assuming write-enable Dec 19 05:34:05 volumio-7814a kernel: mmc0: Host Software Queue enabled Dec 19 05:34:05 volumio-7814a kernel: mmc0: new high speed SDHC card at address aaaa Dec 19 05:34:05 volumio-7814a kernel: mmcblk0: mmc0:aaaa SC16G 14.8 GiB Dec 19 05:34:05 volumio-7814a kernel: mmcblk0: p1 p2 p3 Dec 19 05:34:05 volumio-7814a kernel: mmcblk0: mmc0:aaaa SC16G 14.8 GiB (quirks 0x0000c000) Dec 19 05:34:05 volumio-7814a kernel: mmc1: new high speed SDIO card at address 0001 Dec 19 05:34:05 volumio-7814a kernel: fuse: init (API version 7.39) Dec 19 05:34:05 volumio-7814a kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 19 05:34:05 volumio-7814a kernel: usbcore: registered new interface driver uas Dec 19 05:34:05 volumio-7814a kernel: EXT4-fs (mmcblk0p2): mounted filesystem db7775c5-9234-4b9a-955e-7341a245d498 r/w with ordered data mode. Quota mode: none. Dec 19 05:34:05 volumio-7814a kernel: loop0: detected capacity change from 0 to 1005568 Dec 19 05:34:05 volumio-7814a kernel: EXT4-fs (mmcblk0p3): recovery complete Dec 19 05:34:05 volumio-7814a kernel: EXT4-fs (mmcblk0p3): mounted filesystem 4112086d-38d3-4206-a7af-ef93bf4e4008 r/w with ordered data mode. Quota mode: none. Dec 19 05:34:05 volumio-7814a systemd[1]: System time before build time, advancing clock. Dec 19 05:34:05 volumio-7814a kernel: NET: Registered PF_INET6 protocol family Dec 19 05:34:05 volumio-7814a kernel: Segment Routing with IPv6 Dec 19 05:34:05 volumio-7814a kernel: In-situ OAM (IOAM) with IPv6 Dec 19 05:34:05 volumio-7814a 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 19 05:34:05 volumio-7814a systemd[1]: Detected architecture arm. Dec 19 05:34:05 volumio-7814a systemd[1]: Set hostname to . Dec 19 05:34:05 volumio-7814a 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 19 05:34:05 volumio-7814a systemd[1]: Listening on fsck to fsckd communication Socket. Dec 19 05:34:05 volumio-7814a systemd[1]: Created slice system-getty.slice. Dec 19 05:34:05 volumio-7814a systemd[1]: Started Forward Password Requests to Wall Directory Watch. Dec 19 05:34:05 volumio-7814a systemd[1]: Created slice system-systemd\x2dfsck.slice. Dec 19 05:34:05 volumio-7814a systemd[1]: Listening on udev Control Socket. Dec 19 05:34:05 volumio-7814a systemd[1]: Listening on udev Kernel Socket. Dec 19 05:34:05 volumio-7814a kernel: i2c_dev: i2c /dev entries driver Dec 19 05:34:05 volumio-7814a systemd-journald[275]: Journal started Dec 19 05:34:05 volumio-7814a systemd-journald[275]: Runtime journal (/run/log/journal/c1d531165394c79721acb5a765d65e88) is 3.7M, max 30.0M, 26.2M free. Dec 19 05:34:05 volumio-7814a systemd-modules-load[262]: Inserted module 'i2c_dev' Dec 19 05:34:05 volumio-7814a fake-hwclock[265]: Fri Dec 19 04:34:05 UTC 2025 Dec 19 05:34:05 volumio-7814a volumio[263]: 512 MB or less RAM Detected, need to enable swap Dec 19 05:34:05 volumio-7814a systemd[1]: Mounted FUSE Control File System. Dec 19 05:34:05 volumio-7814a systemd[1]: Started Load/Save Random Seed. Dec 19 05:34:05 volumio-7814a systemd[1]: Mounted Kernel Configuration File System. Dec 19 05:34:05 volumio-7814a systemd[1]: Started Apply Kernel Variables. Dec 19 05:34:05 volumio-7814a kernel: ext4 filesystem being mounted at /swap supports timestamps until 2038-01-19 (0x7fffffff) Dec 19 05:34:05 volumio-7814a volumio[263]: Enabling Swap Dec 19 05:34:05 volumio-7814a systemd[1]: Started Create System Users. Dec 19 05:34:05 volumio-7814a kernel: Adding 524228k swap on /swap/swapfile. Priority:-2 extents:14 across:8636412k SS Dec 19 05:34:05 volumio-7814a volumio[263]: Setting swappiness to 40 Dec 19 05:34:05 volumio-7814a systemd[1]: Starting Create Static Device Nodes in /dev... Dec 19 05:34:05 volumio-7814a volumio[263]: vm.swappiness = 40 Dec 19 05:34:05 volumio-7814a systemd[1]: dynamicswap.service: Succeeded. Dec 19 05:34:05 volumio-7814a systemd[1]: Started udev Coldplug all Devices. Dec 19 05:34:05 volumio-7814a systemd[1]: Starting Helper to synchronize boot up for ifupdown... Dec 19 05:34:05 volumio-7814a systemd[1]: Started Helper to synchronize boot up for ifupdown. Dec 19 05:34:05 volumio-7814a systemd[1]: Started Create Static Device Nodes in /dev. Dec 19 05:34:05 volumio-7814a systemd[1]: Starting udev Kernel Device Manager... Dec 19 05:34:05 volumio-7814a systemd[1]: Reached target Local File Systems (Pre). Dec 19 05:34:05 volumio-7814a systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Dec 19 05:34:05 volumio-7814a systemd[1]: Mounting /tmp... Dec 19 05:34:05 volumio-7814a systemd[1]: Mounting /var/spool/cups... Dec 19 05:34:05 volumio-7814a systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Dec 19 05:34:05 volumio-7814a systemd[1]: Mounting /var/log... Dec 19 05:34:05 volumio-7814a systemd[1]: Mounted /tmp. Dec 19 05:34:05 volumio-7814a systemd[1]: Mounted /var/spool/cups. Dec 19 05:34:05 volumio-7814a systemd[1]: Mounting /var/spool/cups/tmp... Dec 19 05:34:05 volumio-7814a systemd[1]: Mounted /var/log. Dec 19 05:34:05 volumio-7814a systemd[1]: Starting Flush Journal to Persistent Storage... Dec 19 05:34:05 volumio-7814a systemd-udevd[299]: Network interface NamePolicy= disabled on kernel command line, ignoring. Dec 19 05:34:05 volumio-7814a systemd[1]: Mounted /var/spool/cups/tmp. Dec 19 05:34:05 volumio-7814a systemd-journald[275]: Runtime journal (/run/log/journal/c1d531165394c79721acb5a765d65e88) is 3.7M, max 30.0M, 26.2M free. Dec 19 05:34:05 volumio-7814a systemd[1]: Started udev Kernel Device Manager. Dec 19 05:34:05 volumio-7814a systemd[1]: Started Flush Journal to Persistent Storage. Dec 19 05:34:05 volumio-7814a systemd[1]: Starting Show Plymouth Boot Screen... Dec 19 05:34:05 volumio-7814a systemd[1]: plymouth-start.service: Succeeded. Dec 19 05:34:05 volumio-7814a systemd[1]: Started Show Plymouth Boot Screen. Dec 19 05:34:05 volumio-7814a systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Dec 19 05:34:05 volumio-7814a systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Dec 19 05:34:05 volumio-7814a systemd[1]: Reached target Local Encrypted Volumes. Dec 19 05:34:05 volumio-7814a systemd[1]: Reached target Paths. Dec 19 05:34:05 volumio-7814a kernel: rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 Dec 19 05:34:05 volumio-7814a kernel: rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem Dec 19 05:34:05 volumio-7814a kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Dec 19 05:34:05 volumio-7814a kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Dec 19 05:34:05 volumio-7814a kernel: [vc_sm_connected_init]: start Dec 19 05:34:05 volumio-7814a kernel: [vc_sm_connected_init]: installed successfully Dec 19 05:34:05 volumio-7814a kernel: mc: Linux media interface: v0.10 Dec 19 05:34:06 volumio-7814a kernel: videodev: Linux video capture interface: v2.00 Dec 19 05:34:06 volumio-7814a kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Dec 19 05:34:06 volumio-7814a kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Dec 19 05:34:06 volumio-7814a kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Dec 19 05:34:06 volumio-7814a kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: Core ver 2.22 Dec 19 05:34:06 volumio-7814a kernel: NET: Registered PF_BLUETOOTH protocol family Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: HCI device and connection manager initialized Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: HCI socket layer initialized Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: L2CAP socket layer initialized Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: SCO socket layer initialized Dec 19 05:34:06 volumio-7814a kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Dec 19 05:34:06 volumio-7814a kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Dec 19 05:34:06 volumio-7814a kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Dec 19 05:34:06 volumio-7814a kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Dec 19 05:34:06 volumio-7814a kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Dec 19 05:34:06 volumio-7814a kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Dec 19 05:34:06 volumio-7814a kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Dec 19 05:34:06 volumio-7814a kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Dec 19 05:34:06 volumio-7814a kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Dec 19 05:34:06 volumio-7814a kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Dec 19 05:34:06 volumio-7814a kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Dec 19 05:34:06 volumio-7814a kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Dec 19 05:34:06 volumio-7814a kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Dec 19 05:34:06 volumio-7814a kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: HCI UART driver ver 2.3 Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: HCI UART protocol H4 registered Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Dec 19 05:34:06 volumio-7814a kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Dec 19 05:34:06 volumio-7814a kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Dec 19 05:34:06 volumio-7814a kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Dec 19 05:34:06 volumio-7814a kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: HCI UART protocol Broadcom registered Dec 19 05:34:06 volumio-7814a kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Dec 19 05:34:06 volumio-7814a kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Dec 19 05:34:06 volumio-7814a kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Dec 19 05:34:06 volumio-7814a kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Dec 19 05:34:06 volumio-7814a kernel: uart-pl011 3f201000.serial: no DMA platform data Dec 19 05:34:06 volumio-7814a kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6 Dec 19 05:34:06 volumio-7814a kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 Dec 19 05:34:06 volumio-7814a kernel: brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43430-sdio.raspberrypi,model-zero-2-w.bin failed with error -2 Dec 19 05:34:06 volumio-7814a kernel: usbcore: registered new interface driver brcmfmac Dec 19 05:34:06 volumio-7814a systemd-udevd[312]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Dec 19 05:34:06 volumio-7814a systemd[1]: Found device /dev/disk/by-uuid/F102-DE29. Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: hci0: BCM: chip id 94 Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: hci0: BCM: features 0x2e Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: hci0: BCM43430A1 Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0000 Dec 19 05:34:06 volumio-7814a kernel: Bluetooth: hci0: BCM43430A1 'brcm/BCM43430A1.hcd' Patch Dec 19 05:34:06 volumio-7814a kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Dec 19 05:34:06 volumio-7814a kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Jul 19 2021 03:24:18 version 7.45.98 (TOB) (56df937 CY) FWID 01-8e14b897 Dec 19 05:34:07 volumio-7814a systemd-udevd[311]: Using default interface naming scheme 'v240'. Dec 19 05:34:07 volumio-7814a systemd-udevd[311]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Dec 19 05:34:07 volumio-7814a kernel: alsactl[386]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Dec 19 05:34:07 volumio-7814a kernel: alsactl[385]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Dec 19 05:34:07 volumio-7814a systemd[1]: Created slice system-bthelper.slice. Dec 19 05:34:07 volumio-7814a systemd[1]: Condition check resulted in Huge Pages File System being skipped. Dec 19 05:34:07 volumio-7814a kernel: Bluetooth: hci0: BCM: features 0x2e Dec 19 05:34:07 volumio-7814a kernel: Bluetooth: hci0: BCM43438A1 37.4MHz Raspberry Pi 3-0141 Dec 19 05:34:07 volumio-7814a kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0508 Dec 19 05:34:07 volumio-7814a systemd[1]: Starting Show Plymouth Boot Screen... Dec 19 05:34:07 volumio-7814a systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Dec 19 05:34:07 volumio-7814a systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Dec 19 05:34:07 volumio-7814a systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Dec 19 05:34:07 volumio-7814a systemd[1]: Starting File System Check on /dev/disk/by-uuid/F102-DE29... Dec 19 05:34:07 volumio-7814a systemd[1]: Starting Load/Save RF Kill Switch Status... Dec 19 05:34:07 volumio-7814a systemd[1]: plymouth-start.service: Succeeded. Dec 19 05:34:07 volumio-7814a systemd[1]: Started Show Plymouth Boot Screen. Dec 19 05:34:07 volumio-7814a systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Dec 19 05:34:07 volumio-7814a systemd[1]: Started File System Check Daemon to report status. Dec 19 05:34:07 volumio-7814a systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Dec 19 05:34:07 volumio-7814a systemd[1]: Started Load/Save RF Kill Switch Status. Dec 19 05:34:07 volumio-7814a systemd-fsck[402]: fsck.fat 4.1 (2017-01-24) Dec 19 05:34:07 volumio-7814a systemd-fsck[402]: Unexpected long filename sequence number (2 vs. expected 1). Dec 19 05:34:07 volumio-7814a systemd-fsck[402]: It could be that just the number is wrong Dec 19 05:34:07 volumio-7814a systemd-fsck[402]: if "network-confi" seems to match "g". Dec 19 05:34:07 volumio-7814a systemd-fsck[402]: Not auto-correcting this. Dec 19 05:34:07 volumio-7814a systemd-fsck[402]: /dev/mmcblk0p1: 487 files, 42210/46774 clusters Dec 19 05:34:07 volumio-7814a systemd[1]: Started File System Check on /dev/disk/by-uuid/F102-DE29. Dec 19 05:34:07 volumio-7814a systemd[1]: Mounting /boot... Dec 19 05:34:07 volumio-7814a systemd[1]: Mounted /boot. Dec 19 05:34:07 volumio-7814a systemd[1]: Reached target Local File Systems. Dec 19 05:34:07 volumio-7814a systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Dec 19 05:34:07 volumio-7814a systemd[1]: Starting Create Volatile Files and Directories... Dec 19 05:34:07 volumio-7814a systemd[1]: Starting Preprocess NFS configuration... Dec 19 05:34:07 volumio-7814a systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Dec 19 05:34:07 volumio-7814a systemd[1]: Started ifup for wlan0. Dec 19 05:34:07 volumio-7814a systemd[1]: Starting Raise network interfaces... Dec 19 05:34:07 volumio-7814a systemd[1]: Received SIGRTMIN+20 from PID 160 (plymouthd). Dec 19 05:34:07 volumio-7814a systemd[1]: plymouth-read-write.service: Succeeded. Dec 19 05:34:07 volumio-7814a systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Dec 19 05:34:07 volumio-7814a systemd[1]: nfs-config.service: Succeeded. Dec 19 05:34:07 volumio-7814a systemd[1]: Started Preprocess NFS configuration. Dec 19 05:34:07 volumio-7814a systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Dec 19 05:34:07 volumio-7814a systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Dec 19 05:34:07 volumio-7814a systemd[1]: Reached target NFS client services. Dec 19 05:34:07 volumio-7814a systemd[1]: Started Create Volatile Files and Directories. Dec 19 05:34:07 volumio-7814a systemd[1]: Starting RPC bind portmap service... Dec 19 05:34:07 volumio-7814a kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Dec 19 05:34:07 volumio-7814a systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Dec 19 05:34:07 volumio-7814a systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Dec 19 05:34:08 volumio-7814a systemd[1]: Starting Update UTMP about System Boot/Shutdown... Dec 19 05:34:08 volumio-7814a systemd[1]: Started Update UTMP about System Boot/Shutdown. Dec 19 05:34:08 volumio-7814a systemd[1]: Reached target System Initialization. Dec 19 05:34:08 volumio-7814a systemd[1]: Started Daily apt download activities. Dec 19 05:34:08 volumio-7814a systemd[1]: Started Daily apt upgrade and clean activities. Dec 19 05:34:08 volumio-7814a systemd[1]: Listening on D-Bus System Message Bus Socket. Dec 19 05:34:08 volumio-7814a systemd[1]: Listening on triggerhappy.socket. Dec 19 05:34:08 volumio-7814a systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Dec 19 05:34:08 volumio-7814a systemd[1]: Reached target Sockets. Dec 19 05:34:08 volumio-7814a systemd[1]: Reached target Basic System. Dec 19 05:34:08 volumio-7814a kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 19 05:34:08 volumio-7814a systemd[1]: Started Volumio Iptables Module. Dec 19 05:34:08 volumio-7814a systemd[1]: Starting Login Service... Dec 19 05:34:08 volumio-7814a systemd[1]: Started UPnP Renderer front-end to MPD. Dec 19 05:34:08 volumio-7814a systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Dec 19 05:34:08 volumio-7814a systemd[1]: Starting Wireless Services... Dec 19 05:34:08 volumio-7814a systemd[1]: Started Manage Sound Card State (restore and store). Dec 19 05:34:08 volumio-7814a systemd[1]: Starting Save/Restore Sound Card State... Dec 19 05:34:08 volumio-7814a alsactl[476]: alsactl 1.1.8 daemon started Dec 19 05:34:08 volumio-7814a systemd[1]: Starting dhcpcd on all interfaces... Dec 19 05:34:08 volumio-7814a systemd[1]: Started volumio-remote-updater.service. Dec 19 05:34:08 volumio-7814a systemd[1]: Started D-Bus System Message Bus. Dec 19 05:34:08 volumio-7814a systemd[1]: Starting WPA supplicant... Dec 19 05:34:08 volumio-7814a systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Dec 19 05:34:08 volumio-7814a systemd[1]: Starting Configure Bluetooth Modems connected by UART... Dec 19 05:34:08 volumio-7814a systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Dec 19 05:34:08 volumio-7814a systemd[1]: Starting triggerhappy global hotkey daemon... Dec 19 05:34:08 volumio-7814a systemd[1]: Started Daily Cleanup of Temporary Directories. Dec 19 05:34:08 volumio-7814a systemd[1]: Reached target Timers. Dec 19 05:34:08 volumio-7814a systemd[1]: Started Volumio Log Rotation Service. Dec 19 05:34:08 volumio-7814a systemd[1]: Starting Volumio Time Update Utility... Dec 19 05:34:08 volumio-7814a systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Dec 19 05:34:08 volumio-7814a systemd[1]: Started RPC bind portmap service. Dec 19 05:34:08 volumio-7814a dhcpcd[479]: Not running dhcpcd because /etc/network/interfaces Dec 19 05:34:08 volumio-7814a dhcpcd[479]: defines some interfaces that will use a Dec 19 05:34:08 volumio-7814a dhcpcd[479]: DHCP client or static address Dec 19 05:34:08 volumio-7814a systemd[1]: Started Save/Restore Sound Card State. Dec 19 05:34:08 volumio-7814a systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Dec 19 05:34:08 volumio-7814a systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Dec 19 05:34:08 volumio-7814a systemd[1]: Failed to start dhcpcd on all interfaces. Dec 19 05:34:08 volumio-7814a systemd[1]: Reached target Sound Card. Dec 19 05:34:08 volumio-7814a systemd[1]: Reached target Remote File Systems (Pre). Dec 19 05:34:08 volumio-7814a systemd[1]: Reached target Remote File Systems. Dec 19 05:34:08 volumio-7814a systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Dec 19 05:34:08 volumio-7814a systemd[1]: Reached target RPC Port Mapper. Dec 19 05:34:08 volumio-7814a volumio-time-update[489]: volumio-time-update-util: Fetching time from Volumio... Dec 19 05:34:08 volumio-7814a systemd-logind[472]: New seat seat0. Dec 19 05:34:08 volumio-7814a thd[487]: Unable to parse trigger line: Dec 19 05:34:08 volumio-7814a thd[487]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Dec 19 05:34:08 volumio-7814a thd[487]: Unable to parse trigger line: Dec 19 05:34:08 volumio-7814a thd[487]: Found socket passed from systemd Dec 19 05:34:08 volumio-7814a avahi-daemon[486]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Dec 19 05:34:08 volumio-7814a avahi-daemon[486]: Successfully dropped root privileges. Dec 19 05:34:08 volumio-7814a avahi-daemon[486]: avahi-daemon 0.7 starting up. Dec 19 05:34:09 volumio-7814a avahi-daemon[486]: Successfully called chroot(). Dec 19 05:34:09 volumio-7814a avahi-daemon[486]: Successfully dropped remaining capabilities. Dec 19 05:34:09 volumio-7814a systemd[1]: Started Login Service. Dec 19 05:34:09 volumio-7814a systemd[1]: Started Avahi mDNS/DNS-SD Stack. Dec 19 05:34:09 volumio-7814a systemd[1]: Started triggerhappy global hotkey daemon. Dec 19 05:34:09 volumio-7814a systemd[1]: hciuart.service: Succeeded. Dec 19 05:34:09 volumio-7814a systemd[1]: Started Configure Bluetooth Modems connected by UART. Dec 19 05:34:09 volumio-7814a avahi-daemon[486]: Loading service file /services/volumio.service. Dec 19 05:34:09 volumio-7814a wpa_supplicant[484]: Successfully initialized wpa_supplicant Dec 19 05:34:09 volumio-7814a avahi-daemon[486]: Network interface enumeration completed. Dec 19 05:34:09 volumio-7814a avahi-daemon[486]: Server startup complete. Host name is volumio-7814a.local. Local service cookie is 1218599850. Dec 19 05:34:09 volumio-7814a avahi-daemon[486]: Service "Volumio-7814A" (/services/volumio.service) successfully established. Dec 19 05:34:09 volumio-7814a sh[414]: wlan0=wlan0 Dec 19 05:34:09 volumio-7814a volumio-remote-updater[482]: Error: No active session Dec 19 05:34:09 volumio-7814a systemd[1]: Started Raise network interfaces. Dec 19 05:34:09 volumio-7814a volumio-remote-updater[482]: [2025-12-19 05:34:09] [info] asio async_connect error: system:111 (Connection refused) Dec 19 05:34:09 volumio-7814a volumio-remote-updater[482]: [2025-12-19 05:34:09] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 19 05:34:09 volumio-7814a volumio-remote-updater[482]: [2025-12-19 05:34:09] [error] handle_connect error: Underlying Transport Error Dec 19 05:34:09 volumio-7814a systemd[1]: Started WPA supplicant. Dec 19 05:34:09 volumio-7814a systemd[1]: Reached target Network. Dec 19 05:34:09 volumio-7814a systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Dec 19 05:34:09 volumio-7814a haveged[439]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Dec 19 05:34:09 volumio-7814a haveged[439]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Dec 19 05:34:09 volumio-7814a haveged[439]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00024 Dec 19 05:34:09 volumio-7814a haveged[439]: haveged: fills: 0, generated: 0 Dec 19 05:34:09 volumio-7814a systemd[1]: Starting Network Time Service... Dec 19 05:34:09 volumio-7814a volumio[474]: Could not open config: /tmp/upmpdcli.conf Dec 19 05:34:09 volumio-7814a systemd[1]: Starting Permit User Sessions... Dec 19 05:34:09 volumio-7814a systemd[1]: Reached target Network is Online. Dec 19 05:34:09 volumio-7814a systemd[1]: Starting LSB: Brings up/down network automatically... Dec 19 05:34:09 volumio-7814a systemd[1]: Starting Samba NMB Daemon... Dec 19 05:34:09 volumio-7814a systemd[1]: Starting /etc/rc.local Compatibility... Dec 19 05:34:09 volumio-7814a systemd[1]: Starting Raspberry Pi bluetooth helper... Dec 19 05:34:09 volumio-7814a systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 19 05:34:09 volumio-7814a volumio-time-update[489]: volumio-time-update-util: Date not found in response Dec 19 05:34:09 volumio-7814a volumio-time-update[489]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 05:34:09 volumio-7814a systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 19 05:34:09 volumio-7814a systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 19 05:34:09 volumio-7814a systemd[1]: Started Permit User Sessions. Dec 19 05:34:09 volumio-7814a systemd[1]: Started /etc/rc.local Compatibility. Dec 19 05:34:09 volumio-7814a systemd[1]: Starting Terminate Plymouth Boot Screen... Dec 19 05:34:09 volumio-7814a systemd[1]: Starting Hold until boot process finishes up... Dec 19 05:34:09 volumio-7814a systemd[1]: iptables.service: Succeeded. Dec 19 05:34:09 volumio-7814a systemd[1]: Received SIGRTMIN+21 from PID 160 (plymouthd). Dec 19 05:34:09 volumio-7814a systemd[1]: plymouth-quit.service: Succeeded. Dec 19 05:34:09 volumio-7814a systemd[1]: Started Terminate Plymouth Boot Screen. Dec 19 05:34:09 volumio-7814a systemd[1]: plymouth-quit-wait.service: Succeeded. Dec 19 05:34:09 volumio-7814a systemd[1]: Started Hold until boot process finishes up. Dec 19 05:34:09 volumio-7814a systemd[1]: Received SIGRTMIN+21 from PID 160 (n/a). Dec 19 05:34:09 volumio-7814a loadcpufreq[492]: Loading cpufreq kernel modules...done (none). Dec 19 05:34:09 volumio-7814a systemd[1]: Started Getty on tty1. Dec 19 05:34:09 volumio-7814a ifplugd[583]: Network Interface Plugging Daemon...skip eth0...done. Dec 19 05:34:09 volumio-7814a systemd[1]: Reached target Login Prompts. Dec 19 05:34:09 volumio-7814a bthelper[587]: Raspberry Pi BDADDR already set Dec 19 05:34:09 volumio-7814a systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Dec 19 05:34:09 volumio-7814a systemd[1]: Started LSB: Brings up/down network automatically. Dec 19 05:34:09 volumio-7814a systemd[1]: Started Raspberry Pi bluetooth helper. Dec 19 05:34:09 volumio-7814a systemd[1]: Starting Bluetooth service... Dec 19 05:34:09 volumio-7814a systemd[1]: Starting LSB: set CPUFreq kernel parameters... Dec 19 05:34:10 volumio-7814a ntpd[577]: ntpd 4.2.8p12@1.3728-o (1): Starting Dec 19 05:34:10 volumio-7814a ntpd[577]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Dec 19 05:34:10 volumio-7814a systemd[1]: Started Network Time Service. Dec 19 05:34:10 volumio-7814a ntpd[638]: proto: precision = 0.833 usec (-20) Dec 19 05:34:10 volumio-7814a ntpd[638]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Dec 19 05:34:10 volumio-7814a ntpd[638]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Dec 19 05:34:10 volumio-7814a ntpd[638]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 357 days ago Dec 19 05:34:10 volumio-7814a ntpd[638]: Listen and drop on 0 v6wildcard [::]:123 Dec 19 05:34:10 volumio-7814a ntpd[638]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Dec 19 05:34:10 volumio-7814a ntpd[638]: Listen normally on 2 lo 127.0.0.1:123 Dec 19 05:34:10 volumio-7814a ntpd[638]: Listening on routing socket on fd #19 for interface updates Dec 19 05:34:10 volumio-7814a ntpd[638]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 19 05:34:10 volumio-7814a ntpd[638]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 19 05:34:10 volumio-7814a cpufrequtils[634]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Dec 19 05:34:10 volumio-7814a systemd[1]: Started LSB: set CPUFreq kernel parameters. Dec 19 05:34:10 volumio-7814a bluetoothd[633]: Bluetooth daemon 5.83 Dec 19 05:34:10 volumio-7814a bluetoothd[633]: src/main.c:check_options() Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Dec 19 05:34:10 volumio-7814a systemd[1]: Started Bluetooth service. Dec 19 05:34:10 volumio-7814a systemd[1]: Reached target Bluetooth. Dec 19 05:34:10 volumio-7814a bluetoothd[633]: Starting SDP server Dec 19 05:34:10 volumio-7814a bluetoothd[633]: Excluding (cli) hostname Dec 19 05:34:10 volumio-7814a bluetoothd[633]: Excluding (cli) scanparam Dec 19 05:34:10 volumio-7814a bluetoothd[633]: Excluding (cli) battery Dec 19 05:34:10 volumio-7814a kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Dec 19 05:34:10 volumio-7814a kernel: Bluetooth: BNEP filters: protocol multicast Dec 19 05:34:10 volumio-7814a kernel: Bluetooth: BNEP socket layer initialized Dec 19 05:34:10 volumio-7814a bluetoothd[633]: Bluetooth management interface 1.22 initialized Dec 19 05:34:10 volumio-7814a bluetoothd[633]: Battery Provider Manager created Dec 19 05:34:10 volumio-7814a kernel: Bluetooth: MGMT ver 1.22 Dec 19 05:34:10 volumio-7814a kernel: NET: Registered PF_ALG protocol family Dec 19 05:34:10 volumio-7814a kernel: cryptd: max_cpu_qlen set to 1000 Dec 19 05:34:10 volumio-7814a bluetoothd[633]: Failed to set privacy: Rejected (0x0b) Dec 19 05:34:11 volumio-7814a ntpd[638]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Dec 19 05:34:11 volumio-7814a nmbd[593]: [2025/12/19 05:34:11.258323, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Dec 19 05:34:11 volumio-7814a nmbd[593]: started asyncdns process 671 Dec 19 05:34:11 volumio-7814a nmbd[593]: [2025/12/19 05:34:11.260945, 0] ../lib/util/become_daemon.c:149(daemon_status) Dec 19 05:34:11 volumio-7814a nmbd[593]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Dec 19 05:34:11 volumio-7814a nmbd[593]: [2025/12/19 05:34:11.261205, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Dec 19 05:34:11 volumio-7814a nmbd[593]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Dec 19 05:34:11 volumio-7814a wireless.js[475]: Cleaning previous... Dec 19 05:34:11 volumio-7814a sudo[679]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Dec 19 05:34:11 volumio-7814a sudo[679]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:11 volumio-7814a sudo[679]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:11 volumio-7814a sudo[681]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Dec 19 05:34:11 volumio-7814a sudo[681]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:12 volumio-7814a ntpd[638]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Dec 19 05:34:12 volumio-7814a sudo[681]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:12 volumio-7814a wireless.js[475]: Stopped aP Dec 19 05:34:12 volumio-7814a sudo[688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 19 05:34:12 volumio-7814a sudo[688]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:12 volumio-7814a sudo[688]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:12 volumio-7814a kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 19 05:34:12 volumio-7814a sudo[690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 19 05:34:12 volumio-7814a sudo[690]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:12 volumio-7814a sudo[690]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:12 volumio-7814a systemd[1]: systemd-rfkill.service: Succeeded. Dec 19 05:34:12 volumio-7814a sudo[697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 19 05:34:12 volumio-7814a sudo[697]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:12 volumio-7814a sudo[697]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:12 volumio-7814a sudo[699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 19 05:34:12 volumio-7814a sudo[699]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:13 volumio-7814a ntpd[638]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Dec 19 05:34:13 volumio-7814a sudo[699]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:13 volumio-7814a wireless.js[475]: SETTING APPROPRIATE REG DOMAIN: DE Dec 19 05:34:13 volumio-7814a sudo[704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 19 05:34:13 volumio-7814a sudo[704]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:13 volumio-7814a sudo[704]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:13 volumio-7814a sudo[706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Dec 19 05:34:13 volumio-7814a sudo[706]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:13 volumio-7814a sudo[706]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:13 volumio-7814a wireless.js[475]: SUCCESSFULLY SET NEW REGDOMAIN: DE Dec 19 05:34:13 volumio-7814a wireless.js[475]: Start wireless flow Dec 19 05:34:13 volumio-7814a wireless.js[475]: Stopped hotspot (if there).. Dec 19 05:34:13 volumio-7814a sudo[711]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Dec 19 05:34:13 volumio-7814a sudo[711]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:13 volumio-7814a sudo[711]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:13 volumio-7814a sudo[713]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Dec 19 05:34:13 volumio-7814a sudo[713]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:13 volumio-7814a sudo[713]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:13 volumio-7814a wireless.js[475]: DHCP IP Dec 19 05:34:13 volumio-7814a wireless.js[475]: Start ap Dec 19 05:34:13 volumio-7814a wpa_supplicant[715]: Successfully initialized wpa_supplicant Dec 19 05:34:13 volumio-7814a sudo[716]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Dec 19 05:34:13 volumio-7814a sudo[716]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:13 volumio-7814a kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 19 05:34:14 volumio-7814a dhcpcd[717]: dev: loaded udev Dec 19 05:34:14 volumio-7814a ntpd[638]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Dec 19 05:34:14 volumio-7814a kernel: 8021q: 802.1Q VLAN Support v1.8 Dec 19 05:34:14 volumio-7814a dhcpcd-run-hooks[725]: wlan0: starting wpa_supplicant Dec 19 05:34:14 volumio-7814a dhcpcd-run-hooks[730]: wlan0: failed to start wpa_supplicant Dec 19 05:34:14 volumio-7814a dhcpcd-run-hooks[731]: 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 19 05:34:14 volumio-7814a dhcpcd[717]: wlan0: connected to Access Point `' Dec 19 05:34:14 volumio-7814a volumio-remote-updater[482]: [2025-12-19 05:34:14] [info] asio async_connect error: system:111 (Connection refused) Dec 19 05:34:14 volumio-7814a volumio-remote-updater[482]: [2025-12-19 05:34:14] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 19 05:34:14 volumio-7814a volumio-remote-updater[482]: [2025-12-19 05:34:14] [error] handle_connect error: Underlying Transport Error Dec 19 05:34:14 volumio-7814a dhcpcd[717]: no interfaces have a carrier Dec 19 05:34:14 volumio-7814a dhcpcd[717]: forked to background, child pid 745 Dec 19 05:34:14 volumio-7814a dhcpcd[745]: wlan0: waiting for carrier Dec 19 05:34:14 volumio-7814a sudo[716]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:14 volumio-7814a volumio-time-update[489]: volumio-time-update-util: Fetching time from Volumio... Dec 19 05:34:14 volumio-7814a volumio-time-update[489]: volumio-time-update-util: Date not found in response Dec 19 05:34:14 volumio-7814a volumio-time-update[489]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 05:34:14 volumio-7814a wpa_supplicant[729]: wlan0: Trying to associate with SSID 'Signal' Dec 19 05:34:14 volumio-7814a wireless.js[475]: trying... Dec 19 05:34:14 volumio-7814a bluetoothd[633]: src/adv_monitor.c:btd_adv_monitor_power_down() Unexpected NULL btd_adv_monitor_manager object upon power down Dec 19 05:34:14 volumio-7814a bthelper[587]: [NEW] Media /org/bluez/hci0 Dec 19 05:34:14 volumio-7814a bthelper[587]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Dec 19 05:34:14 volumio-7814a bthelper[587]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Dec 19 05:34:14 volumio-7814a bthelper[587]: [CHG] Controller 2C:CF:67:0A:FA:A9 PowerState: on-disabling Dec 19 05:34:14 volumio-7814a bthelper[587]: hci0 class of device changed: 0x000000 Dec 19 05:34:14 volumio-7814a bthelper[587]: hci0 new_settings: ssp br/edr le secure-conn Dec 19 05:34:14 volumio-7814a bthelper[587]: Changing power off succeeded Dec 19 05:34:14 volumio-7814a sudo[753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 05:34:14 volumio-7814a sudo[753]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:15 volumio-7814a sudo[753]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:15 volumio-7814a bthelper[587]: [NEW] Media /org/bluez/hci0 Dec 19 05:34:15 volumio-7814a bthelper[587]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Dec 19 05:34:15 volumio-7814a bthelper[587]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Dec 19 05:34:15 volumio-7814a bthelper[587]: [CHG] Controller 2C:CF:67:0A:FA:A9 PowerState: off-enabling Dec 19 05:34:15 volumio-7814a bthelper[587]: hci0 class of device changed: 0x00041c Dec 19 05:34:15 volumio-7814a bthelper[587]: [CHG] Controller 2C:CF:67:0A:FA:A9 Class: 0x0000041c (1052) Dec 19 05:34:15 volumio-7814a bthelper[587]: hci0 new_settings: powered ssp br/edr le secure-conn Dec 19 05:34:15 volumio-7814a bthelper[587]: Changing power on succeeded Dec 19 05:34:15 volumio-7814a dhcpcd[745]: wlan0: carrier acquired Dec 19 05:34:15 volumio-7814a dhcpcd[745]: wlan0: connected to Access Point `Signal' Dec 19 05:34:15 volumio-7814a wpa_supplicant[729]: wlan0: Associated with 98:9b:cb:f0:ab:d5 Dec 19 05:34:15 volumio-7814a wpa_supplicant[729]: wlan0: CTRL-EVENT-CONNECTED - Connection to 98:9b:cb:f0:ab:d5 completed [id=0 id_str=] Dec 19 05:34:15 volumio-7814a wpa_supplicant[729]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Dec 19 05:34:15 volumio-7814a wpa_supplicant[729]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Dec 19 05:34:15 volumio-7814a dhcpcd[745]: DUID 00:01:00:01:2d:69:1f:68:2c:cf:67:0a:fa:a7 Dec 19 05:34:15 volumio-7814a dhcpcd[745]: wlan0: IAID 67:0a:fa:a7 Dec 19 05:34:15 volumio-7814a dhcpcd[745]: wlan0: adding address fe80::d2d2:f12c:2f68:6517 Dec 19 05:34:15 volumio-7814a dhcpcd[745]: ipv6_addaddr1: Permission denied Dec 19 05:34:15 volumio-7814a dhcpcd[745]: wlan0: carrier lost Dec 19 05:34:15 volumio-7814a dhcpcd[745]: wlan0: carrier acquired Dec 19 05:34:15 volumio-7814a dhcpcd[745]: wlan0: IAID 67:0a:fa:a7 Dec 19 05:34:15 volumio-7814a dhcpcd[745]: wlan0: rebinding lease of 192.168.21.24 Dec 19 05:34:15 volumio-7814a dhcpcd[745]: wlan0: probing address 192.168.21.24/16 Dec 19 05:34:15 volumio-7814a wireless.js[475]: trying... Dec 19 05:34:15 volumio-7814a sudo[769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 05:34:15 volumio-7814a sudo[769]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:15 volumio-7814a dhcpcd[745]: wlan0: soliciting an IPv6 router Dec 19 05:34:15 volumio-7814a sudo[769]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:16 volumio-7814a wireless.js[475]: trying... Dec 19 05:34:16 volumio-7814a sudo[772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 05:34:16 volumio-7814a sudo[772]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:16 volumio-7814a sudo[772]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:17 volumio-7814a wireless.js[475]: trying... Dec 19 05:34:17 volumio-7814a sudo[775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 05:34:17 volumio-7814a sudo[775]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:17 volumio-7814a sudo[775]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:18 volumio-7814a wireless.js[475]: trying... Dec 19 05:34:18 volumio-7814a sudo[778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 05:34:18 volumio-7814a sudo[778]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:19 volumio-7814a sudo[778]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:19 volumio-7814a volumio-time-update[489]: volumio-time-update-util: Fetching time from Volumio... Dec 19 05:34:19 volumio-7814a volumio-time-update[489]: volumio-time-update-util: Date not found in response Dec 19 05:34:19 volumio-7814a volumio-time-update[489]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 05:34:19 volumio-7814a wireless.js[475]: trying... Dec 19 05:34:19 volumio-7814a sudo[786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 05:34:19 volumio-7814a sudo[786]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:20 volumio-7814a sudo[786]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:20 volumio-7814a dhcpcd[745]: wlan0: leased 192.168.21.24 for 864000 seconds Dec 19 05:34:20 volumio-7814a avahi-daemon[486]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.21.24. Dec 19 05:34:20 volumio-7814a dhcpcd[745]: wlan0: adding route to 192.168.0.0/16 Dec 19 05:34:20 volumio-7814a dhcpcd[745]: wlan0: adding default route via 192.168.159.17 Dec 19 05:34:20 volumio-7814a avahi-daemon[486]: New relevant interface wlan0.IPv4 for mDNS. Dec 19 05:34:20 volumio-7814a avahi-daemon[486]: Registering new address record for 192.168.21.24 on wlan0.IPv4. Dec 19 05:34:20 volumio-7814a wireless.js[475]: trying... Dec 19 05:34:20 volumio-7814a sudo[810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 05:34:20 volumio-7814a sudo[810]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:21 volumio-7814a sudo[810]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:21 volumio-7814a wireless.js[475]: Connected to: ----Signal Dec 19 05:34:21 volumio-7814a wireless.js[475]: ---- Dec 19 05:34:21 volumio-7814a sudo[813]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 05:34:21 volumio-7814a sudo[813]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:21 volumio-7814a sudo[813]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:21 volumio-7814a wireless.js[475]: ... joined AP, wlan0 IPv4 is 192.168.21.24, ipV6 is undefined Dec 19 05:34:21 volumio-7814a wireless.js[475]: It's done! AP Dec 19 05:34:21 volumio-7814a systemd[1]: Started Wireless Services. Dec 19 05:34:21 volumio-7814a kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 19 05:34:21 volumio-7814a systemd[1]: Started Volumio Backend Module. Dec 19 05:34:21 volumio-7814a systemd[1]: Started Volumio Cpu Tweaker. Dec 19 05:34:21 volumio-7814a volumio-cpu-tweak[819]: Setting RT Priority for mpd Dec 19 05:34:21 volumio-7814a volumio-cpu-tweak[819]: pid 35's current scheduling policy: SCHED_OTHER Dec 19 05:34:21 volumio-7814a volumio-cpu-tweak[819]: pid 35's current scheduling priority: 0 Dec 19 05:34:21 volumio-7814a volumio-cpu-tweak[819]: Setting MPD Affinity Dec 19 05:34:21 volumio-7814a volumio-cpu-tweak[819]: pid 3's current affinity mask: f Dec 19 05:34:21 volumio-7814a volumio-cpu-tweak[819]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Dec 19 05:34:21 volumio-7814a volumio-cpu-tweak[819]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Dec 19 05:34:21 volumio-7814a nmbd[593]: [2025/12/19 05:34:21.269666, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 19 05:34:21 volumio-7814a systemd[1]: Started Samba NMB Daemon. Dec 19 05:34:21 volumio-7814a nmbd[593]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Dec 19 05:34:21 volumio-7814a systemd[1]: Starting Samba Winbind Daemon... Dec 19 05:34:21 volumio-7814a systemd[1]: volumio_cpu_tweak.service: Succeeded. Dec 19 05:34:21 volumio-7814a winbindd[835]: [2025/12/19 05:34:21.710346, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Dec 19 05:34:21 volumio-7814a winbindd[835]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 19 05:34:21 volumio-7814a winbindd[835]: [2025/12/19 05:34:21.737421, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 19 05:34:21 volumio-7814a winbindd[835]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Dec 19 05:34:21 volumio-7814a systemd[1]: Started Samba Winbind Daemon. Dec 19 05:34:21 volumio-7814a systemd[1]: Starting Samba SMB Daemon... Dec 19 05:34:22 volumio-7814a volumio-remote-updater[482]: [2025-12-19 05:34:22] [info] asio async_connect error: system:111 (Connection refused) Dec 19 05:34:22 volumio-7814a volumio-remote-updater[482]: [2025-12-19 05:34:22] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 19 05:34:22 volumio-7814a volumio-remote-updater[482]: [2025-12-19 05:34:22] [error] handle_connect error: Underlying Transport Error Dec 19 05:34:22 volumio-7814a ntpd[638]: Listen normally on 3 wlan0 192.168.21.24:123 Dec 19 05:34:22 volumio-7814a ntpd[638]: new interface(s) found: waking up resolver Dec 19 05:34:22 volumio-7814a smbd[840]: [2025/12/19 05:34:22.479064, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 19 05:34:22 volumio-7814a systemd[1]: Started Samba SMB Daemon. Dec 19 05:34:22 volumio-7814a smbd[840]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Dec 19 05:34:24 volumio-7814a volumio[818]: info: ------------------------------------------- Dec 19 05:34:24 volumio-7814a volumio[818]: info: ----- Volumio3 ---- Dec 19 05:34:24 volumio-7814a volumio[818]: info: ------------------------------------------- Dec 19 05:34:24 volumio-7814a volumio[818]: info: ----- System startup ---- Dec 19 05:34:24 volumio-7814a volumio[818]: info: ------------------------------------------- Dec 19 05:34:24 volumio-7814a volumio-time-update[489]: volumio-time-update-util: Fetching time from Volumio... Dec 19 05:34:25 volumio-7814a volumio[818]: info: MYVOLUMIO Environment detected Dec 19 05:34:26 volumio-7814a volumio[818]: info: Plugin folders cleanup Dec 19 05:34:26 volumio-7814a volumio[818]: info: Scanning into folder /volumio/app/plugins/ Dec 19 05:34:26 volumio-7814a volumio[818]: info: Scanning category audio_interface Dec 19 05:34:26 volumio-7814a volumio[818]: info: Scanning category miscellanea Dec 19 05:34:26 volumio-7814a volumio[818]: info: Scanning category music_service Dec 19 05:34:26 volumio-7814a volumio[818]: info: Scanning category plugins.json Dec 19 05:34:26 volumio-7814a volumio[818]: info: Scanning category system_controller Dec 19 05:34:26 volumio-7814a volumio[818]: info: Scanning category user_interface Dec 19 05:34:26 volumio-7814a volumio[818]: info: Scanning into folder /data/plugins/ Dec 19 05:34:26 volumio-7814a volumio[818]: info: Scanning category audio_interface Dec 19 05:34:26 volumio-7814a volumio[818]: info: Scanning category system_controller Dec 19 05:34:26 volumio-7814a volumio[818]: info: Plugin folders cleanup completed Dec 19 05:34:26 volumio-7814a volumio[818]: info: ------------------------------------------- Dec 19 05:34:26 volumio-7814a volumio[818]: info: ----- Core plugins startup ---- Dec 19 05:34:26 volumio-7814a volumio[818]: info: ------------------------------------------- Dec 19 05:34:26 volumio-7814a volumio[818]: info: Loading plugins from folder /volumio/app/plugins/ Dec 19 05:34:26 volumio-7814a volumio[818]: info: Adding plugin upnp to MyMusic Plugins Dec 19 05:34:26 volumio-7814a volumio[818]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 19 05:34:26 volumio-7814a volumio[818]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 19 05:34:26 volumio-7814a volumio[818]: info: Loading plugins from folder /data/plugins/ Dec 19 05:34:26 volumio-7814a volumio[818]: info: Loading plugin "system"... Dec 19 05:34:26 volumio-7814a volumio[818]: info: Loading plugin "appearance"... Dec 19 05:34:28 volumio-7814a volumio[818]: info: Loading plugin "network"... Dec 19 05:34:28 volumio-7814a volumio[818]: info: Refreshing Cached IP Addresses Dec 19 05:34:28 volumio-7814a sudo[866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 05:34:28 volumio-7814a sudo[866]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:28 volumio-7814a sudo[868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 05:34:28 volumio-7814a sudo[868]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:28 volumio-7814a sudo[868]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:28 volumio-7814a sudo[866]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:28 volumio-7814a volumio[818]: info: Loading plugin "services"... Dec 19 05:34:28 volumio-7814a sudo[880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 05:34:28 volumio-7814a sudo[880]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:28 volumio-7814a volumio[818]: info: Loading plugin "alsa_controller"... Dec 19 05:34:28 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 05:34:28 volumio-7814a volumio[818]: info: Loading plugin "wizard"... Dec 19 05:34:28 volumio-7814a volumio[818]: info: Loading plugin "networkfs"... Dec 19 05:34:28 volumio-7814a volumio[818]: info: Starting Udev Watcher for removable devices Dec 19 05:34:28 volumio-7814a sudo[896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Melanthius,password=1MsiWa17B.,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.2.66/Music /mnt/NAS/NAS Dec 19 05:34:28 volumio-7814a sudo[896]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:28 volumio-7814a volumio[818]: info: Ignoring mount for partition: boot Dec 19 05:34:28 volumio-7814a volumio[818]: info: Ignoring mount for partition: volumio Dec 19 05:34:28 volumio-7814a volumio[818]: info: Ignoring mount for partition: volumio_data Dec 19 05:34:28 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 05:34:28 volumio-7814a volumio[818]: info: Loading plugin "volumio_command_line_client"... Dec 19 05:34:28 volumio-7814a volumio[818]: info: Loading plugin "upnp"... Dec 19 05:34:28 volumio-7814a volumio[818]: info: [1766118868500] Starting Upmpd Daemon Dec 19 05:34:28 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 05:34:28 volumio-7814a volumio[818]: info: Loading plugin "my_music"... Dec 19 05:34:28 volumio-7814a volumio[818]: info: Loading plugin "mpd"... Dec 19 05:34:28 volumio-7814a kernel: Key type cifs.spnego registered Dec 19 05:34:28 volumio-7814a kernel: Key type cifs.idmap registered Dec 19 05:34:28 volumio-7814a 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 19 05:34:28 volumio-7814a kernel: CIFS: Attempting to mount //192.168.2.66/Music Dec 19 05:34:29 volumio-7814a sudo[880]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:29 volumio-7814a volumio[818]: info: Loading plugin "upnp_browser"... Dec 19 05:34:29 volumio-7814a volumio[818]: info: Starting UPNP Browser Dec 19 05:34:29 volumio-7814a volumio[818]: info: Loading plugin "alarm-clock"... Dec 19 05:34:29 volumio-7814a volumio[818]: info: Loading plugin "airplay_emulation"... Dec 19 05:34:30 volumio-7814a volumio[818]: info: Starting Shairport Sync Dec 19 05:34:30 volumio-7814a volumio[818]: info: Loading plugin "last_100"... Dec 19 05:34:30 volumio-7814a volumio[818]: info: Loading plugin "webradio"... Dec 19 05:34:30 volumio-7814a volumio[818]: info: Loading plugin "i2s_dacs"... Dec 19 05:34:30 volumio-7814a volumio[818]: info: I2S DAC not set, start Auto-detection Dec 19 05:34:30 volumio-7814a volumio[818]: info: Loading plugin "volumiodiscovery"... Dec 19 05:34:30 volumio-7814a volumio[818]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 05:34:30 volumio-7814a volumio[818]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 05:34:30 volumio-7814a volumio[818]: *** WARNING *** For more information see Dec 19 05:34:30 volumio-7814a volumio[818]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 05:34:30 volumio-7814a node[818]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 05:34:30 volumio-7814a volumio[818]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 05:34:30 volumio-7814a volumio[818]: *** WARNING *** For more information see Dec 19 05:34:30 volumio-7814a node[818]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 05:34:30 volumio-7814a node[818]: *** WARNING *** For more information see Dec 19 05:34:30 volumio-7814a node[818]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 05:34:30 volumio-7814a node[818]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 05:34:30 volumio-7814a node[818]: *** WARNING *** For more information see Dec 19 05:34:30 volumio-7814a volumio[818]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 19 05:34:30 volumio-7814a volumio[818]: info: Discovery: Started advertising with name: Volumio-7814A Dec 19 05:34:30 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 05:34:30 volumio-7814a volumio[818]: info: Loading plugin "autostart"... Dec 19 05:34:30 volumio-7814a volumio[818]: info: Applying required configuration parameters for plugin autostart Dec 19 05:34:30 volumio-7814a volumio[818]: info: AutoStart - onVolumioStart - read config.json Dec 19 05:34:30 volumio-7814a volumio[818]: info: Loading plugin "outputs"... Dec 19 05:34:30 volumio-7814a volumio[818]: info: Loading plugin "albumart"... Dec 19 05:34:30 volumio-7814a volumio[818]: info: Plugin example_plugin is not enabled Dec 19 05:34:30 volumio-7814a volumio[818]: info: Loading plugin "inputs"... Dec 19 05:34:30 volumio-7814a volumio[818]: info: Loading plugin "updater_comm"... Dec 19 05:34:31 volumio-7814a volumio[818]: info: Plugin mpdemulation is not enabled Dec 19 05:34:31 volumio-7814a volumio[818]: info: Loading plugin "rest_api"... Dec 19 05:34:31 volumio-7814a volumio[818]: info: Loading plugin "websocket"... Dec 19 05:34:31 volumio-7814a volumio[818]: info: Starting Socket.io Server version 2.3.0 Dec 19 05:34:31 volumio-7814a volumio[818]: info: Loading plugin "fusiondsp"... Dec 19 05:34:31 volumio-7814a volumio[818]: Forking 3 albumart workers Dec 19 05:34:32 volumio-7814a volumio[818]: info: Applying required configuration parameters for plugin fusiondsp Dec 19 05:34:32 volumio-7814a volumio-remote-updater[482]: [2025-12-19 05:34:32] [connect] Successful connection Dec 19 05:34:32 volumio-7814a volumio[818]: info: Loading i18n strings for locale de Dec 19 05:34:32 volumio-7814a volumio[818]: Updating browse sources language Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 05:34:32 volumio-7814a volumio[818]: Starting albumart workers Dec 19 05:34:32 volumio-7814a volumio[818]: Starting albumart workers Dec 19 05:34:32 volumio-7814a volumio[818]: Starting albumart workers Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::initPlayerControls Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 05:34:32 volumio-7814a volumio[818]: Express server listening on port 3000 Dec 19 05:34:32 volumio-7814a volumio[818]: [Metrics] WebUI: 9s 376.87ms Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreStateMachine::resetVolumioState Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreStateMachine::getcurrentVolume Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 05:34:32 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:34:32 volumio-7814a volumio[818]: info: Volumio Network Manager: Network status updated: 2 Dec 19 05:34:33 volumio-7814a volumio-remote-updater[482]: [2025-12-19 05:34:33] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766118872 101 Dec 19 05:34:33 volumio-7814a volumio[818]: 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 19 05:34:33 volumio-7814a volumio[818]: info: Reloading queue from file Dec 19 05:34:33 volumio-7814a volumio[818]: info: Setting Device type: Raspberry PI Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreStateMachine::setRepeat null single undefined Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreStateMachine::pushState Dec 19 05:34:33 volumio-7814a volumio[818]: info: CorePlayQueue::getTrack 0 Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioPushState Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreStateMachine::setRandom null Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreStateMachine::pushState Dec 19 05:34:33 volumio-7814a volumio[818]: info: CorePlayQueue::getTrack 0 Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioPushState Dec 19 05:34:33 volumio-7814a volumio[818]: info: VolumeController:: Volume=79 Mute =false Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreStateMachine::pushState Dec 19 05:34:33 volumio-7814a volumio[818]: info: CorePlayQueue::getTrack 0 Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioPushState Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreStateMachine::updateTrackBlock Dec 19 05:34:33 volumio-7814a volumio[818]: info: CorePlayQueue::getTrackBlock Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 05:34:33 volumio-7814a volumio[818]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 19 05:34:33 volumio-7814a volumio[818]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Dec 19 05:34:33 volumio-7814a volumio[818]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 19 05:34:33 volumio-7814a volumio[818]: info: VolumeController:: Volume=79 Mute =false Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreStateMachine::pushState Dec 19 05:34:33 volumio-7814a volumio[818]: info: CorePlayQueue::getTrack 0 Dec 19 05:34:33 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioPushState Dec 19 05:34:34 volumio-7814a sudo[896]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:34 volumio-7814a volumio[818]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Dec 19 05:34:34 volumio-7814a volumio[818]: info: Completed loading Core Plugins Dec 19 05:34:34 volumio-7814a kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 05:34:34 volumio-7814a kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Dec 19 05:34:34 volumio-7814a volumio[818]: info: Preparing to generate the ALSA configuration file Dec 19 05:34:34 volumio-7814a volumio[818]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 19 05:34:34 volumio-7814a volumio[818]: info: Reading ALSA contributions from plugins. Dec 19 05:34:34 volumio-7814a volumio[818]: info: Asound.conf file unchanged, so no further update is needed Dec 19 05:34:34 volumio-7814a volumio[818]: info: Output device has changed, restarting MPD Dec 19 05:34:35 volumio-7814a volumio[818]: info: Output device has changed, restarting Shairport Sync Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:34:35 volumio-7814a sudo[977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 05:34:35 volumio-7814a sudo[979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 05:34:35 volumio-7814a sudo[977]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:35 volumio-7814a sudo[979]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:35 volumio-7814a sudo[977]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:35 volumio-7814a volumio[818]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 05:34:35 volumio-7814a volumio[818]: info: ___________ START PLUGINS ___________ Dec 19 05:34:35 volumio-7814a volumio[818]: info: ControllerMpd::onStart: Initializing MPD Dec 19 05:34:35 volumio-7814a volumio[818]: info: Creating MPD Configuration file Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 05:34:35 volumio-7814a volumio[818]: info: [1766118875121] CoreMusicLibrary::Adding element Medienserver Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 05:34:35 volumio-7814a sudo[986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 05:34:35 volumio-7814a sudo[986]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:35 volumio-7814a volumio[818]: info: UPNP Browser: Client initialized successfully Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:34:35 volumio-7814a sudo[986]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:35 volumio-7814a sudo[989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 05:34:35 volumio-7814a sudo[989]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:35 volumio-7814a systemd[1]: Listening on mpd.socket. Dec 19 05:34:35 volumio-7814a systemd[1]: Starting Music Player Daemon... Dec 19 05:34:35 volumio-7814a systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 19 05:34:35 volumio-7814a systemd[1]: mpd.service: Succeeded. Dec 19 05:34:35 volumio-7814a systemd[1]: Stopped Music Player Daemon. Dec 19 05:34:35 volumio-7814a systemd[1]: Starting Music Player Daemon... Dec 19 05:34:35 volumio-7814a volumio[818]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 05:34:35 volumio-7814a volumio[818]: info: [1766118875281] CoreMusicLibrary::Adding element Last_100 Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 05:34:35 volumio-7814a volumio[818]: info: [1766118875285] CoreMusicLibrary::Adding element Webradio Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 05:34:35 volumio-7814a volumio[818]: info: Initializing BBC Radios Dec 19 05:34:35 volumio-7814a volumio[818]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:34:35 volumio-7814a sudo[996]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 05:34:35 volumio-7814a sudo[996]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:35 volumio-7814a sudo[996]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 19 05:34:35 volumio-7814a sudo[996]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: AutoStart - onStart Dec 19 05:34:35 volumio-7814a volumio[818]: info: Loading i18n strings for locale de Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: FusionDsp - mixtype--------------------- Hardware Dec 19 05:34:35 volumio-7814a volumio[818]: info: Volumio Calling Home Dec 19 05:34:35 volumio-7814a volumio[818]: info: Preparing to generate the ALSA configuration file Dec 19 05:34:35 volumio-7814a volumio[818]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 19 05:34:35 volumio-7814a volumio[818]: info: Reading ALSA contributions from plugins. Dec 19 05:34:35 volumio-7814a volumio[818]: info: MPD Permissions set Dec 19 05:34:35 volumio-7814a volumio[818]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:35 volumio-7814a volumio[818]: info: Starting Shairport Sync Dec 19 05:34:35 volumio-7814a volumio[818]: info: Starting Shairport Sync Dec 19 05:34:35 volumio-7814a volumio[818]: info: Starting Shairport Sync Dec 19 05:34:36 volumio-7814a sudo[1024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 19 05:34:36 volumio-7814a sudo[1024]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:36 volumio-7814a sudo[1026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 19 05:34:36 volumio-7814a sudo[1026]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:36 volumio-7814a volumio[818]: info: Asound.conf file unchanged, so no further update is needed Dec 19 05:34:36 volumio-7814a volumio[818]: info: Output device has changed, restarting MPD Dec 19 05:34:36 volumio-7814a sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 19 05:34:36 volumio-7814a sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:36 volumio-7814a volumio[818]: info: Output device has changed, restarting Shairport Sync Dec 19 05:34:36 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:36 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:34:36 volumio-7814a sudo[1033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 05:34:36 volumio-7814a sudo[1033]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:36 volumio-7814a sudo[1033]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:36 volumio-7814a sudo[1035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 05:34:36 volumio-7814a sudo[1035]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:36 volumio-7814a systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 19 05:34:36 volumio-7814a systemd[1]: shairport-sync.service: Succeeded. Dec 19 05:34:36 volumio-7814a systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 19 05:34:36 volumio-7814a volumio[818]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 05:34:36 volumio-7814a volumio[818]: info: MPD Permissions set Dec 19 05:34:36 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:36 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:36 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:36 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:36 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:36 volumio-7814a systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 19 05:34:36 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:36 volumio-7814a sudo[1024]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:36 volumio-7814a sudo[1026]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:36 volumio-7814a systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 19 05:34:36 volumio-7814a systemd[1]: mpd.service: Succeeded. Dec 19 05:34:36 volumio-7814a systemd[1]: Stopped Music Player Daemon. Dec 19 05:34:36 volumio-7814a sudo[1029]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:36 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:34:36 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:36 volumio-7814a volumio[818]: info: Shairport-Sync Started Dec 19 05:34:36 volumio-7814a systemd[1]: Starting Music Player Daemon... Dec 19 05:34:36 volumio-7814a volumio[818]: Error adding Membership: Error: addMembership EINVAL Dec 19 05:34:36 volumio-7814a volumio[818]: info: Shairport-Sync Started Dec 19 05:34:36 volumio-7814a volumio[818]: info: Starting Shairport Sync Dec 19 05:34:36 volumio-7814a sudo[1049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 19 05:34:36 volumio-7814a sudo[1049]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:36 volumio-7814a systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 19 05:34:36 volumio-7814a systemd[1]: shairport-sync.service: Succeeded. Dec 19 05:34:36 volumio-7814a systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 19 05:34:36 volumio-7814a sudo[1046]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 05:34:36 volumio-7814a sudo[1046]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:36 volumio-7814a systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 19 05:34:36 volumio-7814a sudo[1046]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 19 05:34:36 volumio-7814a sudo[1046]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:36 volumio-7814a sudo[1049]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:36 volumio-7814a volumio[818]: info: Shairport-Sync Started Dec 19 05:34:37 volumio-7814a volumio[818]: info: camilladsp spawned new process with pid 1063, instance 1, run: true Dec 19 05:34:37 volumio-7814a volumio[818]: info: camilladsp service started and running in background, instance 1 Dec 19 05:34:37 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:34:37 volumio-7814a volumio[818]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 <-AAAAAAAAAAAAA Dec 19 05:34:37 volumio-7814a volumio[818]: info: FusionDsp loaded Dec 19 05:34:37 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 05:34:37 volumio-7814a volumio[818]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 19 05:34:37 volumio-7814a volumio[818]: info: Adding Signal Path Element [object Object] Dec 19 05:34:37 volumio-7814a volumio[818]: info: Adding fusiondspeq DSP Signal Path Element Dec 19 05:34:37 volumio-7814a sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 19 05:34:37 volumio-7814a sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:37 volumio-7814a volumio[818]: info: FusionDsp - ---- installed callbackRead Dec 19 05:34:37 volumio-7814a volumio[818]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 19 05:34:37 volumio-7814a volumio[818]: info: FusionDsp - Loudness is ON true Dec 19 05:34:37 volumio-7814a systemd[1]: Started FusionDsp Daemon. Dec 19 05:34:37 volumio-7814a systemd[1]: systemd-fsckd.service: Succeeded. Dec 19 05:34:37 volumio-7814a sudo[1067]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:38 volumio-7814a sudo[1093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 05:34:38 volumio-7814a sudo[1093]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:38 volumio-7814a sudo[1091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 05:34:38 volumio-7814a sudo[1093]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:38 volumio-7814a sudo[1091]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:38 volumio-7814a sudo[1095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 19 05:34:38 volumio-7814a sudo[1095]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:38 volumio-7814a sudo[1091]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:38 volumio-7814a systemd[1]: Started UPnP Renderer front-end to MPD. Dec 19 05:34:38 volumio-7814a sudo[1095]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:38 volumio-7814a volumio[818]: info: Upmpdcli Daemon Started Dec 19 05:34:39 volumio-7814a sudo[1103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Melanthius,password=1MsiWa17B.,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.2.66/Music /mnt/NAS/NAS Dec 19 05:34:39 volumio-7814a sudo[1103]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:40 volumio-7814a kernel: CIFS: Attempting to mount //192.168.2.66/Music Dec 19 05:34:40 volumio-7814a mpd[1054]: Dec 19 05:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 05:34:40 volumio-7814a systemd[1]: Started Music Player Daemon. Dec 19 05:34:40 volumio-7814a sudo[1035]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:40 volumio-7814a sudo[979]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:40 volumio-7814a sudo[989]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:40 volumio-7814a volumio[818]: info: Completed starting Core Plugins Dec 19 05:34:40 volumio-7814a volumio[818]: info: ------------------------------------------- Dec 19 05:34:40 volumio-7814a volumio[818]: info: ----- MyVolumio plugins startup ---- Dec 19 05:34:40 volumio-7814a volumio[818]: info: ------------------------------------------- Dec 19 05:34:40 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 19 05:34:40 volumio-7814a volumio[818]: error: MPD error: The expression evaluated to a falsy value: Dec 19 05:34:40 volumio-7814a volumio[818]: assert.ok(self.idling) Dec 19 05:34:40 volumio-7814a volumio[818]: error: The expression evaluated to a falsy value: Dec 19 05:34:40 volumio-7814a volumio[818]: assert.ok(self.idling) Dec 19 05:34:40 volumio-7814a volumio[818]: error: MPD error: The expression evaluated to a falsy value: Dec 19 05:34:40 volumio-7814a volumio[818]: assert.ok(self.idling) Dec 19 05:34:40 volumio-7814a volumio[818]: error: The expression evaluated to a falsy value: Dec 19 05:34:40 volumio-7814a volumio[818]: assert.ok(self.idling) Dec 19 05:34:40 volumio-7814a volumio[818]: info: MPD running with PID1054 Dec 19 05:34:40 volumio-7814a volumio[818]: ,establishing connection Dec 19 05:34:40 volumio-7814a volumio[818]: error: updateQueue error: null Dec 19 05:34:40 volumio-7814a volumio[818]: error: updateQueue error: null Dec 19 05:34:40 volumio-7814a volumio[1101]: Generating RSA private key, 4096 bit long modulus (2 primes) Dec 19 05:34:43 volumio-7814a sudo[1127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 19 05:34:43 volumio-7814a sudo[1129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 19 05:34:43 volumio-7814a sudo[1127]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:43 volumio-7814a sudo[1129]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:43 volumio-7814a sudo[1131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 19 05:34:43 volumio-7814a sudo[1131]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:43 volumio-7814a sudo[1129]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:43 volumio-7814a systemd[1]: Started MPD Monitor Service. Dec 19 05:34:43 volumio-7814a sudo[1127]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:43 volumio-7814a volumio[818]: info: Successfully started MPD Monitor Dec 19 05:34:43 volumio-7814a sudo[1131]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:43 volumio-7814a volumio[818]: info: Successfully started MPD Monitor Dec 19 05:34:43 volumio-7814a mpd_monitor.sh[1135]: MPD Monitor Service: Starting MPD Monitor Service Dec 19 05:34:43 volumio-7814a volumio[818]: info: Successfully started MPD Monitor Dec 19 05:34:44 volumio-7814a volumio[1101]: .................++++ Dec 19 05:34:45 volumio-7814a sudo[1103]: pam_unix(sudo:session): session closed for user root Dec 19 05:34:45 volumio-7814a kernel: CIFS: VFS: cifs_mount failed w/return code = -112 Dec 19 05:34:45 volumio-7814a volumio[818]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds Dec 19 05:34:45 volumio-7814a volumio[818]: verbose: New Socket.io Connection to 192.168.21.24:3000 from 192.168.21.17 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 19 05:34:45 volumio-7814a volumio[818]: verbose: New Socket.io Connection to 192.168.21.24:3000 from 192.168.21.17 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Dec 19 05:34:46 volumio-7814a volumio[818]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 19 05:34:51 volumio-7814a sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Melanthius,password=1MsiWa17B.,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.2.66/Music /mnt/NAS/NAS Dec 19 05:34:51 volumio-7814a sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:34:51 volumio-7814a kernel: CIFS: Attempting to mount //192.168.2.66/Music Dec 19 05:34:54 volumio-7814a volumio[1101]: ..............................................................++++ Dec 19 05:34:54 volumio-7814a volumio[1101]: e is 65537 (0x010001) Dec 19 05:34:54 volumio-7814a volumio[1101]: writing RSA key Dec 19 05:34:55 volumio-7814a volumio[818]: info: AutoStart - Plugin is starting Dec 19 05:34:55 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioGetQueue Dec 19 05:34:55 volumio-7814a volumio[818]: info: CoreStateMachine::getQueue Dec 19 05:34:55 volumio-7814a volumio[818]: info: CorePlayQueue::getQueue Dec 19 05:34:55 volumio-7814a volumio[818]: info: AutoStart - start playing Dec 19 05:34:55 volumio-7814a volumio[818]: info: AutoStart - start playing with no specific position Dec 19 05:34:55 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioPlay Dec 19 05:34:55 volumio-7814a volumio[818]: info: CoreStateMachine::play index 0 Dec 19 05:34:55 volumio-7814a volumio[818]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 19 05:34:55 volumio-7814a volumio[818]: info: CoreStateMachine::stop Dec 19 05:34:55 volumio-7814a volumio[818]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 19 05:34:55 volumio-7814a volumio[818]: info: CoreStateMachine::play index undefined Dec 19 05:34:55 volumio-7814a volumio[818]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 19 05:34:55 volumio-7814a volumio[818]: info: CorePlayQueue::getTrack 0 Dec 19 05:34:55 volumio-7814a volumio[818]: info: CoreStateMachine::startPlaybackTimer Dec 19 05:34:55 volumio-7814a volumio[818]: info: CorePlayQueue::getTrack 0 Dec 19 05:34:55 volumio-7814a volumio[818]: info: [1766118895409] ControllerWebradio::clearAddPlayTrack Dec 19 05:34:55 volumio-7814a volumio[818]: verbose: ControllerMpd::sendMpdCommand stop Dec 19 05:34:55 volumio-7814a volumio[818]: info: sendMpdCommand stop took 6 milliseconds Dec 19 05:34:55 volumio-7814a volumio[818]: verbose: ControllerMpd::sendMpdCommand clear Dec 19 05:34:55 volumio-7814a volumio[818]: info: Dec 19 05:34:55 volumio-7814a volumio[818]: ---------------------------- MPD announces system playlist update Dec 19 05:34:55 volumio-7814a volumio[818]: info: Ignoring MPD Status Update Dec 19 05:34:55 volumio-7814a volumio[818]: info: sendMpdCommand clear took 6 milliseconds Dec 19 05:34:55 volumio-7814a volumio[818]: verbose: ControllerMpd::sendMpdCommand load "https://stream.ffn.de/ffn-708090/mp3-192/?ref=tunein" Dec 19 05:34:55 volumio-7814a volumio[818]: info: Dec 19 05:34:55 volumio-7814a volumio[818]: ---------------------------- MPD announces system playlist update Dec 19 05:34:55 volumio-7814a volumio[818]: info: Ignoring MPD Status Update Dec 19 05:34:55 volumio-7814a volumio[818]: info: Dec 19 05:34:55 volumio-7814a volumio[818]: ---------------------------- MPD announces system playlist update Dec 19 05:34:55 volumio-7814a volumio[818]: info: Ignoring MPD Status Update Dec 19 05:34:55 volumio-7814a volumio[818]: info: Dec 19 05:34:55 volumio-7814a volumio[818]: ---------------------------- MPD announces system playlist update Dec 19 05:34:55 volumio-7814a volumio[818]: info: Ignoring MPD Status Update Dec 19 05:34:55 volumio-7814a volumio[818]: error: updateQueue error: null Dec 19 05:34:55 volumio-7814a volumio[818]: info: ------------------------------ 19ms Dec 19 05:35:00 volumio-7814a volumio[818]: error: MyVolumio Plugin failed to start in a timely fashion Dec 19 05:35:00 volumio-7814a volumio[818]: [Metrics] CommandRouter: 36s 145.52ms Dec 19 05:35:00 volumio-7814a volumio[818]: info: CoreCommandRouter::volumiosetStartupVolume Dec 19 05:35:00 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 05:35:00 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:35:00 volumio-7814a volumio[818]: info: CoreCommandRouter::Close All Modals sent Dec 19 05:35:00 volumio-7814a volumio[818]: info: CoreCommandRouter::Close All Modals sent Dec 19 05:35:00 volumio-7814a volumio[818]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 19 05:35:00 volumio-7814a volumio[818]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 19 05:35:00 volumio-7814a volumio[818]: info: camilladsp stopping service pid 1063... Dec 19 05:35:00 volumio-7814a kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=-11) Dec 19 05:35:00 volumio-7814a volumio[818]: info: camilladsp service terminated, instance 1 Dec 19 05:35:00 volumio-7814a volumio[818]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 19 05:35:00 volumio-7814a volumio[818]: info: FusionDsp - Loudness is ON true Dec 19 05:35:00 volumio-7814a volumio[818]: info: camilladsp service started and running in background, instance 1 Dec 19 05:35:01 volumio-7814a volumio[818]: info: camilladsp spawned new process with pid 1202, instance 1, run: true Dec 19 05:35:01 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 19 05:35:01 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 19 05:35:01 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 19 05:35:01 volumio-7814a volumio[818]: info: Version has changed, forcing UI Reload Dec 19 05:35:01 volumio-7814a volumio[818]: info: CoreCommandRouter::Reload Ui Dec 19 05:35:05 volumio-7814a volumio[818]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 19 05:35:05 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:35:05 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 05:35:05 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:35:05 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 19 05:35:06 volumio-7814a kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=-11) Dec 19 05:35:06 volumio-7814a volumio[818]: info: camilladsp spawned new process with pid 1215, instance 1, run: true Dec 19 05:35:07 volumio-7814a volumio[818]: info: BOOT COMPLETED Dec 19 05:35:12 volumio-7814a kernel: CIFS: VFS: cifs_mount failed w/return code = -112 Dec 19 05:35:12 volumio-7814a sudo[1162]: pam_unix(sudo:session): session closed for user root Dec 19 05:35:12 volumio-7814a volumio[818]: info: Cannot mount NAS NAS at system boot, trial number 3 ,retrying in 5 seconds Dec 19 05:35:13 volumio-7814a mpd_monitor.sh[1135]: MPD Monitor Service: MPD Appears to be inactive, restarting Dec 19 05:35:13 volumio-7814a systemd[1]: Stopping Music Player Daemon... Dec 19 05:35:17 volumio-7814a sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Melanthius,password=1MsiWa17B.,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.2.66/Music /mnt/NAS/NAS Dec 19 05:35:17 volumio-7814a sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:35:17 volumio-7814a kernel: CIFS: Attempting to mount //192.168.2.66/Music Dec 19 05:35:27 volumio-7814a dhcpcd[745]: wlan0: carrier lost Dec 19 05:35:27 volumio-7814a wpa_supplicant[729]: wlan0: Associated with 1c:ed:6f:b5:53:65 Dec 19 05:35:27 volumio-7814a wpa_supplicant[729]: wlan0: CTRL-EVENT-CONNECTED - Connection to 1c:ed:6f:b5:53:65 completed [id=0 id_str=] Dec 19 05:35:27 volumio-7814a wpa_supplicant[729]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Dec 19 05:35:27 volumio-7814a avahi-daemon[486]: Withdrawing address record for 192.168.21.24 on wlan0. Dec 19 05:35:27 volumio-7814a avahi-daemon[486]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.21.24. Dec 19 05:35:27 volumio-7814a dhcpcd[745]: wlan0: deleting route to 192.168.0.0/16 Dec 19 05:35:27 volumio-7814a dhcpcd[745]: wlan0: deleting default route via 192.168.159.17 Dec 19 05:35:27 volumio-7814a avahi-daemon[486]: Interface wlan0.IPv4 no longer relevant for mDNS. Dec 19 05:35:27 volumio-7814a volumio[818]: info: Discovery: A device disappeared from network Dec 19 05:35:27 volumio-7814a volumio[818]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Dec 19 05:35:27 volumio-7814a volumio[818]: info: Discovery: A device disappeared from network Dec 19 05:35:27 volumio-7814a volumio[818]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Dec 19 05:35:27 volumio-7814a dhcpcd[745]: wlan0: carrier acquired Dec 19 05:35:27 volumio-7814a dhcpcd[745]: wlan0: IAID 67:0a:fa:a7 Dec 19 05:35:27 volumio-7814a dhcpcd[745]: wlan0: rebinding lease of 192.168.21.24 Dec 19 05:35:27 volumio-7814a dhcpcd[745]: wlan0: probing address 192.168.21.24/16 Dec 19 05:35:27 volumio-7814a dhcpcd[745]: wlan0: soliciting an IPv6 router Dec 19 05:35:28 volumio-7814a volumio[818]: verbose: ControllerMpd::sendMpdCommand add "https://stream.ffn.de/ffn-708090/mp3-192/?ref=tunein" Dec 19 05:35:28 volumio-7814a volumio[818]: Upnp client error: Error: This socket has been ended by the other party Dec 19 05:35:28 volumio-7814a volumio[818]: error: MPD error: Error: read ECONNRESET Dec 19 05:35:28 volumio-7814a volumio[818]: info: Volumio Network Manager: Network status updated: 0 Dec 19 05:35:29 volumio-7814a ntpd[638]: Deleting interface #3 wlan0, 192.168.21.24#123, interface stats: received=0, sent=0, dropped=0, active_time=67 secs Dec 19 05:35:29 volumio-7814a systemd[1]: mpd.service: Succeeded. Dec 19 05:35:29 volumio-7814a systemd[1]: Stopped Music Player Daemon. Dec 19 05:35:29 volumio-7814a systemd[1]: Starting Music Player Daemon... Dec 19 05:35:29 volumio-7814a sudo[1342]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 05:35:29 volumio-7814a sudo[1342]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:35:29 volumio-7814a sudo[1342]: pam_unix(sudo:session): session closed for user root Dec 19 05:35:30 volumio-7814a ntpd[638]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Dec 19 05:35:30 volumio-7814a ntpd[638]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Dec 19 05:35:30 volumio-7814a ntpd[638]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Dec 19 05:35:30 volumio-7814a ntpd[638]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Dec 19 05:35:31 volumio-7814a mpd[1344]: Dec 19 05:35 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 05:35:31 volumio-7814a systemd[1]: Started Music Player Daemon. Dec 19 05:35:31 volumio-7814a mpd_monitor.sh[1135]: MPD Monitor Service: MPD restarted due to no mpc output. Dec 19 05:35:31 volumio-7814a volumio[818]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Dec 19 05:35:31 volumio-7814a volumio[818]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 19 05:35:32 volumio-7814a dhcpcd[745]: wlan0: leased 192.168.21.24 for 864000 seconds Dec 19 05:35:32 volumio-7814a avahi-daemon[486]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.21.24. Dec 19 05:35:32 volumio-7814a avahi-daemon[486]: New relevant interface wlan0.IPv4 for mDNS. Dec 19 05:35:32 volumio-7814a dhcpcd[745]: wlan0: adding route to 192.168.0.0/16 Dec 19 05:35:32 volumio-7814a avahi-daemon[486]: Registering new address record for 192.168.21.24 on wlan0.IPv4. Dec 19 05:35:32 volumio-7814a dhcpcd[745]: wlan0: adding default route via 192.168.159.17 Dec 19 05:35:32 volumio-7814a volumio[818]: info: Discovery: adding 98038db8-6979-433b-8d70-431a361ac71b Dec 19 05:35:32 volumio-7814a volumio[818]: info: Discovery: Found device Volumio—1Mii Dec 19 05:35:32 volumio-7814a volumio[818]: info: Discovery: Connecting to remote: 192.168.21.17 Dec 19 05:35:32 volumio-7814a volumio[818]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 19 05:35:32 volumio-7814a volumio[818]: info: Discovery: Connected to remote: 192.168.21.17 Dec 19 05:35:32 volumio-7814a volumio[818]: 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 19 05:35:32 volumio-7814a volumio[818]: 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 19 05:35:32 volumio-7814a volumio[818]: 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 19 05:35:32 volumio-7814a volumio[818]: info: Discovery: this is already registered, 98038db8-6979-433b-8d70-431a361ac71b Dec 19 05:35:32 volumio-7814a volumio[818]: info: Discovery: Found device Volumio—1Mii Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 19 05:35:33 volumio-7814a volumio[818]: info: Adding plugin bluetooth to MyMusic Plugins Dec 19 05:35:33 volumio-7814a volumio[818]: info: Adding plugin multiroom to MyMusic Plugins Dec 19 05:35:33 volumio-7814a volumio[818]: info: Adding plugin metavolumio to MyMusic Plugins Dec 19 05:35:33 volumio-7814a volumio[818]: info: Adding plugin cd_controller to MyMusic Plugins Dec 19 05:35:33 volumio-7814a volumio[818]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 19 05:35:33 volumio-7814a volumio[818]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 19 05:35:33 volumio-7814a volumio[818]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 19 05:35:33 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 19 05:35:34 volumio-7814a ntpd[638]: Listen normally on 4 wlan0 192.168.21.24:123 Dec 19 05:35:34 volumio-7814a ntpd[638]: new interface(s) found: waking up resolver Dec 19 05:35:35 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 19 05:35:35 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 19 05:35:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:35:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:35:35 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 05:35:35 volumio-7814a volumio[818]: info: Starting MyVolumio Remote Streaming Endpoints Dec 19 05:35:35 volumio-7814a volumio[818]: info: MyVolumio login type: Token Dec 19 05:35:35 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 19 05:35:35 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 19 05:35:37 volumio-7814a volumio[818]: info: Starting Streaming Service Transparent Proxy Dec 19 05:35:37 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 19 05:35:37 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 19 05:35:37 volumio-7814a volumio[818]: info: Streaming services startup Dec 19 05:35:37 volumio-7814a volumio[818]: info: Starting Streaming Daemon Dec 19 05:35:37 volumio-7814a sudo[1389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 19 05:35:37 volumio-7814a sudo[1389]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:35:37 volumio-7814a sudo[1389]: pam_unix(sudo:session): session closed for user root Dec 19 05:35:37 volumio-7814a volumio[818]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 19 05:35:37 volumio-7814a volumio[818]: info: Discovery: adding a24bd339-ba60-48bd-9658-60801756f99b Dec 19 05:35:37 volumio-7814a volumio[818]: info: Discovery: Found device Volumio-7814A Dec 19 05:35:37 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioGetState Dec 19 05:35:37 volumio-7814a volumio[818]: info: CorePlayQueue::getTrack 0 Dec 19 05:35:37 volumio-7814a volumio[818]: error: Cannot start Volumio Streaming Daemon Dec 19 05:35:37 volumio-7814a volumio[818]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 19 05:35:37 volumio-7814a volumio[818]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 19 05:35:37 volumio-7814a volumio[818]: verbose: New Socket.io Connection to 192.168.21.24:3000 from 192.168.21.17 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 19 05:35:37 volumio-7814a volumio[818]: verbose: New Socket.io Connection to 192.168.21.24:3000 from 192.168.21.17 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Dec 19 05:35:37 volumio-7814a volumio[818]: verbose: New Socket.io Connection to 192.168.21.24:3000 from 192.168.21.17 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Dec 19 05:35:37 volumio-7814a volumio[818]: error: updateQueue error: null Dec 19 05:35:37 volumio-7814a volumio[818]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Dec 19 05:35:37 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioGetState Dec 19 05:35:37 volumio-7814a volumio[818]: info: CorePlayQueue::getTrack 0 Dec 19 05:35:38 volumio-7814a volumio[818]: info: Discovery: this is already registered, a24bd339-ba60-48bd-9658-60801756f99b Dec 19 05:35:38 volumio-7814a volumio[818]: info: Discovery: Found device Volumio-7814A Dec 19 05:35:38 volumio-7814a volumio[818]: info: CoreCommandRouter::volumioGetState Dec 19 05:35:38 volumio-7814a volumio[818]: info: CorePlayQueue::getTrack 0 Dec 19 05:35:38 volumio-7814a volumio[818]: error: MyVolumio Custom Token format not valid, refreshing it Dec 19 05:35:38 volumio-7814a volumio[818]: info: Volumio Network Manager: Network status updated: 2 Dec 19 05:35:39 volumio-7814a volumio[818]: STREAMING PROXY: Starting server on port 3245 Dec 19 05:35:39 volumio-7814a volumio[818]: Node JS runtime: 14 Dec 19 05:35:39 volumio-7814a volumio[818]: info: MyVolumio login type: Token Dec 19 05:35:39 volumio-7814a volumio[818]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 19 05:35:40 volumio-7814a volumio-time-update[489]: volumio-time-update-util: Setting system time to: 2025-12-19 05:35:17 Dec 19 05:35:40 volumio-7814a sudo[1411]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-12-19 05:35:17 Dec 19 05:35:40 volumio-7814a sudo[1411]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:35:40 volumio-7814a volumio[818]: info: MyVolumio token set successfully Dec 19 05:35:40 volumio-7814a volumio[818]: info: MYVOLUMIO: Adding device Dec 19 05:35:40 volumio-7814a volumio[818]: info: MYVOLUMIO: Evaluating Server Dec 19 05:35:40 volumio-7814a dbus-daemon[483]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.17' (uid=0 pid=1413 comm="timedatectl set-time 2025-12-19 05:35:17 ") Dec 19 05:35:40 volumio-7814a kernel: CIFS: VFS: cifs_mount failed w/return code = -112 Dec 19 05:35:40 volumio-7814a sudo[1277]: pam_unix(sudo:session): session closed for user root Dec 19 05:35:40 volumio-7814a systemd[1]: Starting Time & Date Service... Dec 19 05:35:40 volumio-7814a dbus-daemon[483]: [system] Successfully activated service 'org.freedesktop.timedate1' Dec 19 05:35:40 volumio-7814a systemd[1]: Started Time & Date Service. Dec 19 05:35:17 volumio-7814a systemd-timedated[1419]: Changed local time to Fri Dec 19 05:35:17 2025 Dec 19 05:35:17 volumio-7814a sudo[1411]: pam_unix(sudo:session): session closed for user root Dec 19 05:35:17 volumio-7814a volumio-time-update[489]: volumio-time-update-util: System time updated successfully. Dec 19 05:35:17 volumio-7814a volumio[818]: info: MyVolumio status changed Dec 19 05:35:17 volumio-7814a volumio[818]: info: Streaming services startup Dec 19 05:35:17 volumio-7814a systemd[1]: Started Volumio Time Update Utility. Dec 19 05:35:17 volumio-7814a volumio[818]: info: Starting Streaming Daemon Dec 19 05:35:17 volumio-7814a systemd[1]: Reached target Multi-User System. Dec 19 05:35:17 volumio-7814a systemd[1]: Reached target Graphical Interface. Dec 19 05:35:17 volumio-7814a volumio[818]: info: Removing browser output: myVolumio user plan is not superstar Dec 19 05:35:17 volumio-7814a volumio[818]: info: Removing audio output: Dec 19 05:35:17 volumio-7814a volumio[818]: info: Stoppping Tunnel 1 Dec 19 05:35:17 volumio-7814a sudo[1456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 19 05:35:17 volumio-7814a sudo[1456]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:35:17 volumio-7814a systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 19 05:35:17 volumio-7814a sudo[1456]: pam_unix(sudo:session): session closed for user root Dec 19 05:35:17 volumio-7814a sudo[1460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Dec 19 05:35:17 volumio-7814a sudo[1460]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 05:35:17 volumio-7814a volumio[818]: error: Failed to ping endpoint us2.myvolumio.org : unknown error Dec 19 05:35:17 volumio-7814a volumio[818]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 05:35:17 volumio-7814a volumio[818]: Error: Unable to resolve or reject the same promise twice Dec 19 05:35:17 volumio-7814a volumio[818]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Dec 19 05:35:17 volumio-7814a volumio[818]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32367) Dec 19 05:35:17 volumio-7814a volumio[818]: at Socket.emit (events.js:315:20) Dec 19 05:35:17 volumio-7814a volumio[818]: at addChunk (internal/streams/readable.js:309:12) Dec 19 05:35:17 volumio-7814a volumio[818]: at readableAddChunk (internal/streams/readable.js:284:9) Dec 19 05:35:17 volumio-7814a volumio[818]: at Socket.Readable.push (internal/streams/readable.js:223:10) Dec 19 05:35:17 volumio-7814a volumio[818]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Dec 19 05:35:17 volumio-7814a volumio[818]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 05:35:17 volumio-7814a systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 19 05:35:17 volumio-7814a systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 19 05:35:17 volumio-7814a systemd[1]: Startup finished in 13.580s (kernel) + 1min 37.439s (userspace) = 1min 51.019s. Dec 19 05:35:17 volumio-7814a sudo[1460]: pam_unix(sudo:session): session closed for user root Dec 19 05:35:17 volumio-7814a sudo[1471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-19 05:34 Dec 19 05:35:17 volumio-7814a sudo[1471]: 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" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"