-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Thu 2024-01-25 15:41:01 UTC. -- Jan 25 15:39:35 volumiomfn kernel: Linux version 5.10.92-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1514 SMP Mon Jan 17 17:38:03 GMT 2022 Jan 25 15:39:35 volumiomfn kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d Jan 25 15:39:35 volumiomfn kernel: CPU: div instructions available: patching division code Jan 25 15:39:35 volumiomfn kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache Jan 25 15:39:35 volumiomfn kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.2 Jan 25 15:39:35 volumiomfn kernel: random: fast init done Jan 25 15:39:35 volumiomfn kernel: Memory policy: Data cache writealloc Jan 25 15:39:35 volumiomfn kernel: Reserved memory: created CMA memory pool at 0x000000002a000000, size 64 MiB Jan 25 15:39:35 volumiomfn kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Jan 25 15:39:35 volumiomfn kernel: Zone ranges: Jan 25 15:39:35 volumiomfn kernel: DMA [mem 0x0000000000000000-0x000000002fffffff] Jan 25 15:39:35 volumiomfn kernel: Normal empty Jan 25 15:39:35 volumiomfn kernel: HighMem [mem 0x0000000030000000-0x000000007fffffff] Jan 25 15:39:35 volumiomfn kernel: Movable zone start for each node Jan 25 15:39:35 volumiomfn kernel: Early memory node ranges Jan 25 15:39:35 volumiomfn kernel: node 0: [mem 0x0000000000000000-0x000000003dffffff] Jan 25 15:39:35 volumiomfn kernel: node 0: [mem 0x0000000040000000-0x000000007fffffff] Jan 25 15:39:35 volumiomfn kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff] Jan 25 15:39:35 volumiomfn kernel: On node 0 totalpages: 516096 Jan 25 15:39:35 volumiomfn kernel: DMA zone: 1728 pages used for memmap Jan 25 15:39:35 volumiomfn kernel: DMA zone: 0 pages reserved Jan 25 15:39:35 volumiomfn kernel: DMA zone: 196608 pages, LIFO batch:63 Jan 25 15:39:35 volumiomfn kernel: HighMem zone: 319488 pages, LIFO batch:63 Jan 25 15:39:35 volumiomfn kernel: percpu: Embedded 20 pages/cpu s50828 r8192 d22900 u81920 Jan 25 15:39:35 volumiomfn kernel: pcpu-alloc: s50828 r8192 d22900 u81920 alloc=20*4096 Jan 25 15:39:35 volumiomfn kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jan 25 15:39:35 volumiomfn kernel: Built 1 zonelists, mobility grouping on. Total pages: 514368 Jan 25 15:39:35 volumiomfn kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:BD:23:A8 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 loglevel=0 Jan 25 15:39:35 volumiomfn kernel: Kernel parameter elevator= does not have any effect anymore. Please use sysfs to set IO scheduler for individual devices. Jan 25 15:39:35 volumiomfn kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) Jan 25 15:39:35 volumiomfn kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 25 15:39:35 volumiomfn kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 25 15:39:35 volumiomfn kernel: software IO TLB: mapped [mem 0x0000000024e00000-0x0000000028e00000] (64MB) Jan 25 15:39:35 volumiomfn kernel: Memory: 1881660K/2064384K available (10240K kernel code, 1366K rwdata, 3196K rodata, 2048K init, 882K bss, 117188K reserved, 65536K cma-reserved, 1277952K highmem) Jan 25 15:39:35 volumiomfn kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jan 25 15:39:35 volumiomfn kernel: ftrace: allocating 34360 entries in 101 pages Jan 25 15:39:35 volumiomfn kernel: ftrace: allocated 101 pages with 4 groups Jan 25 15:39:35 volumiomfn kernel: rcu: Hierarchical RCU implementation. Jan 25 15:39:35 volumiomfn kernel: Rude variant of Tasks RCU enabled. Jan 25 15:39:35 volumiomfn kernel: Tracing variant of Tasks RCU enabled. Jan 25 15:39:35 volumiomfn kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. Jan 25 15:39:35 volumiomfn kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Jan 25 15:39:35 volumiomfn kernel: GIC: Using split EOI/Deactivate mode Jan 25 15:39:35 volumiomfn kernel: random: get_random_bytes called from start_kernel+0x3c8/0x59c with crng_init=1 Jan 25 15:39:35 volumiomfn kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns Jan 25 15:39:35 volumiomfn kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns Jan 25 15:39:35 volumiomfn kernel: bcm2835: system timer (irq = 25) Jan 25 15:39:35 volumiomfn kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Jan 25 15:39:35 volumiomfn kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Jan 25 15:39:35 volumiomfn kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Jan 25 15:39:35 volumiomfn kernel: Switching to timer-based delay loop, resolution 18ns Jan 25 15:39:35 volumiomfn kernel: Console: colour dummy device 80x30 Jan 25 15:39:35 volumiomfn kernel: printk: console [tty1] enabled Jan 25 15:39:35 volumiomfn kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000) Jan 25 15:39:35 volumiomfn kernel: pid_max: default: 32768 minimum: 301 Jan 25 15:39:35 volumiomfn kernel: LSM: Security Framework initializing Jan 25 15:39:35 volumiomfn kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Jan 25 15:39:35 volumiomfn kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Jan 25 15:39:35 volumiomfn kernel: cgroup: Disabling memory control group subsystem Jan 25 15:39:35 volumiomfn kernel: CPU: Testing write buffer coherency: ok Jan 25 15:39:35 volumiomfn kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Jan 25 15:39:35 volumiomfn kernel: Setting up static identity map for 0x200000 - 0x20003c Jan 25 15:39:35 volumiomfn kernel: rcu: Hierarchical SRCU implementation. Jan 25 15:39:35 volumiomfn kernel: smp: Bringing up secondary CPUs ... Jan 25 15:39:35 volumiomfn kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Jan 25 15:39:35 volumiomfn kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Jan 25 15:39:35 volumiomfn kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Jan 25 15:39:35 volumiomfn kernel: smp: Brought up 1 node, 4 CPUs Jan 25 15:39:35 volumiomfn kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS). Jan 25 15:39:35 volumiomfn kernel: CPU: All CPU(s) started in HYP mode. Jan 25 15:39:35 volumiomfn kernel: CPU: Virtualization extensions available. Jan 25 15:39:35 volumiomfn kernel: devtmpfs: initialized Jan 25 15:39:35 volumiomfn kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0 Jan 25 15:39:35 volumiomfn kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Jan 25 15:39:35 volumiomfn kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jan 25 15:39:35 volumiomfn kernel: pinctrl core: initialized pinctrl subsystem Jan 25 15:39:35 volumiomfn kernel: NET: Registered protocol family 16 Jan 25 15:39:35 volumiomfn kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Jan 25 15:39:35 volumiomfn kernel: audit: initializing netlink subsys (disabled) Jan 25 15:39:35 volumiomfn kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Jan 25 15:39:35 volumiomfn kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 25 15:39:35 volumiomfn kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Jan 25 15:39:35 volumiomfn kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Jan 25 15:39:35 volumiomfn kernel: Serial: AMBA PL011 UART driver Jan 25 15:39:35 volumiomfn kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled Jan 25 15:39:35 volumiomfn kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2022-01-20T13:56:48, variant start Jan 25 15:39:35 volumiomfn kernel: raspberrypi-firmware soc:firmware: Firmware hash is bd88f66f8952d34e4e0613a85c7a6d3da49e13e2 Jan 25 15:39:35 volumiomfn kernel: Kprobes globally optimized Jan 25 15:39:35 volumiomfn kernel: bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1 Jan 25 15:39:35 volumiomfn kernel: vgaarb: loaded Jan 25 15:39:35 volumiomfn kernel: SCSI subsystem initialized Jan 25 15:39:35 volumiomfn kernel: usbcore: registered new interface driver usbfs Jan 25 15:39:35 volumiomfn kernel: usbcore: registered new interface driver hub Jan 25 15:39:35 volumiomfn kernel: usbcore: registered new device driver usb Jan 25 15:39:35 volumiomfn kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator Jan 25 15:39:35 volumiomfn kernel: clocksource: Switched to clocksource arch_sys_counter Jan 25 15:39:35 volumiomfn kernel: VFS: Disk quotas dquot_6.6.0 Jan 25 15:39:35 volumiomfn kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Jan 25 15:39:35 volumiomfn kernel: FS-Cache: Loaded Jan 25 15:39:35 volumiomfn kernel: CacheFiles: Loaded Jan 25 15:39:35 volumiomfn kernel: NET: Registered protocol family 2 Jan 25 15:39:35 volumiomfn kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Jan 25 15:39:35 volumiomfn kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear) Jan 25 15:39:35 volumiomfn kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Jan 25 15:39:35 volumiomfn kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 25 15:39:35 volumiomfn kernel: TCP: Hash tables configured (established 8192 bind 8192) Jan 25 15:39:35 volumiomfn kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Jan 25 15:39:35 volumiomfn kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Jan 25 15:39:35 volumiomfn kernel: NET: Registered protocol family 1 Jan 25 15:39:35 volumiomfn kernel: RPC: Registered named UNIX socket transport module. Jan 25 15:39:35 volumiomfn kernel: RPC: Registered udp transport module. Jan 25 15:39:35 volumiomfn kernel: RPC: Registered tcp transport module. Jan 25 15:39:35 volumiomfn kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jan 25 15:39:35 volumiomfn kernel: PCI: CLS 0 bytes, default 64 Jan 25 15:39:35 volumiomfn kernel: Trying to unpack rootfs image as initramfs... Jan 25 15:39:35 volumiomfn kernel: Freeing initrd memory: 13028K Jan 25 15:39:35 volumiomfn kernel: Initialise system trusted keyrings Jan 25 15:39:35 volumiomfn kernel: workingset: timestamp_bits=14 max_order=19 bucket_order=5 Jan 25 15:39:35 volumiomfn kernel: zbud: loaded Jan 25 15:39:35 volumiomfn kernel: FS-Cache: Netfs 'nfs' registered for caching Jan 25 15:39:35 volumiomfn kernel: NFS: Registering the id_resolver key type Jan 25 15:39:35 volumiomfn kernel: Key type id_resolver registered Jan 25 15:39:35 volumiomfn kernel: Key type id_legacy registered Jan 25 15:39:35 volumiomfn kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Jan 25 15:39:35 volumiomfn kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Jan 25 15:39:35 volumiomfn kernel: Key type asymmetric registered Jan 25 15:39:35 volumiomfn kernel: Asymmetric key parser 'x509' registered Jan 25 15:39:35 volumiomfn kernel: bounce: pool size: 64 pages Jan 25 15:39:35 volumiomfn kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Jan 25 15:39:35 volumiomfn kernel: io scheduler mq-deadline registered Jan 25 15:39:35 volumiomfn kernel: io scheduler kyber registered Jan 25 15:39:35 volumiomfn kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: Jan 25 15:39:35 volumiomfn kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] Jan 25 15:39:35 volumiomfn kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000 Jan 25 15:39:35 volumiomfn kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x007fffffff -> 0x0400000000 Jan 25 15:39:35 volumiomfn kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) Jan 25 15:39:35 volumiomfn kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 Jan 25 15:39:35 volumiomfn kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jan 25 15:39:35 volumiomfn kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff]) Jan 25 15:39:35 volumiomfn kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 Jan 25 15:39:35 volumiomfn kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Jan 25 15:39:35 volumiomfn kernel: PCI: bus0: Fast back to back transfers disabled Jan 25 15:39:35 volumiomfn kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Jan 25 15:39:35 volumiomfn kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 Jan 25 15:39:35 volumiomfn kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Jan 25 15:39:35 volumiomfn kernel: pci 0000:01:00.0: PME# supported from D0 D3cold Jan 25 15:39:35 volumiomfn kernel: PCI: bus1: Fast back to back transfers disabled Jan 25 15:39:35 volumiomfn kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 Jan 25 15:39:35 volumiomfn kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] Jan 25 15:39:35 volumiomfn kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] Jan 25 15:39:35 volumiomfn kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Jan 25 15:39:35 volumiomfn kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] Jan 25 15:39:35 volumiomfn kernel: pcieport 0000:00:00.0: enabling device (0140 -> 0142) Jan 25 15:39:35 volumiomfn kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 62 Jan 25 15:39:35 volumiomfn kernel: bcm2708_fb soc:fb: FB found 1 display(s) Jan 25 15:39:35 volumiomfn kernel: Console: switching to colour frame buffer device 80x30 Jan 25 15:39:35 volumiomfn kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480 Jan 25 15:39:35 volumiomfn kernel: iproc-rng200 fe104000.rng: hwrng registered Jan 25 15:39:35 volumiomfn kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Jan 25 15:39:35 volumiomfn kernel: gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000 Jan 25 15:39:35 volumiomfn kernel: brd: module loaded Jan 25 15:39:35 volumiomfn kernel: loop: module loaded Jan 25 15:39:35 volumiomfn kernel: Loading iSCSI transport class v2.0-870. Jan 25 15:39:35 volumiomfn kernel: libphy: Fixed MDIO Bus: probed Jan 25 15:39:35 volumiomfn kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 Jan 25 15:39:35 volumiomfn kernel: libphy: bcmgenet MII bus: probed Jan 25 15:39:35 volumiomfn kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus Jan 25 15:39:35 volumiomfn kernel: usbcore: registered new interface driver r8152 Jan 25 15:39:35 volumiomfn kernel: usbcore: registered new interface driver lan78xx Jan 25 15:39:35 volumiomfn kernel: usbcore: registered new interface driver smsc95xx Jan 25 15:39:35 volumiomfn kernel: xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142) Jan 25 15:39:35 volumiomfn kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Jan 25 15:39:35 volumiomfn kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 Jan 25 15:39:35 volumiomfn kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x00000e0000000890 Jan 25 15:39:35 volumiomfn kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10 Jan 25 15:39:35 volumiomfn kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 25 15:39:35 volumiomfn kernel: usb usb1: Product: xHCI Host Controller Jan 25 15:39:35 volumiomfn kernel: usb usb1: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd Jan 25 15:39:35 volumiomfn kernel: usb usb1: SerialNumber: 0000:01:00.0 Jan 25 15:39:35 volumiomfn kernel: hub 1-0:1.0: USB hub found Jan 25 15:39:35 volumiomfn kernel: hub 1-0:1.0: 1 port detected Jan 25 15:39:35 volumiomfn kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Jan 25 15:39:35 volumiomfn kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 Jan 25 15:39:35 volumiomfn kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed Jan 25 15:39:35 volumiomfn kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10 Jan 25 15:39:35 volumiomfn kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 25 15:39:35 volumiomfn kernel: usb usb2: Product: xHCI Host Controller Jan 25 15:39:35 volumiomfn kernel: usb usb2: Manufacturer: Linux 5.10.92-v7l+ xhci-hcd Jan 25 15:39:35 volumiomfn kernel: usb usb2: SerialNumber: 0000:01:00.0 Jan 25 15:39:35 volumiomfn kernel: hub 2-0:1.0: USB hub found Jan 25 15:39:35 volumiomfn kernel: hub 2-0:1.0: 4 ports detected Jan 25 15:39:35 volumiomfn kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Jan 25 15:39:35 volumiomfn kernel: dwc_otg: FIQ enabled Jan 25 15:39:35 volumiomfn kernel: dwc_otg: NAK holdoff enabled Jan 25 15:39:35 volumiomfn kernel: dwc_otg: FIQ split-transaction FSM enabled Jan 25 15:39:35 volumiomfn kernel: Module dwc_common_port init Jan 25 15:39:35 volumiomfn kernel: usbcore: registered new interface driver uas Jan 25 15:39:35 volumiomfn kernel: usbcore: registered new interface driver usb-storage Jan 25 15:39:35 volumiomfn kernel: mousedev: PS/2 mouse device common for all mice Jan 25 15:39:35 volumiomfn kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Jan 25 15:39:35 volumiomfn kernel: sdhci: Secure Digital Host Controller Interface driver Jan 25 15:39:35 volumiomfn kernel: sdhci: Copyright(c) Pierre Ossman Jan 25 15:39:35 volumiomfn kernel: mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe Jan 25 15:39:35 volumiomfn kernel: sdhci-pltfm: SDHCI platform and OF driver helper Jan 25 15:39:35 volumiomfn kernel: ledtrig-cpu: registered to indicate activity on CPUs Jan 25 15:39:35 volumiomfn kernel: hid: raw HID events driver (C) Jiri Kosina Jan 25 15:39:35 volumiomfn kernel: usbcore: registered new interface driver usbhid Jan 25 15:39:35 volumiomfn kernel: usbhid: USB HID core driver Jan 25 15:39:35 volumiomfn kernel: Initializing XFRM netlink socket Jan 25 15:39:35 volumiomfn kernel: NET: Registered protocol family 17 Jan 25 15:39:35 volumiomfn kernel: Key type dns_resolver registered Jan 25 15:39:35 volumiomfn kernel: Registering SWP/SWPB emulation handler Jan 25 15:39:35 volumiomfn kernel: registered taskstats version 1 Jan 25 15:39:35 volumiomfn kernel: Loading compiled-in X.509 certificates Jan 25 15:39:35 volumiomfn kernel: Key type ._fscrypt registered Jan 25 15:39:35 volumiomfn kernel: Key type .fscrypt registered Jan 25 15:39:35 volumiomfn kernel: Key type fscrypt-provisioning registered Jan 25 15:39:35 volumiomfn kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Jan 25 15:39:35 volumiomfn kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Jan 25 15:39:35 volumiomfn kernel: fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2 Jan 25 15:39:35 volumiomfn kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Jan 25 15:39:35 volumiomfn kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Jan 25 15:39:35 volumiomfn kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Jan 25 15:39:35 volumiomfn kernel: of_cfs_init Jan 25 15:39:35 volumiomfn kernel: of_cfs_init: OK Jan 25 15:39:35 volumiomfn kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes) Jan 25 15:39:35 volumiomfn kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Jan 25 15:39:35 volumiomfn kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Jan 25 15:39:35 volumiomfn kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes) Jan 25 15:39:35 volumiomfn kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Jan 25 15:39:35 volumiomfn kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Jan 25 15:39:35 volumiomfn kernel: Freeing unused kernel memory: 2048K Jan 25 15:39:35 volumiomfn kernel: Run /init as init process Jan 25 15:39:35 volumiomfn kernel: with arguments: Jan 25 15:39:35 volumiomfn kernel: /init Jan 25 15:39:35 volumiomfn kernel: splash Jan 25 15:39:35 volumiomfn kernel: with environment: Jan 25 15:39:35 volumiomfn kernel: HOME=/ Jan 25 15:39:35 volumiomfn kernel: TERM=linux Jan 25 15:39:35 volumiomfn kernel: imgpart=/dev/mmcblk0p2 Jan 25 15:39:35 volumiomfn kernel: imgfile=/volumio_current.sqsh Jan 25 15:39:35 volumiomfn kernel: bootdelay=5 Jan 25 15:39:35 volumiomfn kernel: mmc1: new high speed SDIO card at address 0001 Jan 25 15:39:35 volumiomfn kernel: mmc0: new ultra high speed DDR50 SDHC card at address aaaa Jan 25 15:39:35 volumiomfn kernel: mmcblk0: mmc0:aaaa SP32G 29.7 GiB Jan 25 15:39:35 volumiomfn kernel: mmcblk0: p1 p2 p3 Jan 25 15:39:35 volumiomfn kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Jan 25 15:39:35 volumiomfn initramfs: Booting Volumio for BCM2711 Jan 25 15:39:35 volumiomfn initramfs: This script mounts rootfs RO with an overlay RW layer. Jan 25 15:39:35 volumiomfn kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 25 15:39:35 volumiomfn initramfs: IMGPART=/dev/mmcblk0p2 Jan 25 15:39:35 volumiomfn initramfs: IMGFILE=/volumio_current.sqsh Jan 25 15:39:35 volumiomfn initramfs: Boot delay (except first time) will be 5 seconds Jan 25 15:39:35 volumiomfn initramfs: /dev/mmcblk0p2: Jan 25 15:39:35 volumiomfn kernel: EXT4-fs (mmcblk0p2): recovery complete Jan 25 15:39:35 volumiomfn kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Jan 25 15:39:35 volumiomfn initramfs: Doing a 5 second delay here to give kernel load a headstart Jan 25 15:39:35 volumiomfn kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Jan 25 15:39:35 volumiomfn kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Jan 25 15:39:35 volumiomfn kernel: usb 1-1: Product: USB2.0 Hub Jan 25 15:39:35 volumiomfn kernel: hub 1-1:1.0: USB hub found Jan 25 15:39:35 volumiomfn kernel: hub 1-1:1.0: 4 ports detected Jan 25 15:39:35 volumiomfn kernel: usb 1-1.1: new high-speed USB device number 3 using xhci_hcd Jan 25 15:39:35 volumiomfn kernel: usb 1-1.1: New USB device found, idVendor=090c, idProduct=2000, bcdDevice=11.00 Jan 25 15:39:35 volumiomfn kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 25 15:39:35 volumiomfn kernel: usb 1-1.1: Product: Flash Disk Jan 25 15:39:35 volumiomfn kernel: usb 1-1.1: Manufacturer: USB Jan 25 15:39:35 volumiomfn kernel: usb 1-1.1: SerialNumber: SCY0000000171656 Jan 25 15:39:35 volumiomfn kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected Jan 25 15:39:35 volumiomfn kernel: scsi host0: usb-storage 1-1.1:1.0 Jan 25 15:39:35 volumiomfn kernel: scsi 0:0:0:0: Direct-Access USB Flash Disk 1100 PQ: 0 ANSI: 4 Jan 25 15:39:35 volumiomfn kernel: sd 0:0:0:0: [sda] 15974400 512-byte logical blocks: (8.18 GB/7.62 GiB) Jan 25 15:39:35 volumiomfn kernel: sd 0:0:0:0: [sda] Write Protect is off Jan 25 15:39:35 volumiomfn kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 Jan 25 15:39:35 volumiomfn kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jan 25 15:39:35 volumiomfn kernel: sda: sda1 Jan 25 15:39:35 volumiomfn kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Jan 25 15:39:35 volumiomfn initramfs: Checking for USB updates Jan 25 15:39:35 volumiomfn kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jan 25 15:39:35 volumiomfn kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jan 25 15:39:35 volumiomfn kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jan 25 15:39:35 volumiomfn kernel: EXT4-fs (mmcblk0p3): 2 orphan inodes deleted Jan 25 15:39:35 volumiomfn kernel: EXT4-fs (mmcblk0p3): recovery complete Jan 25 15:39:35 volumiomfn kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Jan 25 15:39:35 volumiomfn initramfs: With Option: Jan 25 15:39:35 volumiomfn initramfs: VOLUMIO_VERSION="3.546" Jan 25 15:39:35 volumiomfn initramfs: Finish initramfs, continue booting Volumio Jan 25 15:39:35 volumiomfn systemd[1]: System time before build time, advancing clock. Jan 25 15:39:35 volumiomfn kernel: NET: Registered protocol family 10 Jan 25 15:39:35 volumiomfn kernel: Segment Routing with IPv6 Jan 25 15:39:35 volumiomfn 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) Jan 25 15:39:35 volumiomfn systemd[1]: Detected architecture arm. Jan 25 15:39:35 volumiomfn systemd[1]: Set hostname to . Jan 25 15:39:35 volumiomfn 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. Jan 25 15:39:35 volumiomfn kernel: random: systemd: uninitialized urandom read (16 bytes read) Jan 25 15:39:35 volumiomfn kernel: random: systemd: uninitialized urandom read (16 bytes read) Jan 25 15:39:35 volumiomfn kernel: random: systemd: uninitialized urandom read (16 bytes read) Jan 25 15:39:35 volumiomfn systemd[1]: Listening on udev Kernel Socket. Jan 25 15:39:35 volumiomfn systemd[1]: Created slice User and Session Slice. Jan 25 15:39:35 volumiomfn systemd[1]: Reached target Slices. Jan 25 15:39:35 volumiomfn systemd[1]: Listening on fsck to fsckd communication Socket. Jan 25 15:39:35 volumiomfn systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Jan 25 15:39:35 volumiomfn systemd[1]: Created slice system-getty.slice. Jan 25 15:39:35 volumiomfn kernel: i2c /dev entries driver Jan 25 15:39:35 volumiomfn systemd-journald[210]: Journal started Jan 25 15:39:35 volumiomfn systemd-journald[210]: Runtime journal (/run/log/journal/785f013f15a7766cb54a2cb06217cae8) is 7.5M, max 30.0M, 22.5M free. Jan 25 15:39:35 volumiomfn systemd-modules-load[205]: Inserted module 'i2c_dev' Jan 25 15:39:35 volumiomfn fake-hwclock[207]: Thu Jan 25 15:39:35 UTC 2024 Jan 25 15:39:35 volumiomfn systemd[1]: Started Create Static Device Nodes in /dev. Jan 25 15:39:35 volumiomfn systemd[1]: Starting udev Kernel Device Manager... Jan 25 15:39:35 volumiomfn systemd[1]: Reached target Local File Systems (Pre). Jan 25 15:39:35 volumiomfn systemd[1]: Mounting /var/spool/cups... Jan 25 15:39:35 volumiomfn systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jan 25 15:39:35 volumiomfn systemd[1]: Mounting /tmp... Jan 25 15:39:35 volumiomfn systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jan 25 15:39:35 volumiomfn systemd[1]: Mounting /var/log... Jan 25 15:39:35 volumiomfn systemd[1]: Mounted /var/spool/cups. Jan 25 15:39:35 volumiomfn systemd[1]: Mounted /tmp. Jan 25 15:39:35 volumiomfn systemd[1]: Mounting /var/spool/cups/tmp... Jan 25 15:39:35 volumiomfn systemd-udevd[232]: Network interface NamePolicy= disabled on kernel command line, ignoring. Jan 25 15:39:35 volumiomfn systemd[1]: Mounted /var/log. Jan 25 15:39:35 volumiomfn systemd[1]: Starting Flush Journal to Persistent Storage... Jan 25 15:39:35 volumiomfn systemd[1]: Mounted /var/spool/cups/tmp. Jan 25 15:39:35 volumiomfn systemd[1]: Started udev Kernel Device Manager. Jan 25 15:39:35 volumiomfn systemd-journald[210]: Runtime journal (/run/log/journal/785f013f15a7766cb54a2cb06217cae8) is 7.5M, max 30.0M, 22.5M free. Jan 25 15:39:35 volumiomfn systemd[1]: Started Flush Journal to Persistent Storage. Jan 25 15:39:35 volumiomfn systemd[1]: Started udev Coldplug all Devices. Jan 25 15:39:35 volumiomfn systemd[1]: Starting Show Plymouth Boot Screen... Jan 25 15:39:35 volumiomfn systemd[1]: Starting Helper to synchronize boot up for ifupdown... Jan 25 15:39:35 volumiomfn systemd[1]: Received SIGRTMIN+20 from PID 254 (plymouthd). Jan 25 15:39:35 volumiomfn systemd[1]: Started Show Plymouth Boot Screen. Jan 25 15:39:35 volumiomfn systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jan 25 15:39:35 volumiomfn systemd[1]: Reached target Local Encrypted Volumes. Jan 25 15:39:35 volumiomfn systemd[1]: Reached target Paths. Jan 25 15:39:35 volumiomfn systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jan 25 15:39:35 volumiomfn systemd-udevd[245]: Using default interface naming scheme 'v240'. Jan 25 15:39:35 volumiomfn kernel: rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000 Jan 25 15:39:35 volumiomfn kernel: rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000 Jan 25 15:39:35 volumiomfn kernel: rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000 Jan 25 15:39:35 volumiomfn kernel: rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000 Jan 25 15:39:35 volumiomfn kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Jan 25 15:39:35 volumiomfn kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Jan 25 15:39:35 volumiomfn kernel: [vc_sm_connected_init]: start Jan 25 15:39:35 volumiomfn kernel: [vc_sm_connected_init]: installed successfully Jan 25 15:39:35 volumiomfn kernel: mc: Linux media interface: v0.10 Jan 25 15:39:36 volumiomfn systemd-udevd[245]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jan 25 15:39:36 volumiomfn kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Jan 25 15:39:36 volumiomfn kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Jan 25 15:39:36 volumiomfn kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Jan 25 15:39:36 volumiomfn kernel: videodev: Linux video capture interface: v2.00 Jan 25 15:39:36 volumiomfn kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Jan 25 15:39:36 volumiomfn kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Jan 25 15:39:36 volumiomfn systemd[1]: Found device /dev/mmcblk0p1. Jan 25 15:39:36 volumiomfn kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Jan 25 15:39:36 volumiomfn kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Jan 25 15:39:36 volumiomfn kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Jan 25 15:39:36 volumiomfn kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Jan 25 15:39:36 volumiomfn kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Jan 25 15:39:36 volumiomfn kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Jan 25 15:39:36 volumiomfn kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Jan 25 15:39:36 volumiomfn kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Jan 25 15:39:36 volumiomfn kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Jan 25 15:39:36 volumiomfn kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Jan 25 15:39:36 volumiomfn kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Jan 25 15:39:36 volumiomfn kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Jan 25 15:39:36 volumiomfn systemd-udevd[249]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jan 25 15:39:37 volumiomfn kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Jan 25 15:39:37 volumiomfn kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Jan 25 15:39:37 volumiomfn kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Jan 25 15:39:37 volumiomfn kernel: cfg80211: loaded regulatory.db is malformed or signature is missing/invalid Jan 25 15:39:38 volumiomfn kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Jan 25 15:39:38 volumiomfn kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Jan 25 15:39:38 volumiomfn kernel: usbcore: registered new interface driver brcmfmac Jan 25 15:39:38 volumiomfn kernel: wm8804 1-003b: revision E Jan 25 15:39:38 volumiomfn kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Jan 25 15:39:38 volumiomfn kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 Jan 25 15:39:39 volumiomfn systemd-udevd[245]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jan 25 15:39:39 volumiomfn systemd-udevd[238]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 0' failed with exit code 17. Jan 25 15:39:39 volumiomfn systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Jan 25 15:39:39 volumiomfn systemd[1]: Condition check resulted in FUSE Control File System being skipped. Jan 25 15:39:39 volumiomfn systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jan 25 15:39:39 volumiomfn systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jan 25 15:39:39 volumiomfn systemd[1]: Condition check resulted in Huge Pages File System being skipped. Jan 25 15:39:39 volumiomfn systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jan 25 15:39:39 volumiomfn systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Jan 25 15:39:39 volumiomfn systemd[1]: Starting File System Check on /dev/mmcblk0p1... Jan 25 15:39:39 volumiomfn systemd[1]: Starting Load/Save RF Kill Switch Status... Jan 25 15:39:39 volumiomfn systemd[1]: Started File System Check Daemon to report status. Jan 25 15:39:39 volumiomfn systemd[1]: Started Load/Save RF Kill Switch Status. Jan 25 15:39:39 volumiomfn systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Jan 25 15:39:39 volumiomfn systemd[1]: Started Helper to synchronize boot up for ifupdown. Jan 25 15:39:39 volumiomfn systemd-fsck[387]: fsck.fat 4.1 (2017-01-24) Jan 25 15:39:39 volumiomfn systemd-fsck[387]: 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Jan 25 15:39:39 volumiomfn systemd-fsck[387]: Automatically removing dirty bit. Jan 25 15:39:39 volumiomfn systemd-fsck[387]: Performing changes. Jan 25 15:39:39 volumiomfn systemd-fsck[387]: /dev/mmcblk0p1: 308 files, 109538/123044 clusters Jan 25 15:39:39 volumiomfn systemd[1]: Started File System Check on /dev/mmcblk0p1. Jan 25 15:39:39 volumiomfn systemd[1]: Mounting /boot... Jan 25 15:39:39 volumiomfn systemd[1]: Mounted /boot. Jan 25 15:39:39 volumiomfn systemd[1]: Reached target Local File Systems. Jan 25 15:39:39 volumiomfn systemd[1]: Starting Raise network interfaces... Jan 25 15:39:39 volumiomfn systemd[1]: Starting Create Volatile Files and Directories... Jan 25 15:39:39 volumiomfn systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jan 25 15:39:39 volumiomfn systemd[1]: Starting Preprocess NFS configuration... Jan 25 15:39:39 volumiomfn systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Jan 25 15:39:39 volumiomfn systemd[1]: Started ifup for eth0. Jan 25 15:39:39 volumiomfn systemd[1]: Started ifup for wlan0. Jan 25 15:39:39 volumiomfn systemd[1]: plymouth-read-write.service: Succeeded. Jan 25 15:39:39 volumiomfn systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jan 25 15:39:39 volumiomfn systemd[1]: Received SIGRTMIN+20 from PID 254 (plymouthd). Jan 25 15:39:39 volumiomfn systemd[1]: nfs-config.service: Succeeded. Jan 25 15:39:39 volumiomfn systemd[1]: Started Preprocess NFS configuration. Jan 25 15:39:39 volumiomfn systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jan 25 15:39:39 volumiomfn systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jan 25 15:39:39 volumiomfn systemd[1]: Reached target NFS client services. Jan 25 15:39:40 volumiomfn systemd[1]: Started Create Volatile Files and Directories. Jan 25 15:39:40 volumiomfn systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Jan 25 15:39:40 volumiomfn systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Jan 25 15:39:40 volumiomfn systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jan 25 15:39:40 volumiomfn systemd[1]: Starting RPC bind portmap service... Jan 25 15:39:40 volumiomfn systemd[1]: Started Update UTMP about System Boot/Shutdown. Jan 25 15:39:40 volumiomfn systemd[1]: Reached target System Initialization. Jan 25 15:39:40 volumiomfn systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jan 25 15:39:40 volumiomfn systemd[1]: Listening on D-Bus System Message Bus Socket. Jan 25 15:39:40 volumiomfn systemd[1]: apt-daily.timer: Not using persistent file timestamp Thu 2024-04-25 07:52:02 UTC as it is in the future. Jan 25 15:39:40 volumiomfn systemd[1]: Started Daily apt download activities. Jan 25 15:39:40 volumiomfn systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Thu 2024-04-25 06:30:26 UTC as it is in the future. Jan 25 15:39:40 volumiomfn systemd[1]: Started Daily apt upgrade and clean activities. Jan 25 15:39:40 volumiomfn systemd[1]: Listening on mpd.socket. Jan 25 15:39:40 volumiomfn systemd[1]: Listening on triggerhappy.socket. Jan 25 15:39:40 volumiomfn systemd[1]: Reached target Sockets. Jan 25 15:39:40 volumiomfn systemd[1]: Started Daily Cleanup of Temporary Directories. Jan 25 15:39:40 volumiomfn systemd[1]: Reached target Timers. Jan 25 15:39:40 volumiomfn systemd[1]: Reached target Basic System. Jan 25 15:39:40 volumiomfn kernel: 8021q: 802.1Q VLAN Support v1.8 Jan 25 15:39:40 volumiomfn systemd[1]: Starting triggerhappy global hotkey daemon... Jan 25 15:39:40 volumiomfn systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Jan 25 15:39:40 volumiomfn systemd[1]: Started Volumio Iptables Module. Jan 25 15:39:40 volumiomfn systemd[1]: Starting Configure Bluetooth Modems connected by UART... Jan 25 15:39:40 volumiomfn systemd[1]: Starting Login Service... Jan 25 15:39:40 volumiomfn systemd[1]: Started Manage Sound Card State (restore and store). Jan 25 15:39:40 volumiomfn thd[467]: Unable to parse trigger line: Jan 25 15:39:40 volumiomfn thd[467]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Jan 25 15:39:40 volumiomfn thd[467]: Unable to parse trigger line: Jan 25 15:39:40 volumiomfn alsactl[472]: alsactl 1.1.8 daemon started Jan 25 15:39:40 volumiomfn thd[467]: Found socket passed from systemd Jan 25 15:39:40 volumiomfn kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 25 15:39:40 volumiomfn systemd[1]: Starting Save/Restore Sound Card State... Jan 25 15:39:40 volumiomfn systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Jan 25 15:39:40 volumiomfn systemd[1]: Starting dhcpcd on all interfaces... Jan 25 15:39:40 volumiomfn systemd[1]: Started D-Bus System Message Bus. Jan 25 15:39:40 volumiomfn dhcpcd[478]: Not running dhcpcd because /etc/network/interfaces Jan 25 15:39:40 volumiomfn dhcpcd[478]: defines some interfaces that will use a Jan 25 15:39:40 volumiomfn dhcpcd[478]: DHCP client or static address Jan 25 15:39:40 volumiomfn systemd[1]: Starting WPA supplicant... Jan 25 15:39:40 volumiomfn systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Jan 25 15:39:40 volumiomfn systemd-logind[471]: New seat seat0. Jan 25 15:39:40 volumiomfn systemd[1]: Started volumio-remote-updater.service. Jan 25 15:39:40 volumiomfn systemd[1]: Started UPnP Renderer front-end to MPD. Jan 25 15:39:40 volumiomfn systemd[1]: Starting Wireless Services... Jan 25 15:39:40 volumiomfn systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jan 25 15:39:40 volumiomfn systemd[1]: Started triggerhappy global hotkey daemon. Jan 25 15:39:40 volumiomfn systemd[1]: Started RPC bind portmap service. Jan 25 15:39:40 volumiomfn systemd[1]: Started Save/Restore Sound Card State. Jan 25 15:39:40 volumiomfn systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Jan 25 15:39:40 volumiomfn systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Jan 25 15:39:40 volumiomfn systemd[1]: Failed to start dhcpcd on all interfaces. Jan 25 15:39:40 volumiomfn kernel: uart-pl011 fe201000.serial: no DMA platform data Jan 25 15:39:40 volumiomfn systemd[1]: Reached target Sound Card. Jan 25 15:39:40 volumiomfn systemd[1]: Reached target RPC Port Mapper. Jan 25 15:39:40 volumiomfn systemd[1]: Reached target Remote File Systems (Pre). Jan 25 15:39:40 volumiomfn systemd[1]: Reached target Remote File Systems. Jan 25 15:39:40 volumiomfn systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Jan 25 15:39:40 volumiomfn ifup[394]: ifup: waiting for lock on /run/network/ifstate.wlan0 Jan 25 15:39:40 volumiomfn sh[400]: eth0: waiting for carrier Jan 25 15:39:40 volumiomfn dhcpcd[446]: eth0: waiting for carrier Jan 25 15:39:40 volumiomfn sh[401]: wlan0=wlan0 Jan 25 15:39:40 volumiomfn kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Jan 25 15:39:40 volumiomfn kernel: bcmgenet fd580000.ethernet eth0: Link is Down Jan 25 15:39:41 volumiomfn avahi-daemon[520]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Jan 25 15:39:41 volumiomfn avahi-daemon[520]: Successfully dropped root privileges. Jan 25 15:39:41 volumiomfn avahi-daemon[520]: avahi-daemon 0.7 starting up. Jan 25 15:39:41 volumiomfn avahi-daemon[520]: Successfully called chroot(). Jan 25 15:39:41 volumiomfn avahi-daemon[520]: Successfully dropped remaining capabilities. Jan 25 15:39:41 volumiomfn avahi-daemon[520]: Loading service file /services/volumio.service. Jan 25 15:39:41 volumiomfn avahi-daemon[520]: Network interface enumeration completed. Jan 25 15:39:41 volumiomfn avahi-daemon[520]: Server startup complete. Host name is volumiomfn.local. Local service cookie is 926548912. Jan 25 15:39:41 volumiomfn avahi-daemon[520]: Service "Volumio_MFN" (/services/volumio.service) successfully established. Jan 25 15:39:41 volumiomfn systemd[1]: Started Login Service. Jan 25 15:39:41 volumiomfn systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jan 25 15:39:41 volumiomfn systemd[1]: Started Raise network interfaces. Jan 25 15:39:41 volumiomfn loadcpufreq[529]: Loading cpufreq kernel modules...done (none). Jan 25 15:39:41 volumiomfn systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Jan 25 15:39:41 volumiomfn systemd[1]: Starting LSB: set CPUFreq kernel parameters... Jan 25 15:39:42 volumiomfn cpufrequtils[589]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Jan 25 15:39:42 volumiomfn systemd[1]: Started LSB: set CPUFreq kernel parameters. Jan 25 15:39:42 volumiomfn systemd[1]: iptables.service: Succeeded. Jan 25 15:39:42 volumiomfn systemd[1]: Started WPA supplicant. Jan 25 15:39:42 volumiomfn systemd[1]: Reached target Network. Jan 25 15:39:42 volumiomfn wpa_supplicant[500]: Successfully initialized wpa_supplicant Jan 25 15:39:42 volumiomfn systemd[1]: Starting Network Time Service... Jan 25 15:39:42 volumiomfn systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Jan 25 15:39:42 volumiomfn systemd[1]: Reached target Network is Online. Jan 25 15:39:42 volumiomfn systemd[1]: Starting LSB: Brings up/down network automatically... Jan 25 15:39:42 volumiomfn systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 25 15:39:42 volumiomfn systemd[1]: Starting /etc/rc.local Compatibility... Jan 25 15:39:42 volumiomfn systemd[1]: Starting Samba NMB Daemon... Jan 25 15:39:42 volumiomfn systemd[1]: Starting OpenBSD Secure Shell server... Jan 25 15:39:42 volumiomfn systemd[1]: Starting Permit User Sessions... Jan 25 15:39:42 volumiomfn systemd[1]: Starting Music Player Daemon... Jan 25 15:39:42 volumiomfn systemd[1]: Started /etc/rc.local Compatibility. Jan 25 15:39:42 volumiomfn systemd[1]: Started Permit User Sessions. Jan 25 15:39:42 volumiomfn systemd[1]: Starting Hold until boot process finishes up... Jan 25 15:39:42 volumiomfn systemd[1]: Starting Terminate Plymouth Boot Screen... Jan 25 15:39:42 volumiomfn systemd[1]: Received SIGRTMIN+21 from PID 254 (plymouthd). Jan 25 15:39:42 volumiomfn systemd[1]: plymouth-start.service: Succeeded. Jan 25 15:39:42 volumiomfn systemd[1]: plymouth-quit-wait.service: Succeeded. Jan 25 15:39:42 volumiomfn systemd[1]: Started Hold until boot process finishes up. Jan 25 15:39:42 volumiomfn systemd[1]: plymouth-quit.service: Succeeded. Jan 25 15:39:42 volumiomfn systemd[1]: Started Terminate Plymouth Boot Screen. Jan 25 15:39:42 volumiomfn systemd[1]: Received SIGRTMIN+21 from PID 254 (n/a). Jan 25 15:39:42 volumiomfn systemd[1]: Started Getty on tty1. Jan 25 15:39:42 volumiomfn systemd[1]: Reached target Login Prompts. Jan 25 15:39:42 volumiomfn ifplugd(eth0)[637]: ifplugd 0.28 initializing. Jan 25 15:39:42 volumiomfn ifplugd(eth0)[637]: Using interface eth0/DC:A6:32:BD:23:A8 with driver (version: 5.10.92-v7l+) Jan 25 15:39:42 volumiomfn ifplugd(eth0)[637]: Using detection mode: SIOCETHTOOL Jan 25 15:39:42 volumiomfn ifplugd(eth0)[637]: Initialization complete, link beat not detected. Jan 25 15:39:42 volumiomfn ntpd[609]: ntpd 4.2.8p12@1.3728-o (1): Starting Jan 25 15:39:42 volumiomfn ntpd[609]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Jan 25 15:39:42 volumiomfn systemd[1]: Started Network Time Service. Jan 25 15:39:42 volumiomfn ntpd[639]: proto: precision = 0.796 usec (-20) Jan 25 15:39:42 volumiomfn ntpd[639]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jan 25 15:39:42 volumiomfn ntpd[639]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2023-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jan 25 15:39:42 volumiomfn ntpd[639]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 29 days ago Jan 25 15:39:42 volumiomfn ntpd[639]: Listen and drop on 0 v6wildcard [::]:123 Jan 25 15:39:42 volumiomfn ntpd[639]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jan 25 15:39:42 volumiomfn ntpd[639]: Listen normally on 2 lo 127.0.0.1:123 Jan 25 15:39:42 volumiomfn ntpd[639]: Listening on routing socket on fd #19 for interface updates Jan 25 15:39:42 volumiomfn ntpd[639]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 25 15:39:42 volumiomfn ntpd[639]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 25 15:39:42 volumiomfn ifplugd[610]: Network Interface Plugging Daemon...start eth0...done. Jan 25 15:39:42 volumiomfn systemd[1]: Started LSB: Brings up/down network automatically. Jan 25 15:39:42 volumiomfn kernel: random: crng init done Jan 25 15:39:42 volumiomfn kernel: random: 7 urandom warning(s) missed due to ratelimiting Jan 25 15:39:42 volumiomfn volumio-remote-updater[507]: Error: No active session Jan 25 15:39:42 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:39:42] [info] asio async_connect error: system:111 (Connection refused) Jan 25 15:39:42 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:39:42] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 25 15:39:42 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:39:42] [error] handle_connect error: Underlying Transport Error Jan 25 15:39:43 volumiomfn sshd[646]: Server listening on 0.0.0.0 port 22. Jan 25 15:39:43 volumiomfn sshd[646]: Server listening on :: port 22. Jan 25 15:39:43 volumiomfn systemd[1]: Started OpenBSD Secure Shell server. Jan 25 15:39:43 volumiomfn haveged[437]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Jan 25 15:39:43 volumiomfn haveged[437]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Jan 25 15:39:43 volumiomfn haveged[437]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00252 Jan 25 15:39:43 volumiomfn haveged[437]: haveged: fills: 0, generated: 0 Jan 25 15:39:43 volumiomfn volumio[514]: Could not open config: /tmp/upmpdcli.conf Jan 25 15:39:43 volumiomfn systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 25 15:39:43 volumiomfn systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 25 15:39:43 volumiomfn ntpd[639]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jan 25 15:39:44 volumiomfn nmbd[624]: [2024/01/25 15:39:44.172790, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jan 25 15:39:44 volumiomfn nmbd[624]: started asyncdns process 652 Jan 25 15:39:44 volumiomfn nmbd[624]: [2024/01/25 15:39:44.175637, 0] ../lib/util/become_daemon.c:149(daemon_status) Jan 25 15:39:44 volumiomfn nmbd[624]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jan 25 15:39:44 volumiomfn nmbd[624]: [2024/01/25 15:39:44.175797, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jan 25 15:39:44 volumiomfn nmbd[624]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jan 25 15:39:44 volumiomfn systemd[1]: systemd-rfkill.service: Succeeded. Jan 25 15:39:44 volumiomfn ntpd[639]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jan 25 15:39:44 volumiomfn wireless.js[516]: Cleaning previous... Jan 25 15:39:45 volumiomfn sudo[661]: root : unable to resolve host volumiomfn Jan 25 15:39:45 volumiomfn sudo[661]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:45 volumiomfn sudo[661]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jan 25 15:39:45 volumiomfn sudo[661]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:45 volumiomfn sudo[661]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:45 volumiomfn sudo[663]: root : unable to resolve host volumiomfn Jan 25 15:39:45 volumiomfn sudo[663]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:45 volumiomfn sudo[663]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jan 25 15:39:45 volumiomfn sudo[663]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:45 volumiomfn mpd[640]: Jan 25 15:39 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 25 15:39:45 volumiomfn mpd[640]: Jan 25 15:39 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jan 25 15:39:45 volumiomfn mpd[640]: Jan 25 15:39 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jan 25 15:39:45 volumiomfn sudo[663]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:45 volumiomfn systemd[1]: Started Music Player Daemon. Jan 25 15:39:45 volumiomfn wireless.js[516]: Stopped aP Jan 25 15:39:45 volumiomfn ntpd[639]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jan 25 15:39:45 volumiomfn sudo[672]: volumio : unable to resolve host volumiomfn Jan 25 15:39:45 volumiomfn sudo[672]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:45 volumiomfn sudo[672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 25 15:39:45 volumiomfn sudo[672]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:45 volumiomfn kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 25 15:39:45 volumiomfn sudo[672]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:45 volumiomfn sudo[674]: volumio : unable to resolve host volumiomfn Jan 25 15:39:45 volumiomfn sudo[674]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:45 volumiomfn sudo[674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jan 25 15:39:45 volumiomfn sudo[674]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:45 volumiomfn sudo[674]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:45 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:45 volumiomfn sudo[681]: volumio : unable to resolve host volumiomfn Jan 25 15:39:45 volumiomfn sudo[681]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:45 volumiomfn sudo[681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 25 15:39:45 volumiomfn sudo[681]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:45 volumiomfn sudo[681]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:45 volumiomfn sudo[683]: volumio : unable to resolve host volumiomfn Jan 25 15:39:45 volumiomfn sudo[683]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:45 volumiomfn sudo[683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jan 25 15:39:45 volumiomfn sudo[683]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:46 volumiomfn ntpd[639]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jan 25 15:39:47 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:39:47] [info] asio async_connect error: system:111 (Connection refused) Jan 25 15:39:47 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:39:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 25 15:39:47 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:39:47] [error] handle_connect error: Underlying Transport Error Jan 25 15:39:48 volumiomfn kernel: Bluetooth: Core ver 2.22 Jan 25 15:39:48 volumiomfn kernel: NET: Registered protocol family 31 Jan 25 15:39:48 volumiomfn kernel: Bluetooth: HCI device and connection manager initialized Jan 25 15:39:48 volumiomfn kernel: Bluetooth: HCI socket layer initialized Jan 25 15:39:48 volumiomfn kernel: Bluetooth: L2CAP socket layer initialized Jan 25 15:39:48 volumiomfn kernel: Bluetooth: SCO socket layer initialized Jan 25 15:39:48 volumiomfn kernel: Bluetooth: HCI UART driver ver 2.3 Jan 25 15:39:48 volumiomfn kernel: Bluetooth: HCI UART protocol H4 registered Jan 25 15:39:48 volumiomfn kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Jan 25 15:39:48 volumiomfn kernel: Bluetooth: HCI UART protocol Broadcom registered Jan 25 15:39:48 volumiomfn btuart[470]: bcm43xx_init Jan 25 15:39:48 volumiomfn btuart[470]: Flash firmware /lib/firmware/brcm/BCM4345C0.hcd Jan 25 15:39:48 volumiomfn btuart[470]: Set Controller UART speed to 3000000 bit/s Jan 25 15:39:48 volumiomfn btuart[470]: Device setup complete Jan 25 15:39:48 volumiomfn systemd[1]: Starting Load/Save RF Kill Switch Status... Jan 25 15:39:48 volumiomfn systemd[1]: Started Configure Bluetooth Modems connected by UART. Jan 25 15:39:48 volumiomfn systemd[1]: Started Load/Save RF Kill Switch Status. Jan 25 15:39:48 volumiomfn systemd[1]: Created slice system-bthelper.slice. Jan 25 15:39:48 volumiomfn systemd[1]: Starting Raspberry Pi bluetooth helper... Jan 25 15:39:48 volumiomfn bthelper[696]: Raspberry Pi BDADDR already set Jan 25 15:39:48 volumiomfn systemd[1]: Started Raspberry Pi bluetooth helper. Jan 25 15:39:48 volumiomfn systemd[1]: Starting Bluetooth service... Jan 25 15:39:48 volumiomfn bluetoothd[706]: Bluetooth daemon 5.50 Jan 25 15:39:48 volumiomfn bluetoothd[706]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Jan 25 15:39:48 volumiomfn systemd[1]: Started Bluetooth service. Jan 25 15:39:48 volumiomfn systemd[1]: Reached target Bluetooth. Jan 25 15:39:48 volumiomfn bluetoothd[706]: Starting SDP server Jan 25 15:39:48 volumiomfn bluetoothd[706]: Excluding (cli) sap Jan 25 15:39:48 volumiomfn kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Jan 25 15:39:48 volumiomfn kernel: Bluetooth: BNEP filters: protocol multicast Jan 25 15:39:48 volumiomfn kernel: Bluetooth: BNEP socket layer initialized Jan 25 15:39:48 volumiomfn dbus-daemon[479]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=706 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Jan 25 15:39:48 volumiomfn bluetoothd[706]: Bluetooth management interface 1.18 initialized Jan 25 15:39:48 volumiomfn systemd[1]: Starting Hostname Service... Jan 25 15:39:48 volumiomfn dbus-daemon[479]: [system] Successfully activated service 'org.freedesktop.hostname1' Jan 25 15:39:48 volumiomfn systemd[1]: Started Hostname Service. Jan 25 15:39:48 volumiomfn bluetoothd[706]: Failed to set privacy: Rejected (0x0b) Jan 25 15:39:48 volumiomfn sudo[683]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:48 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:48 volumiomfn wireless.js[516]: Start wireless flow Jan 25 15:39:48 volumiomfn wireless.js[516]: Stopped hotspot (if there).. Jan 25 15:39:48 volumiomfn sudo[710]: root : unable to resolve host volumiomfn Jan 25 15:39:48 volumiomfn sudo[710]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:48 volumiomfn sudo[710]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jan 25 15:39:48 volumiomfn sudo[710]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:48 volumiomfn sudo[710]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:48 volumiomfn sudo[712]: root : unable to resolve host volumiomfn Jan 25 15:39:48 volumiomfn sudo[712]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:48 volumiomfn sudo[712]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jan 25 15:39:48 volumiomfn sudo[712]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:48 volumiomfn sudo[712]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:48 volumiomfn wireless.js[516]: DHCP IP Jan 25 15:39:48 volumiomfn wireless.js[516]: Start ap Jan 25 15:39:48 volumiomfn wpa_supplicant[714]: Successfully initialized wpa_supplicant Jan 25 15:39:48 volumiomfn sudo[715]: root : unable to resolve host volumiomfn Jan 25 15:39:48 volumiomfn sudo[715]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:48 volumiomfn sudo[715]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jan 25 15:39:48 volumiomfn sudo[715]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:49 volumiomfn kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 25 15:39:49 volumiomfn dhcpcd[716]: dev: loaded udev Jan 25 15:39:49 volumiomfn dhcpcd-run-hooks[734]: wlan0: starting wpa_supplicant Jan 25 15:39:49 volumiomfn dhcpcd-run-hooks[739]: wlan0: failed to start wpa_supplicant Jan 25 15:39:49 volumiomfn dhcpcd-run-hooks[740]: 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 Jan 25 15:39:49 volumiomfn dhcpcd[716]: wlan0: connected to Access Point `' Jan 25 15:39:49 volumiomfn dhcpcd[716]: no interfaces have a carrier Jan 25 15:39:49 volumiomfn dhcpcd[716]: forked to background, child pid 750 Jan 25 15:39:49 volumiomfn dhcpcd[750]: eth0: waiting for carrier Jan 25 15:39:49 volumiomfn dhcpcd[750]: wlan0: waiting for carrier Jan 25 15:39:49 volumiomfn sudo[715]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:49 volumiomfn wireless.js[516]: trying... Jan 25 15:39:49 volumiomfn sudo[752]: volumio : unable to resolve host volumiomfn Jan 25 15:39:49 volumiomfn sudo[752]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:50 volumiomfn sudo[752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:39:50 volumiomfn sudo[752]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:50 volumiomfn sudo[752]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:50 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:50 volumiomfn wireless.js[516]: trying... Jan 25 15:39:50 volumiomfn sudo[755]: volumio : unable to resolve host volumiomfn Jan 25 15:39:50 volumiomfn sudo[755]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:51 volumiomfn sudo[755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:39:51 volumiomfn sudo[755]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:51 volumiomfn sudo[755]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:51 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:51 volumiomfn wpa_supplicant[738]: wlan0: Trying to associate with SSID 'SLAUDIO' Jan 25 15:39:51 volumiomfn wireless.js[516]: trying... Jan 25 15:39:51 volumiomfn sudo[758]: volumio : unable to resolve host volumiomfn Jan 25 15:39:51 volumiomfn sudo[758]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:52 volumiomfn sudo[758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:39:52 volumiomfn sudo[758]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:52 volumiomfn sudo[758]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:52 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:52 volumiomfn wireless.js[516]: trying... Jan 25 15:39:53 volumiomfn sudo[761]: volumio : unable to resolve host volumiomfn Jan 25 15:39:53 volumiomfn sudo[761]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:53 volumiomfn sudo[761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:39:53 volumiomfn sudo[761]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:53 volumiomfn sudo[761]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:53 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:53 volumiomfn systemd[1]: systemd-rfkill.service: Succeeded. Jan 25 15:39:53 volumiomfn bthelper[696]: Changing power off succeeded Jan 25 15:39:53 volumiomfn bthelper[696]: [CHG] Controller DC:A6:32:BD:23:AA Class: 0x0000041c Jan 25 15:39:53 volumiomfn bthelper[696]: Changing power on succeeded Jan 25 15:39:53 volumiomfn wireless.js[516]: trying... Jan 25 15:39:54 volumiomfn sudo[771]: volumio : unable to resolve host volumiomfn Jan 25 15:39:54 volumiomfn sudo[771]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:54 volumiomfn sudo[771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:39:54 volumiomfn sudo[771]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:54 volumiomfn sudo[771]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:54 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:54 volumiomfn dhcpcd[750]: wlan0: carrier acquired Jan 25 15:39:54 volumiomfn dhcpcd[750]: wlan0: connected to Access Point `SLAUDIO' Jan 25 15:39:54 volumiomfn wpa_supplicant[738]: wlan0: Associated with 7e:8a:20:d4:b2:c5 Jan 25 15:39:54 volumiomfn wpa_supplicant[738]: wlan0: CTRL-EVENT-CONNECTED - Connection to 7e:8a:20:d4:b2:c5 completed [id=1 id_str=] Jan 25 15:39:54 volumiomfn wpa_supplicant[738]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jan 25 15:39:54 volumiomfn dhcpcd[750]: DUID 00:01:00:01:29:aa:89:2e:dc:a6:32:bd:23:a9 Jan 25 15:39:54 volumiomfn dhcpcd[750]: wlan0: IAID 32:bd:23:a9 Jan 25 15:39:54 volumiomfn dhcpcd[750]: wlan0: adding address fe80::dea6:32ff:febd:23a9 Jan 25 15:39:54 volumiomfn dhcpcd[750]: ipv6_addaddr1: Permission denied Jan 25 15:39:54 volumiomfn dhcpcd[750]: wlan0: probing address 192.168.230.40/24 Jan 25 15:39:54 volumiomfn wpa_supplicant[738]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DK Jan 25 15:39:54 volumiomfn dhcpcd[750]: wlan0: carrier lost Jan 25 15:39:54 volumiomfn dhcpcd[750]: wlan0: carrier acquired Jan 25 15:39:54 volumiomfn dhcpcd[750]: wlan0: IAID 32:bd:23:a9 Jan 25 15:39:54 volumiomfn dhcpcd[750]: wlan0: probing address 192.168.230.40/24 Jan 25 15:39:54 volumiomfn wireless.js[516]: trying... Jan 25 15:39:55 volumiomfn sudo[796]: volumio : unable to resolve host volumiomfn Jan 25 15:39:55 volumiomfn sudo[796]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:55 volumiomfn sudo[796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:39:55 volumiomfn sudo[796]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:55 volumiomfn sudo[796]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:55 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:55 volumiomfn dhcpcd[750]: wlan0: soliciting an IPv6 router Jan 25 15:39:55 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:39:55] [info] asio async_connect error: system:111 (Connection refused) Jan 25 15:39:55 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:39:55] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 25 15:39:55 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:39:55] [error] handle_connect error: Underlying Transport Error Jan 25 15:39:55 volumiomfn wireless.js[516]: trying... Jan 25 15:39:56 volumiomfn sudo[799]: volumio : unable to resolve host volumiomfn Jan 25 15:39:56 volumiomfn sudo[799]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:56 volumiomfn sudo[799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:39:56 volumiomfn sudo[799]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:56 volumiomfn sudo[799]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:56 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:56 volumiomfn kernel: cam-dummy-reg: disabling Jan 25 15:39:56 volumiomfn kernel: cam1-reg: disabling Jan 25 15:39:56 volumiomfn wireless.js[516]: trying... Jan 25 15:39:57 volumiomfn sudo[802]: volumio : unable to resolve host volumiomfn Jan 25 15:39:57 volumiomfn sudo[802]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:57 volumiomfn sudo[802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:39:57 volumiomfn sudo[802]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:57 volumiomfn sudo[802]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:57 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:57 volumiomfn wireless.js[516]: trying... Jan 25 15:39:58 volumiomfn sudo[805]: volumio : unable to resolve host volumiomfn Jan 25 15:39:58 volumiomfn sudo[805]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:58 volumiomfn sudo[805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:39:58 volumiomfn sudo[805]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:58 volumiomfn sudo[805]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:58 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:58 volumiomfn wireless.js[516]: trying... Jan 25 15:39:59 volumiomfn sudo[808]: volumio : unable to resolve host volumiomfn Jan 25 15:39:59 volumiomfn sudo[808]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:39:59 volumiomfn sudo[808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:39:59 volumiomfn sudo[808]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:39:59 volumiomfn sudo[808]: pam_unix(sudo:session): session closed for user root Jan 25 15:39:59 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:39:59 volumiomfn dhcpcd[750]: wlan0: using static address 192.168.230.40/24 Jan 25 15:39:59 volumiomfn avahi-daemon[520]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.230.40. Jan 25 15:39:59 volumiomfn dhcpcd[750]: wlan0: adding route to 192.168.230.0/24 Jan 25 15:39:59 volumiomfn dhcpcd[750]: wlan0: adding default route via 192.168.230.1 Jan 25 15:39:59 volumiomfn avahi-daemon[520]: New relevant interface wlan0.IPv4 for mDNS. Jan 25 15:39:59 volumiomfn avahi-daemon[520]: Registering new address record for 192.168.230.40 on wlan0.IPv4. Jan 25 15:39:59 volumiomfn wireless.js[516]: trying... Jan 25 15:40:01 volumiomfn ntpd[639]: Listen normally on 3 wlan0 192.168.230.40:123 Jan 25 15:40:01 volumiomfn ntpd[639]: new interface(s) found: waking up resolver Jan 25 15:40:04 volumiomfn systemd[1]: Started Samba NMB Daemon. Jan 25 15:40:04 volumiomfn nmbd[624]: [2024/01/25 15:40:04.186292, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 25 15:40:04 volumiomfn nmbd[624]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jan 25 15:40:04 volumiomfn systemd[1]: Starting Samba Winbind Daemon... Jan 25 15:40:04 volumiomfn winbindd[833]: [2024/01/25 15:40:04.374145, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jan 25 15:40:04 volumiomfn winbindd[833]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jan 25 15:40:04 volumiomfn winbindd[833]: [2024/01/25 15:40:04.392316, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 25 15:40:04 volumiomfn winbindd[833]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jan 25 15:40:04 volumiomfn systemd[1]: Started Samba Winbind Daemon. Jan 25 15:40:04 volumiomfn systemd[1]: Starting Samba SMB Daemon... Jan 25 15:40:04 volumiomfn winbindd[833]: [2024/01/25 15:40:04.733636, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Jan 25 15:40:04 volumiomfn winbindd[833]: res_names->count = 3, expected 4 Jan 25 15:40:04 volumiomfn systemd[1]: Started Samba SMB Daemon. Jan 25 15:40:04 volumiomfn smbd[838]: [2024/01/25 15:40:04.752735, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 25 15:40:04 volumiomfn smbd[838]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jan 25 15:40:05 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:05] [info] asio async_connect error: system:111 (Connection refused) Jan 25 15:40:05 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:05] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 25 15:40:05 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:05] [error] handle_connect error: Underlying Transport Error Jan 25 15:40:09 volumiomfn systemd[1]: systemd-fsckd.service: Succeeded. Jan 25 15:40:10 volumiomfn sudo[832]: volumio : unable to resolve host volumiomfn Jan 25 15:40:10 volumiomfn sudo[832]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:10 volumiomfn sudo[832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:40:10 volumiomfn sudo[832]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:10 volumiomfn sudo[832]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:10 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:40:10 volumiomfn wireless.js[516]: Connected to: ----SLAUDIO Jan 25 15:40:10 volumiomfn wireless.js[516]: ---- Jan 25 15:40:10 volumiomfn wireless.js[516]: trying... Jan 25 15:40:10 volumiomfn sh[400]: timed out Jan 25 15:40:10 volumiomfn dhcpcd[446]: timed out Jan 25 15:40:10 volumiomfn sh[400]: dhcpcd exited Jan 25 15:40:10 volumiomfn dhcpcd[446]: dhcpcd exited Jan 25 15:40:10 volumiomfn sh[400]: ifup: failed to bring up eth0 Jan 25 15:40:10 volumiomfn systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jan 25 15:40:10 volumiomfn systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jan 25 15:40:15 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:15] [info] asio async_connect error: system:111 (Connection refused) Jan 25 15:40:15 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:15] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 25 15:40:15 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:15] [error] handle_connect error: Underlying Transport Error Jan 25 15:40:18 volumiomfn systemd[1]: systemd-hostnamed.service: Succeeded. Jan 25 15:40:20 volumiomfn sudo[848]: root : unable to resolve host volumiomfn Jan 25 15:40:20 volumiomfn sudo[848]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:20 volumiomfn sudo[848]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 15:40:20 volumiomfn sudo[848]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:20 volumiomfn sudo[848]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:20 volumiomfn sudo[850]: volumio : unable to resolve host volumiomfn Jan 25 15:40:20 volumiomfn sudo[850]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:20 volumiomfn sudo[850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 25 15:40:20 volumiomfn sudo[850]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:20 volumiomfn sudo[850]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:20 volumiomfn wireless.js[516]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:40:20 volumiomfn wireless.js[516]: Connected to: ----SLAUDIO Jan 25 15:40:20 volumiomfn wireless.js[516]: ---- Jan 25 15:40:20 volumiomfn wireless.js[516]: ... joined AP, wlan0 IPv4 is 192.168.230.40, ipV6 is undefined Jan 25 15:40:20 volumiomfn wireless.js[516]: It's done! AP Jan 25 15:40:25 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:25] [info] asio async_connect error: system:111 (Connection refused) Jan 25 15:40:25 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:25] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 25 15:40:25 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:25] [error] handle_connect error: Underlying Transport Error Jan 25 15:40:30 volumiomfn sudo[858]: root : unable to resolve host volumiomfn Jan 25 15:40:30 volumiomfn sudo[858]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:30 volumiomfn sudo[858]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 15:40:30 volumiomfn sudo[858]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:30 volumiomfn sudo[858]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:30 volumiomfn wireless.js[516]: ... joined AP, wlan0 IPv4 is 192.168.230.40, ipV6 is undefined Jan 25 15:40:30 volumiomfn wireless.js[516]: It's done! AP Jan 25 15:40:30 volumiomfn systemd[1]: Started Wireless Services. Jan 25 15:40:30 volumiomfn kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 25 15:40:30 volumiomfn systemd[1]: Started Volumio Backend Module. Jan 25 15:40:30 volumiomfn systemd[1]: Reached target Multi-User System. Jan 25 15:40:30 volumiomfn systemd[1]: Reached target Graphical Interface. Jan 25 15:40:30 volumiomfn systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 25 15:40:30 volumiomfn systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 25 15:40:30 volumiomfn systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 25 15:40:30 volumiomfn systemd[1]: Startup finished in 9.779s (kernel) + 56.863s (userspace) = 1min 6.643s. Jan 25 15:40:32 volumiomfn volumio[864]: info: ------------------------------------------- Jan 25 15:40:32 volumiomfn volumio[864]: info: ----- Volumio3 ---- Jan 25 15:40:32 volumiomfn volumio[864]: info: ------------------------------------------- Jan 25 15:40:32 volumiomfn volumio[864]: info: ----- System startup ---- Jan 25 15:40:32 volumiomfn volumio[864]: info: ------------------------------------------- Jan 25 15:40:32 volumiomfn volumio[864]: info: MYVOLUMIO Environment detected Jan 25 15:40:32 volumiomfn volumio[864]: info: Plugin folders cleanup Jan 25 15:40:32 volumiomfn volumio[864]: info: Scanning into folder /volumio/app/plugins/ Jan 25 15:40:32 volumiomfn volumio[864]: info: Scanning category audio_interface Jan 25 15:40:32 volumiomfn volumio[864]: info: Scanning category miscellanea Jan 25 15:40:32 volumiomfn volumio[864]: info: Scanning category music_service Jan 25 15:40:32 volumiomfn volumio[864]: info: Scanning category plugins.json Jan 25 15:40:32 volumiomfn volumio[864]: info: Scanning category system_controller Jan 25 15:40:32 volumiomfn volumio[864]: info: Scanning category user_interface Jan 25 15:40:32 volumiomfn volumio[864]: info: Scanning into folder /data/plugins/ Jan 25 15:40:32 volumiomfn volumio[864]: info: Scanning category audio_interface Jan 25 15:40:32 volumiomfn volumio[864]: info: Scanning category music_service Jan 25 15:40:32 volumiomfn volumio[864]: info: Scanning category system_controller Jan 25 15:40:32 volumiomfn volumio[864]: info: Plugin folders cleanup completed Jan 25 15:40:32 volumiomfn volumio[864]: info: ------------------------------------------- Jan 25 15:40:32 volumiomfn volumio[864]: info: ----- Core plugins startup ---- Jan 25 15:40:32 volumiomfn volumio[864]: info: ------------------------------------------- Jan 25 15:40:32 volumiomfn volumio[864]: info: Loading plugins from folder /volumio/app/plugins/ Jan 25 15:40:32 volumiomfn volumio[864]: info: Adding plugin upnp to MyMusic Plugins Jan 25 15:40:32 volumiomfn volumio[864]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 25 15:40:32 volumiomfn volumio[864]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 25 15:40:32 volumiomfn volumio[864]: info: Loading plugins from folder /data/plugins/ Jan 25 15:40:32 volumiomfn volumio[864]: info: Loading plugin "system"... Jan 25 15:40:32 volumiomfn volumio[864]: info: Loading plugin "appearance"... Jan 25 15:40:33 volumiomfn volumio[864]: info: Loading plugin "network"... Jan 25 15:40:33 volumiomfn volumio[864]: info: Refreshing Cached IP Addresses Jan 25 15:40:33 volumiomfn volumio[864]: info: Loading plugin "services"... Jan 25 15:40:33 volumiomfn volumio[864]: info: Loading plugin "alsa_controller"... Jan 25 15:40:33 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 25 15:40:33 volumiomfn volumio[864]: info: Loading plugin "wizard"... Jan 25 15:40:33 volumiomfn volumio[864]: info: Loading plugin "volumio_command_line_client"... Jan 25 15:40:33 volumiomfn volumio[864]: info: Loading plugin "upnp"... Jan 25 15:40:33 volumiomfn volumio[864]: info: [1706197233996] Starting Upmpd Daemon Jan 25 15:40:33 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 25 15:40:33 volumiomfn volumio[864]: info: Loading plugin "my_music"... Jan 25 15:40:34 volumiomfn volumio[864]: info: Loading plugin "mpd"... Jan 25 15:40:34 volumiomfn volumio[864]: info: Creating MPD Configuration file Jan 25 15:40:34 volumiomfn volumio[864]: info: Loading plugin "upnp_browser"... Jan 25 15:40:34 volumiomfn volumio[864]: info: Loading plugin "networkfs"... Jan 25 15:40:34 volumiomfn volumio[864]: info: Starting Udev Watcher for removable devices Jan 25 15:40:35 volumiomfn volumio[864]: info: Ignoring mount for partition: boot Jan 25 15:40:35 volumiomfn volumio[864]: info: Ignoring mount for partition: volumio Jan 25 15:40:35 volumiomfn volumio[864]: info: Ignoring mount for partition: volumio_data Jan 25 15:40:35 volumiomfn volumio[864]: info: Mounting Device MUSIK Jan 25 15:40:35 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:35] [connect] Successful connection Jan 25 15:40:44 volumiomfn sudo[883]: volumio : unable to resolve host volumiomfn Jan 25 15:40:44 volumiomfn sudo[883]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:44 volumiomfn sudo[885]: volumio : unable to resolve host volumiomfn Jan 25 15:40:44 volumiomfn sudo[887]: volumio : unable to resolve host volumiomfn Jan 25 15:40:44 volumiomfn sudo[885]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:44 volumiomfn sudo[887]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:44 volumiomfn sudo[883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 25 15:40:44 volumiomfn sudo[883]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:44 volumiomfn sudo[885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 15:40:44 volumiomfn sudo[885]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:44 volumiomfn sudo[887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 25 15:40:44 volumiomfn sudo[887]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:44 volumiomfn sudo[883]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:44 volumiomfn sudo[885]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:44 volumiomfn sudo[891]: volumio : unable to resolve host volumiomfn Jan 25 15:40:44 volumiomfn sudo[893]: volumio : unable to resolve host volumiomfn Jan 25 15:40:44 volumiomfn sudo[893]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:44 volumiomfn sudo[891]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:44 volumiomfn sudo[893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 25 15:40:44 volumiomfn sudo[893]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:44 volumiomfn sudo[891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 25 15:40:44 volumiomfn sudo[891]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:44 volumiomfn sudo[891]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:44 volumiomfn systemd[1]: Stopping Music Player Daemon... Jan 25 15:40:44 volumiomfn systemd[1]: mpd.service: Succeeded. Jan 25 15:40:44 volumiomfn systemd[1]: Stopped Music Player Daemon. Jan 25 15:40:44 volumiomfn systemd[1]: Starting Music Player Daemon... Jan 25 15:40:44 volumiomfn sudo[896]: volumio : unable to resolve host volumiomfn Jan 25 15:40:44 volumiomfn sudo[896]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:44 volumiomfn sudo[896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=kaR2fler1_,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.222.48/NoBackup\Multimedia\Audio /mnt/NAS/BCK01 Jan 25 15:40:44 volumiomfn sudo[896]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:45 volumiomfn kernel: FS-Cache: Netfs 'cifs' registered for caching Jan 25 15:40:45 volumiomfn kernel: Key type cifs.spnego registered Jan 25 15:40:45 volumiomfn kernel: Key type cifs.idmap registered Jan 25 15:40:45 volumiomfn kernel: CIFS: Attempting to mount //192.168.222.48/NoBackup\Multimedia\Audio Jan 25 15:40:45 volumiomfn 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. Jan 25 15:40:45 volumiomfn mpd[909]: Jan 25 15:40 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 25 15:40:45 volumiomfn mpd[909]: Jan 25 15:40 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jan 25 15:40:45 volumiomfn mpd[909]: Jan 25 15:40 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jan 25 15:40:45 volumiomfn systemd[1]: Started Music Player Daemon. Jan 25 15:40:45 volumiomfn sudo[893]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:45 volumiomfn sudo[901]: volumio : unable to resolve host volumiomfn Jan 25 15:40:45 volumiomfn sudo[901]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:45 volumiomfn sudo[901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/MUSIK -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jan 25 15:40:45 volumiomfn sudo[901]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:45 volumiomfn sudo[901]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:45 volumiomfn volumio[864]: sudo: unable to resolve host volumiomfn: System error Jan 25 15:40:45 volumiomfn kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jan 25 15:40:45 volumiomfn kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jan 25 15:40:45 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 25 15:40:45 volumiomfn volumio[864]: info: Loading plugin "alarm-clock"... Jan 25 15:40:45 volumiomfn volumio[864]: info: Loading plugin "airplay_emulation"... Jan 25 15:40:45 volumiomfn volumio[864]: info: Starting Shairport Sync Jan 25 15:40:45 volumiomfn volumio[864]: info: Loading plugin "last_100"... Jan 25 15:40:45 volumiomfn volumio[864]: info: Loading plugin "webradio"... Jan 25 15:40:45 volumiomfn volumio[864]: info: Loading plugin "i2s_dacs"... Jan 25 15:40:45 volumiomfn volumio[864]: info: Loading plugin "volumiodiscovery"... Jan 25 15:40:45 volumiomfn volumio[864]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 25 15:40:45 volumiomfn volumio[864]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 25 15:40:45 volumiomfn volumio[864]: *** WARNING *** For more information see Jan 25 15:40:45 volumiomfn node[864]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 25 15:40:45 volumiomfn volumio[864]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 25 15:40:45 volumiomfn volumio[864]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 25 15:40:45 volumiomfn volumio[864]: *** WARNING *** For more information see Jan 25 15:40:45 volumiomfn node[864]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 25 15:40:45 volumiomfn node[864]: *** WARNING *** For more information see Jan 25 15:40:45 volumiomfn node[864]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 25 15:40:45 volumiomfn node[864]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 25 15:40:45 volumiomfn node[864]: *** WARNING *** For more information see Jan 25 15:40:45 volumiomfn volumio[864]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 25 15:40:45 volumiomfn volumio[864]: info: Discovery: Started advertising with name: Volumio_MFN Jan 25 15:40:45 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 25 15:40:45 volumiomfn volumio[864]: info: Loading plugin "autostart"... Jan 25 15:40:45 volumiomfn volumio[864]: info: Applying required configuration parameters for plugin autostart Jan 25 15:40:45 volumiomfn volumio[864]: info: AutoStart - onVolumioStart - read config.json Jan 25 15:40:45 volumiomfn volumio[864]: info: Loading plugin "outputs"... Jan 25 15:40:45 volumiomfn volumio[864]: info: Loading plugin "albumart"... Jan 25 15:40:46 volumiomfn volumio[864]: info: Plugin example_plugin is not enabled Jan 25 15:40:46 volumiomfn volumio[864]: info: Loading plugin "inputs"... Jan 25 15:40:46 volumiomfn volumio[864]: info: Loading plugin "updater_comm"... Jan 25 15:40:46 volumiomfn volumio[864]: info: Plugin mpdemulation is not enabled Jan 25 15:40:46 volumiomfn volumio[864]: info: Loading plugin "rest_api"... Jan 25 15:40:46 volumiomfn volumio[864]: info: Loading plugin "websocket"... Jan 25 15:40:46 volumiomfn volumio[864]: info: Loading plugin "fusiondsp"... Jan 25 15:40:46 volumiomfn volumio[864]: Forking 3 albumart workers Jan 25 15:40:46 volumiomfn volumio[864]: info: Applying required configuration parameters for plugin fusiondsp Jan 25 15:40:46 volumiomfn volumio[864]: info: Loading plugin "radio_paradise"... Jan 25 15:40:46 volumiomfn volumio[864]: Starting albumart workers Jan 25 15:40:46 volumiomfn volumio[864]: Starting albumart workers Jan 25 15:40:46 volumiomfn volumio[864]: Starting albumart workers Jan 25 15:40:47 volumiomfn volumio[864]: info: Applying required configuration parameters for plugin radio_paradise Jan 25 15:40:47 volumiomfn volumio[864]: info: [1706197247040] [RadioParadise] API delay: 5 Jan 25 15:40:47 volumiomfn volumio[864]: info: Loading plugin "spop"... Jan 25 15:40:47 volumiomfn sudo[896]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:47 volumiomfn volumio[864]: info: Loading plugin "volspotconnect2"... Jan 25 15:40:47 volumiomfn sudo[887]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:48 volumiomfn volumio[864]: info: Loading i18n strings for locale da Jan 25 15:40:48 volumiomfn volumio[864]: Updating browse sources language Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::initPlayerControls Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: Express server listening on port 3000 Jan 25 15:40:48 volumiomfn volumio[864]: [Metrics] WebUI: 17s 46.51ms Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreStateMachine::resetVolumioState Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreStateMachine::getcurrentVolume Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::volumioRetrievevolume Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreStateMachine::pushState Jan 25 15:40:48 volumiomfn volumio[864]: info: CorePlayQueue::getTrack 0 Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::volumioPushState Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreStateMachine::updateTrackBlock Jan 25 15:40:48 volumiomfn volumio[864]: info: CorePlayQueue::getTrackBlock Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::volumioRetrievevolume Jan 25 15:40:48 volumiomfn volumio[864]: info: MPD Permissions set Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreStateMachine::pushState Jan 25 15:40:48 volumiomfn volumio[864]: info: CorePlayQueue::getTrack 0 Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::volumioPushState Jan 25 15:40:48 volumiomfn volumio[864]: info: MPD running with PID909 Jan 25 15:40:48 volumiomfn volumio[864]: ,establishing connection Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: Reloading queue from file Jan 25 15:40:48 volumiomfn volumio[864]: error: updateQueue error: null Jan 25 15:40:48 volumiomfn volumio[864]: info: Setting Device type: Raspberry PI Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreStateMachine::setRepeat true single undefined Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreStateMachine::pushState Jan 25 15:40:48 volumiomfn volumio[864]: info: CorePlayQueue::getTrack 0 Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::volumioPushState Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreStateMachine::setRandom null Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreStateMachine::pushState Jan 25 15:40:48 volumiomfn volumio[864]: info: CorePlayQueue::getTrack 0 Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::volumioPushState Jan 25 15:40:48 volumiomfn volumio[864]: info: Completed loading Core Plugins Jan 25 15:40:48 volumiomfn volumio[864]: info: Preparing to generate the ALSA configuration file Jan 25 15:40:48 volumiomfn volumio[864]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 25 15:40:48 volumiomfn volumio[864]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 25 15:40:48 volumiomfn volumio[864]: info: Reading ALSA contributions from plugins. Jan 25 15:40:48 volumiomfn volumio[864]: error: updateQueue error: null Jan 25 15:40:48 volumiomfn volumio[864]: info: Asound.conf file unchanged, so no further update is needed Jan 25 15:40:48 volumiomfn volumio[864]: info: Output device has changed, restarting MPD Jan 25 15:40:48 volumiomfn volumio[864]: info: Output device has changed, restarting Shairport Sync Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 25 15:40:48 volumiomfn volumio[864]: info: ___________ START PLUGINS ___________ Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 25 15:40:48 volumiomfn volumio[864]: info: [1706197248919] CoreMusicLibrary::Adding element Media Servers Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:48 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 25 15:40:49 volumiomfn volumio[864]: info: [1706197249009] CoreMusicLibrary::Adding element Last_100 Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 25 15:40:49 volumiomfn volumio[864]: info: [1706197249012] CoreMusicLibrary::Adding element Webradio Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 25 15:40:49 volumiomfn volumio[864]: info: AutoStart - onStart Jan 25 15:40:49 volumiomfn volumio[864]: info: Loading i18n strings for locale da Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: FusionDsp - mixtype--------------------- Software Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 25 15:40:49 volumiomfn volumio[864]: info: [1706197249038] CoreMusicLibrary::Adding element Radio Paradise Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 25 15:40:49 volumiomfn volumio[864]: Cannot find translation for source Radio Paradise Jan 25 15:40:49 volumiomfn volumio[864]: [SpotifyConnect] Creating VLS config file Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: [SpotifyConnect] Starting metadata listener Jan 25 15:40:49 volumiomfn volumio[864]: info: Volumio Calling Home Jan 25 15:40:49 volumiomfn volumio[864]: info: Preparing to generate the ALSA configuration file Jan 25 15:40:49 volumiomfn volumio[864]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 25 15:40:49 volumiomfn volumio[864]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 25 15:40:49 volumiomfn volumio[864]: info: Reading ALSA contributions from plugins. Jan 25 15:40:49 volumiomfn volumio[864]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: Starting Shairport Sync Jan 25 15:40:49 volumiomfn volumio[864]: info: Starting Shairport Sync Jan 25 15:40:49 volumiomfn volumio[864]: info: Starting Shairport Sync Jan 25 15:40:49 volumiomfn volumio[864]: info: Asound.conf file unchanged, so no further update is needed Jan 25 15:40:49 volumiomfn volumio[864]: info: Output device has changed, restarting MPD Jan 25 15:40:49 volumiomfn volumio[864]: info: Output device has changed, restarting Shairport Sync Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:49 volumiomfn volumio[864]: info: Starting Shairport Sync Jan 25 15:40:50 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:50] [connect] Successful connection Jan 25 15:40:50 volumiomfn volumio-remote-updater[507]: [2024-01-25 15:40:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1706197250 101 Jan 25 15:40:50 volumiomfn volumio[864]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2 Jan 25 15:40:51 volumiomfn volumio[864]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jan 25 15:40:51 volumiomfn volumio[864]: info: camilladsp service started and running in background, instance 1 Jan 25 15:40:51 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 25 15:40:51 volumiomfn volumio[864]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 25 15:40:51 volumiomfn volumio[864]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jan 25 15:40:51 volumiomfn volumio[864]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 25 15:40:51 volumiomfn volumio[864]: info: FusionDsp loaded Jan 25 15:40:51 volumiomfn volumio[864]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 25 15:40:51 volumiomfn volumio[864]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 25 15:40:51 volumiomfn volumio[864]: info: Adding Signal Path Element [object Object] Jan 25 15:40:51 volumiomfn volumio[864]: info: Adding fusiondspeq DSP Signal Path Element Jan 25 15:40:51 volumiomfn volumio[864]: info: FusionDsp - ---- installed callbackRead Jan 25 15:40:51 volumiomfn volumio[864]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 15:40:51 volumiomfn volumio[864]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jan 25 15:40:51 volumiomfn volumio[864]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jan 25 15:40:51 volumiomfn volumio[864]: at onErrorNT (internal/child_process.js:465:16) Jan 25 15:40:51 volumiomfn volumio[864]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jan 25 15:40:51 volumiomfn volumio[864]: errno: -2, Jan 25 15:40:51 volumiomfn volumio[864]: code: 'ENOENT', Jan 25 15:40:51 volumiomfn volumio[864]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jan 25 15:40:51 volumiomfn volumio[864]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jan 25 15:40:51 volumiomfn volumio[864]: spawnargs: [ Jan 25 15:40:51 volumiomfn volumio[864]: '-p', Jan 25 15:40:51 volumiomfn volumio[864]: 9876, Jan 25 15:40:51 volumiomfn volumio[864]: '-o', Jan 25 15:40:51 volumiomfn volumio[864]: '/tmp/camilladsp.log', Jan 25 15:40:51 volumiomfn volumio[864]: '-l', Jan 25 15:40:51 volumiomfn volumio[864]: 'warn', Jan 25 15:40:51 volumiomfn volumio[864]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jan 25 15:40:51 volumiomfn volumio[864]: ] Jan 25 15:40:51 volumiomfn volumio[864]: } Jan 25 15:40:51 volumiomfn volumio[864]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 15:40:53 volumiomfn ntpd[639]: Soliciting pool server 195.137.195.251 Jan 25 15:40:54 volumiomfn ntpd[639]: Soliciting pool server 213.5.39.34 Jan 25 15:40:55 volumiomfn ntpd[639]: Soliciting pool server 86.52.112.177 Jan 25 15:40:56 volumiomfn ntpd[639]: Soliciting pool server 91.210.59.156 Jan 25 15:40:58 volumiomfn sudo[1003]: volumio : unable to resolve host volumiomfn Jan 25 15:40:58 volumiomfn sudo[1003]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:58 volumiomfn sudo[1005]: volumio : unable to resolve host volumiomfn Jan 25 15:40:58 volumiomfn sudo[1005]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:58 volumiomfn sudo[1003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 25 15:40:58 volumiomfn sudo[1003]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:58 volumiomfn sudo[1005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 25 15:40:58 volumiomfn sudo[1005]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:58 volumiomfn sudo[1024]: volumio : unable to resolve host volumiomfn Jan 25 15:40:58 volumiomfn sudo[1024]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:58 volumiomfn sudo[1003]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:58 volumiomfn sudo[1005]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:58 volumiomfn sudo[1024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 25 15:40:58 volumiomfn sudo[1024]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:58 volumiomfn systemd[1]: Started UPnP Renderer front-end to MPD. Jan 25 15:40:58 volumiomfn sudo[1026]: volumio : unable to resolve host volumiomfn Jan 25 15:40:58 volumiomfn sudo[1026]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:58 volumiomfn sudo[1024]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:58 volumiomfn sudo[1026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 25 15:40:58 volumiomfn sudo[1026]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:58 volumiomfn sudo[1026]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:58 volumiomfn sudo[1028]: volumio : unable to resolve host volumiomfn Jan 25 15:40:58 volumiomfn sudo[1028]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:58 volumiomfn sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 25 15:40:58 volumiomfn sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:58 volumiomfn systemd[1]: Stopping Music Player Daemon... Jan 25 15:40:58 volumiomfn ntpd[639]: Soliciting pool server 192.36.143.130 Jan 25 15:40:58 volumiomfn systemd[1]: mpd.service: Succeeded. Jan 25 15:40:58 volumiomfn systemd[1]: Stopped Music Player Daemon. Jan 25 15:40:58 volumiomfn systemd[1]: Starting Music Player Daemon... Jan 25 15:40:59 volumiomfn sudo[1039]: volumio : unable to resolve host volumiomfn Jan 25 15:40:59 volumiomfn sudo[1039]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:59 volumiomfn sudo[1039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Jan 25 15:40:59 volumiomfn sudo[1039]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:59 volumiomfn systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway. Jan 25 15:40:59 volumiomfn systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Jan 25 15:40:59 volumiomfn systemd[1]: Started Spotify Daemon. Jan 25 15:40:59 volumiomfn sudo[1041]: volumio : unable to resolve host volumiomfn Jan 25 15:40:59 volumiomfn sudo[1041]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:59 volumiomfn sudo[1041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jan 25 15:40:59 volumiomfn sudo[1041]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:59 volumiomfn sudo[1039]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:59 volumiomfn systemd[1]: Started Volspotconnect2 Daemon. Jan 25 15:40:59 volumiomfn sudo[1041]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:59 volumiomfn sudo[1050]: volumio : unable to resolve host volumiomfn Jan 25 15:40:59 volumiomfn sudo[1052]: volumio : unable to resolve host volumiomfn Jan 25 15:40:59 volumiomfn sudo[1050]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:59 volumiomfn sudo[1054]: volumio : unable to resolve host volumiomfn Jan 25 15:40:59 volumiomfn sudo[1052]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:59 volumiomfn sudo[1054]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:59 volumiomfn sudo[1050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 25 15:40:59 volumiomfn sudo[1054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 25 15:40:59 volumiomfn sudo[1052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 25 15:40:59 volumiomfn sudo[1054]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:59 volumiomfn sudo[1050]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:59 volumiomfn sudo[1052]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:59 volumiomfn sudo[1058]: volumio : unable to resolve host volumiomfn Jan 25 15:40:59 volumiomfn sudo[1058]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:59 volumiomfn sudo[1058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 25 15:40:59 volumiomfn sudo[1058]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:59 volumiomfn sudo[1056]: volumio : unable to resolve host volumiomfn Jan 25 15:40:59 volumiomfn sudo[1056]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:59 volumiomfn sudo[1056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 25 15:40:59 volumiomfn sudo[1056]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:59 volumiomfn sudo[1056]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:59 volumiomfn volumio[1103]: 2024-01-25 15:40:59 [SPTF] 15:40:59.435 I [offline_authorizer.cpp:297] Unable to login offline: no such user Jan 25 15:40:59 volumiomfn systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 25 15:40:59 volumiomfn volumio[1103]: 2024-01-25 15:40:59 [SPTF] 15:40:59.441 I [ap:1752] Connecting to AP ap.spotify.com:4070 Jan 25 15:40:59 volumiomfn volumio[1105]: vollibrespot v0.2.3 769ce77 2021-06-04 (librespot 08d8bcc 2020-10-07) -- Built On 2021-06-04 Jan 25 15:40:59 volumiomfn volumio[1105]: Reading Config from "volspotify.toml" Jan 25 15:40:59 volumiomfn systemd[1]: shairport-sync.service: Succeeded. Jan 25 15:40:59 volumiomfn systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 25 15:40:59 volumiomfn systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 25 15:40:59 volumiomfn systemd[1]: mpd.service: Succeeded. Jan 25 15:40:59 volumiomfn systemd[1]: Stopped Music Player Daemon. Jan 25 15:40:59 volumiomfn volumio[1105]: [Vollibrespot] : Using Alsa backend with device: volumio Jan 25 15:40:59 volumiomfn systemd[1]: Starting Music Player Daemon... Jan 25 15:40:59 volumiomfn systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 25 15:40:59 volumiomfn sudo[1050]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:59 volumiomfn sudo[1054]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:59 volumiomfn sudo[1052]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:59 volumiomfn sudo[1067]: volumio : unable to resolve host volumiomfn Jan 25 15:40:59 volumiomfn sudo[1067]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:59 volumiomfn sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 25 15:40:59 volumiomfn sudo[1071]: volumio : unable to resolve host volumiomfn Jan 25 15:40:59 volumiomfn sudo[1071]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:40:59 volumiomfn sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:59 volumiomfn sudo[1071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Jan 25 15:40:59 volumiomfn sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:40:59 volumiomfn systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 25 15:40:59 volumiomfn sudo[1071]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:59 volumiomfn volumio[1105]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Jan 25 15:40:59 volumiomfn systemd[1]: shairport-sync.service: Succeeded. Jan 25 15:40:59 volumiomfn systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 25 15:40:59 volumiomfn systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 25 15:40:59 volumiomfn sudo[1067]: pam_unix(sudo:session): session closed for user root Jan 25 15:40:59 volumiomfn ntpd[639]: Soliciting pool server 194.239.208.123 Jan 25 15:41:00 volumiomfn mpd[1125]: Jan 25 15:41 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 25 15:41:00 volumiomfn mpd[1125]: Jan 25 15:41 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jan 25 15:41:00 volumiomfn mpd[1125]: Jan 25 15:41 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jan 25 15:41:00 volumiomfn systemd[1]: Started Music Player Daemon. Jan 25 15:41:00 volumiomfn sudo[1058]: pam_unix(sudo:session): session closed for user root Jan 25 15:41:00 volumiomfn sudo[1028]: pam_unix(sudo:session): session closed for user root Jan 25 15:41:00 volumiomfn ntpd[639]: Soliciting pool server 213.32.246.229 Jan 25 15:41:01 volumiomfn sudo[1082]: volumio : unable to resolve host volumiomfn Jan 25 15:41:01 volumiomfn sudo[1082]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:41:01 volumiomfn sudo[1082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 25 15:41:01 volumiomfn sudo[1082]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 25 15:41:01 volumiomfn systemd[1]: Started FusionDsp Daemon. Jan 25 15:41:01 volumiomfn sudo[1082]: pam_unix(sudo:session): session closed for user root Jan 25 15:41:01 volumiomfn sudo[1092]: volumio : unable to resolve host volumiomfn Jan 25 15:41:01 volumiomfn sudo[1092]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 25 15:41:01 volumiomfn sudo[1092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-01-25 15:39 Jan 25 15:41:01 volumiomfn sudo[1092]: 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="cd8cf34b47ce852e70b71e6f7b6e0265f7fdb695" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="8f88153f9a18f312d56050e6613b45a852ac819a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 27 Sep 2023 11:35:49 AM CEST" VOLUMIO_VERSION="3.546" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6823c0d83061ff736b7e0dd4481bc496"