-- Logs begin at Tue 2024-09-17 17:06:54 CEST, end at Tue 2024-09-17 17:07:39 CEST. -- Sep 17 17:06:54 volumio-kitchen kernel: Booting Linux on physical CPU 0x0 Sep 17 17:06:54 volumio-kitchen kernel: Linux version 6.1.69-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) #1710 SMP Thu Dec 21 13:17:38 GMT 2023 Sep 17 17:06:54 volumio-kitchen kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d Sep 17 17:06:54 volumio-kitchen kernel: CPU: div instructions available: patching division code Sep 17 17:06:54 volumio-kitchen kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache Sep 17 17:06:54 volumio-kitchen kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.2 Sep 17 17:06:54 volumio-kitchen kernel: random: crng init done Sep 17 17:06:54 volumio-kitchen kernel: Memory policy: Data cache writealloc Sep 17 17:06:54 volumio-kitchen kernel: Reserved memory: created CMA memory pool at 0x000000002a000000, size 64 MiB Sep 17 17:06:54 volumio-kitchen kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Sep 17 17:06:54 volumio-kitchen kernel: Zone ranges: Sep 17 17:06:54 volumio-kitchen kernel: DMA [mem 0x0000000000000000-0x000000002fffffff] Sep 17 17:06:54 volumio-kitchen kernel: Normal empty Sep 17 17:06:54 volumio-kitchen kernel: HighMem [mem 0x0000000030000000-0x000000007fffffff] Sep 17 17:06:54 volumio-kitchen kernel: Movable zone start for each node Sep 17 17:06:54 volumio-kitchen kernel: Early memory node ranges Sep 17 17:06:54 volumio-kitchen kernel: node 0: [mem 0x0000000000000000-0x0000000037ffffff] Sep 17 17:06:54 volumio-kitchen kernel: node 0: [mem 0x0000000040000000-0x000000007fffffff] Sep 17 17:06:54 volumio-kitchen kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff] Sep 17 17:06:54 volumio-kitchen kernel: percpu: Embedded 17 pages/cpu s37012 r8192 d24428 u69632 Sep 17 17:06:54 volumio-kitchen kernel: pcpu-alloc: s37012 r8192 d24428 u69632 alloc=17*4096 Sep 17 17:06:54 volumio-kitchen kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 17 17:06:54 volumio-kitchen kernel: Built 1 zonelists, mobility grouping on. Total pages: 489792 Sep 17 17:06:54 volumio-kitchen kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:AD:76:19 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=634d688a-b96e-44c7-9dc6-4a37ca78c1a6 imgfile=/volumio_current.sqsh bootpart=UUID=DC0C-AF04 datapart=UUID=0bab8ffc-a6be-4cb1-bf2a-4f7cb7b6e7f1 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Sep 17 17:06:54 volumio-kitchen kernel: Unknown kernel command line parameters "splash nodebug imgpart=UUID=634d688a-b96e-44c7-9dc6-4a37ca78c1a6 imgfile=/volumio_current.sqsh bootpart=UUID=DC0C-AF04 datapart=UUID=0bab8ffc-a6be-4cb1-bf2a-4f7cb7b6e7f1 uuidconfig=cmdline.txt pcie_aspm=off bootdelay=7 use_kmsg=no", will be passed to user space. Sep 17 17:06:54 volumio-kitchen kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 17 17:06:54 volumio-kitchen kernel: software IO TLB: area num 4. Sep 17 17:06:54 volumio-kitchen kernel: software IO TLB: mapped [mem 0x0000000024e00000-0x0000000028e00000] (64MB) Sep 17 17:06:54 volumio-kitchen kernel: Memory: 1782940K/1966080K available (10240K kernel code, 1505K rwdata, 3388K rodata, 2048K init, 637K bss, 117604K reserved, 65536K cma-reserved, 1179648K highmem) Sep 17 17:06:54 volumio-kitchen kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 17 17:06:54 volumio-kitchen kernel: ftrace: allocating 37226 entries in 110 pages Sep 17 17:06:54 volumio-kitchen kernel: ftrace: allocated 110 pages with 5 groups Sep 17 17:06:54 volumio-kitchen kernel: trace event string verifier disabled Sep 17 17:06:54 volumio-kitchen kernel: rcu: Hierarchical RCU implementation. Sep 17 17:06:54 volumio-kitchen kernel: Rude variant of Tasks RCU enabled. Sep 17 17:06:54 volumio-kitchen kernel: Tracing variant of Tasks RCU enabled. Sep 17 17:06:54 volumio-kitchen kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. Sep 17 17:06:54 volumio-kitchen kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Sep 17 17:06:54 volumio-kitchen kernel: GIC: Using split EOI/Deactivate mode Sep 17 17:06:54 volumio-kitchen kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 17 17:06:54 volumio-kitchen kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Sep 17 17:06:54 volumio-kitchen kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Sep 17 17:06:54 volumio-kitchen kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Sep 17 17:06:54 volumio-kitchen kernel: Switching to timer-based delay loop, resolution 18ns Sep 17 17:06:54 volumio-kitchen kernel: Console: colour dummy device 80x30 Sep 17 17:06:54 volumio-kitchen kernel: printk: console [tty1] enabled Sep 17 17:06:54 volumio-kitchen kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000) Sep 17 17:06:54 volumio-kitchen kernel: CPU: Testing write buffer coherency: ok Sep 17 17:06:54 volumio-kitchen kernel: CPU0: Spectre BHB: enabling loop workaround for all CPUs Sep 17 17:06:54 volumio-kitchen kernel: pid_max: default: 32768 minimum: 301 Sep 17 17:06:54 volumio-kitchen kernel: LSM: Security Framework initializing Sep 17 17:06:54 volumio-kitchen kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: cgroup: Disabling memory control group subsystem Sep 17 17:06:54 volumio-kitchen kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Sep 17 17:06:54 volumio-kitchen kernel: cblist_init_generic: Setting adjustable number of callback queues. Sep 17 17:06:54 volumio-kitchen kernel: cblist_init_generic: Setting shift to 2 and lim to 1. Sep 17 17:06:54 volumio-kitchen kernel: cblist_init_generic: Setting adjustable number of callback queues. Sep 17 17:06:54 volumio-kitchen kernel: cblist_init_generic: Setting shift to 2 and lim to 1. Sep 17 17:06:54 volumio-kitchen kernel: Setting up static identity map for 0x200000 - 0x20003c Sep 17 17:06:54 volumio-kitchen kernel: rcu: Hierarchical SRCU implementation. Sep 17 17:06:54 volumio-kitchen kernel: rcu: Max phase no-delay instances is 1000. Sep 17 17:06:54 volumio-kitchen kernel: smp: Bringing up secondary CPUs ... Sep 17 17:06:54 volumio-kitchen kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Sep 17 17:06:54 volumio-kitchen kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Sep 17 17:06:54 volumio-kitchen kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Sep 17 17:06:54 volumio-kitchen kernel: smp: Brought up 1 node, 4 CPUs Sep 17 17:06:54 volumio-kitchen kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS). Sep 17 17:06:54 volumio-kitchen kernel: CPU: All CPU(s) started in HYP mode. Sep 17 17:06:54 volumio-kitchen kernel: CPU: Virtualization extensions available. Sep 17 17:06:54 volumio-kitchen kernel: devtmpfs: initialized Sep 17 17:06:54 volumio-kitchen kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0 Sep 17 17:06:54 volumio-kitchen kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Sep 17 17:06:54 volumio-kitchen kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: pinctrl core: initialized pinctrl subsystem Sep 17 17:06:54 volumio-kitchen kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 17 17:06:54 volumio-kitchen kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Sep 17 17:06:54 volumio-kitchen kernel: audit: initializing netlink subsys (disabled) Sep 17 17:06:54 volumio-kitchen kernel: audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 Sep 17 17:06:54 volumio-kitchen kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 17 17:06:54 volumio-kitchen kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Sep 17 17:06:54 volumio-kitchen kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Sep 17 17:06:54 volumio-kitchen kernel: Serial: AMBA PL011 UART driver Sep 17 17:06:54 volumio-kitchen kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled Sep 17 17:06:54 volumio-kitchen kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2023-10-17T15:39:16, variant start Sep 17 17:06:54 volumio-kitchen kernel: raspberrypi-firmware soc:firmware: Firmware hash is 30f0c5e4d076da3ab4f341d88e7d505760b93ad7 Sep 17 17:06:54 volumio-kitchen kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Sep 17 17:06:54 volumio-kitchen kernel: bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1 Sep 17 17:06:54 volumio-kitchen kernel: SCSI subsystem initialized Sep 17 17:06:54 volumio-kitchen kernel: usbcore: registered new interface driver usbfs Sep 17 17:06:54 volumio-kitchen kernel: usbcore: registered new interface driver hub Sep 17 17:06:54 volumio-kitchen kernel: usbcore: registered new device driver usb Sep 17 17:06:54 volumio-kitchen kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator Sep 17 17:06:54 volumio-kitchen kernel: pps_core: LinuxPPS API ver. 1 registered Sep 17 17:06:54 volumio-kitchen kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Sep 17 17:06:54 volumio-kitchen kernel: PTP clock support registered Sep 17 17:06:54 volumio-kitchen kernel: vgaarb: loaded Sep 17 17:06:54 volumio-kitchen kernel: clocksource: Switched to clocksource arch_sys_counter Sep 17 17:06:54 volumio-kitchen kernel: VFS: Disk quotas dquot_6.6.0 Sep 17 17:06:54 volumio-kitchen kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Sep 17 17:06:54 volumio-kitchen kernel: FS-Cache: Loaded Sep 17 17:06:54 volumio-kitchen kernel: CacheFiles: Loaded Sep 17 17:06:54 volumio-kitchen kernel: NET: Registered PF_INET protocol family Sep 17 17:06:54 volumio-kitchen kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: TCP: Hash tables configured (established 8192 bind 8192) Sep 17 17:06:54 volumio-kitchen kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Sep 17 17:06:54 volumio-kitchen kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 17 17:06:54 volumio-kitchen kernel: RPC: Registered named UNIX socket transport module. Sep 17 17:06:54 volumio-kitchen kernel: RPC: Registered udp transport module. Sep 17 17:06:54 volumio-kitchen kernel: RPC: Registered tcp transport module. Sep 17 17:06:54 volumio-kitchen kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Sep 17 17:06:54 volumio-kitchen kernel: PCI: CLS 0 bytes, default 64 Sep 17 17:06:54 volumio-kitchen kernel: Trying to unpack rootfs image as initramfs... Sep 17 17:06:54 volumio-kitchen kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available Sep 17 17:06:54 volumio-kitchen kernel: Initialise system trusted keyrings Sep 17 17:06:54 volumio-kitchen kernel: workingset: timestamp_bits=14 max_order=19 bucket_order=5 Sep 17 17:06:54 volumio-kitchen kernel: zbud: loaded Sep 17 17:06:54 volumio-kitchen kernel: NFS: Registering the id_resolver key type Sep 17 17:06:54 volumio-kitchen kernel: Key type id_resolver registered Sep 17 17:06:54 volumio-kitchen kernel: Key type id_legacy registered Sep 17 17:06:54 volumio-kitchen kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Sep 17 17:06:54 volumio-kitchen kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Sep 17 17:06:54 volumio-kitchen kernel: Key type asymmetric registered Sep 17 17:06:54 volumio-kitchen kernel: Asymmetric key parser 'x509' registered Sep 17 17:06:54 volumio-kitchen kernel: bounce: pool size: 64 pages Sep 17 17:06:54 volumio-kitchen kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Sep 17 17:06:54 volumio-kitchen kernel: io scheduler mq-deadline registered Sep 17 17:06:54 volumio-kitchen kernel: io scheduler kyber registered Sep 17 17:06:54 volumio-kitchen kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: Sep 17 17:06:54 volumio-kitchen kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] Sep 17 17:06:54 volumio-kitchen kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000 Sep 17 17:06:54 volumio-kitchen kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x007fffffff -> 0x0400000000 Sep 17 17:06:54 volumio-kitchen kernel: brcm-pcie fd500000.pcie: setting SCB_ACCESS_EN, READ_UR_MODE, MAX_BURST_SIZE Sep 17 17:06:54 volumio-kitchen kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 Sep 17 17:06:54 volumio-kitchen kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 17 17:06:54 volumio-kitchen kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff]) Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Sep 17 17:06:54 volumio-kitchen kernel: PCI: bus0: Fast back to back transfers disabled Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Sep 17 17:06:54 volumio-kitchen kernel: pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator Sep 17 17:06:54 volumio-kitchen kernel: pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator Sep 17 17:06:54 volumio-kitchen kernel: pci_bus 0000:01: supply vpcie12v not found, using dummy regulator Sep 17 17:06:54 volumio-kitchen kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:01:00.0: PME# supported from D0 D3cold Sep 17 17:06:54 volumio-kitchen kernel: PCI: bus1: Fast back to back transfers disabled Sep 17 17:06:54 volumio-kitchen kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:00:00.0: Max Payload Size set to 256/ 512 (was 128), Max Read Rq 512 Sep 17 17:06:54 volumio-kitchen kernel: pci 0000:01:00.0: Max Payload Size set to 256/ 256 (was 128), Max Read Rq 512 Sep 17 17:06:54 volumio-kitchen kernel: pcieport 0000:00:00.0: enabling device (0000 -> 0002) Sep 17 17:06:54 volumio-kitchen kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 45 Sep 17 17:06:54 volumio-kitchen kernel: bcm2708_fb soc:fb: FB found 1 display(s) Sep 17 17:06:54 volumio-kitchen kernel: Console: switching to colour frame buffer device 80x30 Sep 17 17:06:54 volumio-kitchen kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480 Sep 17 17:06:54 volumio-kitchen kernel: iproc-rng200 fe104000.rng: hwrng registered Sep 17 17:06:54 volumio-kitchen kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Sep 17 17:06:54 volumio-kitchen kernel: brd: module loaded Sep 17 17:06:54 volumio-kitchen kernel: loop: module loaded Sep 17 17:06:54 volumio-kitchen kernel: Loading iSCSI transport class v2.0-870. Sep 17 17:06:54 volumio-kitchen kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 Sep 17 17:06:54 volumio-kitchen kernel: Freeing initrd memory: 14316K Sep 17 17:06:54 volumio-kitchen kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus Sep 17 17:06:54 volumio-kitchen kernel: usbcore: registered new device driver r8152-cfgselector Sep 17 17:06:54 volumio-kitchen kernel: usbcore: registered new interface driver r8152 Sep 17 17:06:54 volumio-kitchen kernel: usbcore: registered new interface driver lan78xx Sep 17 17:06:54 volumio-kitchen kernel: usbcore: registered new interface driver smsc95xx Sep 17 17:06:54 volumio-kitchen kernel: xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142) Sep 17 17:06:54 volumio-kitchen kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Sep 17 17:06:54 volumio-kitchen kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 Sep 17 17:06:54 volumio-kitchen kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0f00040000000890 Sep 17 17:06:54 volumio-kitchen kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Sep 17 17:06:54 volumio-kitchen kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 Sep 17 17:06:54 volumio-kitchen kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed Sep 17 17:06:54 volumio-kitchen kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01 Sep 17 17:06:54 volumio-kitchen kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Sep 17 17:06:54 volumio-kitchen kernel: usb usb1: Product: xHCI Host Controller Sep 17 17:06:54 volumio-kitchen kernel: usb usb1: Manufacturer: Linux 6.1.69-v7l+ xhci-hcd Sep 17 17:06:54 volumio-kitchen kernel: usb usb1: SerialNumber: 0000:01:00.0 Sep 17 17:06:54 volumio-kitchen kernel: hub 1-0:1.0: USB hub found Sep 17 17:06:54 volumio-kitchen kernel: hub 1-0:1.0: 1 port detected Sep 17 17:06:54 volumio-kitchen kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01 Sep 17 17:06:54 volumio-kitchen kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Sep 17 17:06:54 volumio-kitchen kernel: usb usb2: Product: xHCI Host Controller Sep 17 17:06:54 volumio-kitchen kernel: usb usb2: Manufacturer: Linux 6.1.69-v7l+ xhci-hcd Sep 17 17:06:54 volumio-kitchen kernel: usb usb2: SerialNumber: 0000:01:00.0 Sep 17 17:06:54 volumio-kitchen kernel: hub 2-0:1.0: USB hub found Sep 17 17:06:54 volumio-kitchen kernel: hub 2-0:1.0: 4 ports detected Sep 17 17:06:54 volumio-kitchen kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Sep 17 17:06:54 volumio-kitchen kernel: dwc_otg: FIQ enabled Sep 17 17:06:54 volumio-kitchen kernel: dwc_otg: NAK holdoff enabled Sep 17 17:06:54 volumio-kitchen kernel: dwc_otg: FIQ split-transaction FSM enabled Sep 17 17:06:54 volumio-kitchen kernel: Module dwc_common_port init Sep 17 17:06:54 volumio-kitchen kernel: usbcore: registered new interface driver uas Sep 17 17:06:54 volumio-kitchen kernel: usbcore: registered new interface driver usb-storage Sep 17 17:06:54 volumio-kitchen kernel: mousedev: PS/2 mouse device common for all mice Sep 17 17:06:54 volumio-kitchen kernel: sdhci: Secure Digital Host Controller Interface driver Sep 17 17:06:54 volumio-kitchen kernel: sdhci: Copyright(c) Pierre Ossman Sep 17 17:06:54 volumio-kitchen kernel: sdhci-pltfm: SDHCI platform and OF driver helper Sep 17 17:06:54 volumio-kitchen kernel: ledtrig-cpu: registered to indicate activity on CPUs Sep 17 17:06:54 volumio-kitchen kernel: hid: raw HID events driver (C) Jiri Kosina Sep 17 17:06:54 volumio-kitchen kernel: usbcore: registered new interface driver usbhid Sep 17 17:06:54 volumio-kitchen kernel: usbhid: USB HID core driver Sep 17 17:06:54 volumio-kitchen kernel: Initializing XFRM netlink socket Sep 17 17:06:54 volumio-kitchen kernel: NET: Registered PF_PACKET protocol family Sep 17 17:06:54 volumio-kitchen kernel: Key type dns_resolver registered Sep 17 17:06:54 volumio-kitchen kernel: Registering SWP/SWPB emulation handler Sep 17 17:06:54 volumio-kitchen kernel: registered taskstats version 1 Sep 17 17:06:54 volumio-kitchen kernel: Loading compiled-in X.509 certificates Sep 17 17:06:54 volumio-kitchen kernel: Key type .fscrypt registered Sep 17 17:06:54 volumio-kitchen kernel: Key type fscrypt-provisioning registered Sep 17 17:06:54 volumio-kitchen kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Sep 17 17:06:54 volumio-kitchen kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Sep 17 17:06:54 volumio-kitchen kernel: fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 51, base_baud = 0) is a PL011 rev2 Sep 17 17:06:54 volumio-kitchen kernel: serial serial0: tty port ttyAMA1 registered Sep 17 17:06:54 volumio-kitchen kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Sep 17 17:06:54 volumio-kitchen kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Sep 17 17:06:54 volumio-kitchen kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Sep 17 17:06:54 volumio-kitchen kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Sep 17 17:06:54 volumio-kitchen kernel: of_cfs_init Sep 17 17:06:54 volumio-kitchen kernel: of_cfs_init: OK Sep 17 17:06:54 volumio-kitchen kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Sep 17 17:06:54 volumio-kitchen kernel: Freeing unused kernel image (initmem) memory: 2048K Sep 17 17:06:54 volumio-kitchen kernel: Run /init as init process Sep 17 17:06:54 volumio-kitchen kernel: with arguments: Sep 17 17:06:54 volumio-kitchen kernel: /init Sep 17 17:06:54 volumio-kitchen kernel: splash Sep 17 17:06:54 volumio-kitchen kernel: nodebug Sep 17 17:06:54 volumio-kitchen kernel: with environment: Sep 17 17:06:54 volumio-kitchen kernel: HOME=/ Sep 17 17:06:54 volumio-kitchen kernel: TERM=linux Sep 17 17:06:54 volumio-kitchen kernel: imgpart=UUID=634d688a-b96e-44c7-9dc6-4a37ca78c1a6 Sep 17 17:06:54 volumio-kitchen kernel: imgfile=/volumio_current.sqsh Sep 17 17:06:54 volumio-kitchen kernel: bootpart=UUID=DC0C-AF04 Sep 17 17:06:54 volumio-kitchen kernel: datapart=UUID=0bab8ffc-a6be-4cb1-bf2a-4f7cb7b6e7f1 Sep 17 17:06:54 volumio-kitchen kernel: uuidconfig=cmdline.txt Sep 17 17:06:54 volumio-kitchen kernel: pcie_aspm=off Sep 17 17:06:54 volumio-kitchen kernel: bootdelay=7 Sep 17 17:06:54 volumio-kitchen kernel: use_kmsg=no Sep 17 17:06:54 volumio-kitchen kernel: mmc1: new high speed SDIO card at address 0001 Sep 17 17:06:54 volumio-kitchen kernel: mmc0: new ultra high speed DDR50 SDHC card at address 59b4 Sep 17 17:06:54 volumio-kitchen kernel: mmcblk0: mmc0:59b4 USDU1 14.9 GiB Sep 17 17:06:54 volumio-kitchen kernel: mmcblk0: p1 p2 p3 Sep 17 17:06:54 volumio-kitchen kernel: mmcblk0: mmc0:59b4 USDU1 14.9 GiB Sep 17 17:06:54 volumio-kitchen kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Sep 17 17:06:54 volumio-kitchen kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Sep 17 17:06:54 volumio-kitchen kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Sep 17 17:06:54 volumio-kitchen kernel: usb 1-1: Product: USB2.0 Hub Sep 17 17:06:54 volumio-kitchen kernel: hub 1-1:1.0: USB hub found Sep 17 17:06:54 volumio-kitchen kernel: hub 1-1:1.0: 4 ports detected Sep 17 17:06:54 volumio-kitchen kernel: fuse: init (API version 7.37) Sep 17 17:06:54 volumio-kitchen kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 17 17:06:54 volumio-kitchen kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Sep 17 17:06:54 volumio-kitchen kernel: EXT4-fs (mmcblk0p2): recovery complete Sep 17 17:06:54 volumio-kitchen kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. Sep 17 17:06:54 volumio-kitchen kernel: loop0: detected capacity change from 0 to 983416 Sep 17 17:06:54 volumio-kitchen kernel: EXT4-fs (mmcblk0p3): recovery complete Sep 17 17:06:54 volumio-kitchen kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. Sep 17 17:06:54 volumio-kitchen systemd[1]: System time before build time, advancing clock. Sep 17 17:06:54 volumio-kitchen kernel: NET: Registered PF_INET6 protocol family Sep 17 17:06:54 volumio-kitchen kernel: Segment Routing with IPv6 Sep 17 17:06:54 volumio-kitchen kernel: In-situ OAM (IOAM) with IPv6 Sep 17 17:06:54 volumio-kitchen 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) Sep 17 17:06:54 volumio-kitchen systemd[1]: Detected architecture arm. Sep 17 17:06:54 volumio-kitchen systemd[1]: Set hostname to . Sep 17 17:06:54 volumio-kitchen 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. Sep 17 17:06:54 volumio-kitchen systemd[1]: Listening on fsck to fsckd communication Socket. Sep 17 17:06:54 volumio-kitchen systemd[1]: Listening on Journal Socket. Sep 17 17:06:54 volumio-kitchen systemd[1]: Mounting Kernel Debug File System... Sep 17 17:06:54 volumio-kitchen systemd[1]: Mounting POSIX Message Queue File System... Sep 17 17:06:54 volumio-kitchen systemd[1]: Starting Create list of required static device nodes for the current kernel... Sep 17 17:06:54 volumio-kitchen systemd[1]: Mounting RPC Pipe File System... Sep 17 17:06:54 volumio-kitchen kernel: i2c_dev: i2c /dev entries driver Sep 17 17:06:54 volumio-kitchen systemd-journald[318]: Journal started Sep 17 17:06:54 volumio-kitchen systemd-journald[318]: Runtime journal (/run/log/journal/d9a3e155a633914cdbe1662066e99934) is 3.7M, max 30.0M, 26.2M free. Sep 17 17:06:54 volumio-kitchen systemd-modules-load[316]: Inserted module 'i2c_dev' Sep 17 17:06:54 volumio-kitchen fake-hwclock[313]: Tue Sep 17 15:06:54 UTC 2024 Sep 17 17:06:54 volumio-kitchen systemd[1]: Started Load/Save Random Seed. Sep 17 17:06:54 volumio-kitchen systemd[1]: Started Create System Users. Sep 17 17:06:54 volumio-kitchen systemd[1]: Starting Create Static Device Nodes in /dev... Sep 17 17:06:54 volumio-kitchen systemd[1]: Started udev Coldplug all Devices. Sep 17 17:06:54 volumio-kitchen systemd[1]: Starting Helper to synchronize boot up for ifupdown... Sep 17 17:06:54 volumio-kitchen systemd[1]: Started Helper to synchronize boot up for ifupdown. Sep 17 17:06:54 volumio-kitchen systemd[1]: Started Create Static Device Nodes in /dev. Sep 17 17:06:54 volumio-kitchen systemd[1]: Reached target Local File Systems (Pre). Sep 17 17:06:54 volumio-kitchen systemd[1]: Mounting /var/spool/cups... Sep 17 17:06:54 volumio-kitchen systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Sep 17 17:06:54 volumio-kitchen systemd[1]: Mounting /tmp... Sep 17 17:06:54 volumio-kitchen systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Sep 17 17:06:54 volumio-kitchen systemd[1]: Mounting /var/log... Sep 17 17:06:54 volumio-kitchen systemd[1]: Starting udev Kernel Device Manager... Sep 17 17:06:54 volumio-kitchen systemd[1]: Mounted /var/spool/cups. Sep 17 17:06:54 volumio-kitchen systemd[1]: Mounted /tmp. Sep 17 17:06:54 volumio-kitchen systemd[1]: Mounted /var/log. Sep 17 17:06:54 volumio-kitchen systemd[1]: Starting Flush Journal to Persistent Storage... Sep 17 17:06:54 volumio-kitchen systemd[1]: Mounting /var/spool/cups/tmp... Sep 17 17:06:54 volumio-kitchen systemd[1]: Mounted /var/spool/cups/tmp. Sep 17 17:06:54 volumio-kitchen systemd-udevd[347]: Network interface NamePolicy= disabled on kernel command line, ignoring. Sep 17 17:06:54 volumio-kitchen systemd-journald[318]: Runtime journal (/run/log/journal/d9a3e155a633914cdbe1662066e99934) is 3.7M, max 30.0M, 26.2M free. Sep 17 17:06:54 volumio-kitchen systemd[1]: Started Flush Journal to Persistent Storage. Sep 17 17:06:54 volumio-kitchen systemd[1]: Started udev Kernel Device Manager. Sep 17 17:06:54 volumio-kitchen systemd[1]: Starting Show Plymouth Boot Screen... Sep 17 17:06:54 volumio-kitchen systemd[1]: plymouth-start.service: Succeeded. Sep 17 17:06:54 volumio-kitchen systemd[1]: Started Show Plymouth Boot Screen. Sep 17 17:06:54 volumio-kitchen systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Sep 17 17:06:54 volumio-kitchen systemd[1]: Reached target Local Encrypted Volumes. Sep 17 17:06:54 volumio-kitchen systemd[1]: Reached target Paths. Sep 17 17:06:54 volumio-kitchen systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Sep 17 17:06:55 volumio-kitchen kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Sep 17 17:06:55 volumio-kitchen kernel: mc: Linux media interface: v0.10 Sep 17 17:06:55 volumio-kitchen systemd-udevd[354]: Using default interface naming scheme 'v240'. Sep 17 17:06:55 volumio-kitchen kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Sep 17 17:06:55 volumio-kitchen kernel: [vc_sm_connected_init]: start Sep 17 17:06:55 volumio-kitchen kernel: [vc_sm_connected_init]: installed successfully Sep 17 17:06:55 volumio-kitchen systemd-udevd[354]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Sep 17 17:06:55 volumio-kitchen kernel: videodev: Linux video capture interface: v2.00 Sep 17 17:06:55 volumio-kitchen kernel: rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000 Sep 17 17:06:55 volumio-kitchen kernel: rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem Sep 17 17:06:55 volumio-kitchen kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Sep 17 17:06:55 volumio-kitchen kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Sep 17 17:06:55 volumio-kitchen kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Sep 17 17:06:55 volumio-kitchen kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Sep 17 17:06:55 volumio-kitchen kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Sep 17 17:06:55 volumio-kitchen kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Sep 17 17:06:55 volumio-kitchen kernel: rpivid feb10000.codec: Device registered as /dev/video19 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Sep 17 17:06:55 volumio-kitchen kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Sep 17 17:06:55 volumio-kitchen kernel: Bluetooth: Core ver 2.22 Sep 17 17:06:55 volumio-kitchen kernel: NET: Registered PF_BLUETOOTH protocol family Sep 17 17:06:55 volumio-kitchen kernel: Bluetooth: HCI device and connection manager initialized Sep 17 17:06:55 volumio-kitchen kernel: Bluetooth: HCI socket layer initialized Sep 17 17:06:55 volumio-kitchen kernel: Bluetooth: L2CAP socket layer initialized Sep 17 17:06:55 volumio-kitchen kernel: Bluetooth: SCO socket layer initialized Sep 17 17:06:55 volumio-kitchen kernel: Bluetooth: HCI UART driver ver 2.3 Sep 17 17:06:55 volumio-kitchen kernel: Bluetooth: HCI UART protocol H4 registered Sep 17 17:06:55 volumio-kitchen kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Sep 17 17:06:55 volumio-kitchen kernel: Bluetooth: HCI UART protocol Broadcom registered Sep 17 17:06:55 volumio-kitchen kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Sep 17 17:06:55 volumio-kitchen kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Sep 17 17:06:55 volumio-kitchen systemd[1]: Found device /dev/disk/by-uuid/DC0C-AF04. Sep 17 17:06:55 volumio-kitchen kernel: uart-pl011 fe201000.serial: no DMA platform data Sep 17 17:06:55 volumio-kitchen kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Sep 17 17:06:55 volumio-kitchen kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Sep 17 17:06:55 volumio-kitchen kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Sep 17 17:06:55 volumio-kitchen kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Sep 17 17:06:56 volumio-kitchen kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Sep 17 17:06:56 volumio-kitchen kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Sep 17 17:06:56 volumio-kitchen kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Sep 17 17:06:56 volumio-kitchen systemd[1]: Starting File System Check on /dev/disk/by-uuid/DC0C-AF04... Sep 17 17:06:56 volumio-kitchen kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Sep 17 17:06:56 volumio-kitchen kernel: Bluetooth: hci0: BCM: chip id 107 Sep 17 17:06:56 volumio-kitchen kernel: Bluetooth: hci0: BCM: features 0x2f Sep 17 17:06:56 volumio-kitchen kernel: Bluetooth: hci0: BCM4345C0 Sep 17 17:06:56 volumio-kitchen kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Sep 17 17:06:56 volumio-kitchen kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Sep 17 17:06:56 volumio-kitchen systemd-udevd[358]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Sep 17 17:06:56 volumio-kitchen kernel: snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517 Sep 17 17:06:56 volumio-kitchen systemd-fsck[454]: fsck.fat 4.1 (2017-01-24) Sep 17 17:06:56 volumio-kitchen systemd-fsck[454]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Sep 17 17:06:56 volumio-kitchen systemd-fsck[454]: Automatically removing dirty bit. Sep 17 17:06:56 volumio-kitchen systemd-fsck[454]: Performing changes. Sep 17 17:06:56 volumio-kitchen systemd-fsck[454]: /dev/mmcblk0p1: 378 files, 33709/46774 clusters Sep 17 17:06:56 volumio-kitchen kernel: snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517 Sep 17 17:06:56 volumio-kitchen systemd[1]: Started File System Check on /dev/disk/by-uuid/DC0C-AF04. Sep 17 17:06:56 volumio-kitchen kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Sep 17 17:06:56 volumio-kitchen kernel: snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517 Sep 17 17:06:56 volumio-kitchen kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Sep 17 17:06:56 volumio-kitchen kernel: usbcore: registered new interface driver brcmfmac Sep 17 17:06:56 volumio-kitchen kernel: snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517 Sep 17 17:06:56 volumio-kitchen kernel: pcm512x 1-004d: supply AVDD not found, using dummy regulator Sep 17 17:06:56 volumio-kitchen kernel: pcm512x 1-004d: supply DVDD not found, using dummy regulator Sep 17 17:06:56 volumio-kitchen kernel: pcm512x 1-004d: supply CPVDD not found, using dummy regulator Sep 17 17:06:56 volumio-kitchen 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 Sep 17 17:06:56 volumio-kitchen kernel: Bluetooth: hci0: BCM: features 0x2f Sep 17 17:06:56 volumio-kitchen kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Sep 17 17:06:56 volumio-kitchen kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Sep 17 17:06:56 volumio-kitchen systemd-udevd[351]: Using default interface naming scheme 'v240'. Sep 17 17:06:56 volumio-kitchen systemd-udevd[351]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Sep 17 17:06:57 volumio-kitchen systemd-udevd[366]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 0' failed with exit code 17. Sep 17 17:06:57 volumio-kitchen systemd-udevd[363]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 2' failed with exit code 99. Sep 17 17:06:57 volumio-kitchen systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Sep 17 17:06:57 volumio-kitchen systemd[1]: Created slice system-bthelper.slice. Sep 17 17:06:57 volumio-kitchen systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Sep 17 17:06:57 volumio-kitchen systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Sep 17 17:06:57 volumio-kitchen kernel: hwmon hwmon1: Undervoltage detected! Sep 17 17:06:57 volumio-kitchen systemd[1]: Starting Show Plymouth Boot Screen... Sep 17 17:06:57 volumio-kitchen systemd[1]: Condition check resulted in Huge Pages File System being skipped. Sep 17 17:06:57 volumio-kitchen systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Sep 17 17:06:57 volumio-kitchen systemd[1]: Mounting /boot... Sep 17 17:06:57 volumio-kitchen systemd[1]: Started File System Check Daemon to report status. Sep 17 17:06:57 volumio-kitchen systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Sep 17 17:06:57 volumio-kitchen systemd[1]: Mounted /boot. Sep 17 17:06:57 volumio-kitchen systemd[1]: plymouth-start.service: Succeeded. Sep 17 17:06:57 volumio-kitchen systemd[1]: Started Show Plymouth Boot Screen. Sep 17 17:06:57 volumio-kitchen systemd[1]: Starting Load/Save RF Kill Switch Status... Sep 17 17:06:57 volumio-kitchen systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Sep 17 17:06:57 volumio-kitchen systemd[1]: Reached target Local File Systems. Sep 17 17:06:57 volumio-kitchen systemd[1]: Starting Create Volatile Files and Directories... Sep 17 17:06:57 volumio-kitchen systemd[1]: Starting Preprocess NFS configuration... Sep 17 17:06:57 volumio-kitchen systemd[1]: Started ifup for eth0. Sep 17 17:06:57 volumio-kitchen systemd[1]: Starting Raise network interfaces... Sep 17 17:06:57 volumio-kitchen systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Sep 17 17:06:57 volumio-kitchen systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Sep 17 17:06:57 volumio-kitchen systemd[1]: Started ifup for wlan0. Sep 17 17:06:57 volumio-kitchen systemd[1]: plymouth-read-write.service: Succeeded. Sep 17 17:06:57 volumio-kitchen systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Sep 17 17:06:57 volumio-kitchen systemd[1]: Started Load/Save RF Kill Switch Status. Sep 17 17:06:57 volumio-kitchen systemd[1]: nfs-config.service: Succeeded. Sep 17 17:06:57 volumio-kitchen systemd[1]: Started Preprocess NFS configuration. Sep 17 17:06:57 volumio-kitchen systemd[1]: Received SIGRTMIN+20 from PID 207 (plymouthd). Sep 17 17:06:57 volumio-kitchen systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Sep 17 17:06:57 volumio-kitchen systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Sep 17 17:06:57 volumio-kitchen systemd[1]: Reached target NFS client services. Sep 17 17:06:58 volumio-kitchen systemd[1]: Started Create Volatile Files and Directories. Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting Update UTMP about System Boot/Shutdown... Sep 17 17:06:58 volumio-kitchen systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Sep 17 17:06:58 volumio-kitchen systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting RPC bind portmap service... Sep 17 17:06:58 volumio-kitchen systemd[1]: Started Update UTMP about System Boot/Shutdown. Sep 17 17:06:58 volumio-kitchen systemd[1]: Reached target System Initialization. Sep 17 17:06:58 volumio-kitchen kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 17 17:06:58 volumio-kitchen systemd[1]: Listening on D-Bus System Message Bus Socket. Sep 17 17:06:58 volumio-kitchen systemd[1]: Listening on triggerhappy.socket. Sep 17 17:06:58 volumio-kitchen systemd[1]: apt-daily.timer: Not using persistent file timestamp Tue 2024-11-26 14:37:06 CET as it is in the future. Sep 17 17:06:58 volumio-kitchen systemd[1]: Started Daily apt download activities. Sep 17 17:06:58 volumio-kitchen systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Tue 2024-11-26 14:37:06 CET as it is in the future. Sep 17 17:06:58 volumio-kitchen systemd[1]: Started Daily apt upgrade and clean activities. Sep 17 17:06:58 volumio-kitchen systemd[1]: Started Daily Cleanup of Temporary Directories. Sep 17 17:06:58 volumio-kitchen systemd[1]: Reached target Timers. Sep 17 17:06:58 volumio-kitchen systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Sep 17 17:06:58 volumio-kitchen systemd[1]: Reached target Sockets. Sep 17 17:06:58 volumio-kitchen systemd[1]: Reached target Basic System. Sep 17 17:06:58 volumio-kitchen systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Sep 17 17:06:58 volumio-kitchen kernel: 8021q: 802.1Q VLAN Support v1.8 Sep 17 17:06:58 volumio-kitchen systemd[1]: Started D-Bus System Message Bus. Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting Configure Bluetooth Modems connected by UART... Sep 17 17:06:58 volumio-kitchen systemd[1]: Started Volumio Log Rotation Service. Sep 17 17:06:58 volumio-kitchen systemd[1]: Started Manage Sound Card State (restore and store). Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting Save/Restore Sound Card State... Sep 17 17:06:58 volumio-kitchen alsactl[622]: alsactl 1.1.8 daemon started Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting Login Service... Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting Wireless Services... Sep 17 17:06:58 volumio-kitchen systemd[1]: Started UPnP Renderer front-end to MPD. Sep 17 17:06:58 volumio-kitchen avahi-daemon[617]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Sep 17 17:06:58 volumio-kitchen avahi-daemon[617]: Successfully dropped root privileges. Sep 17 17:06:58 volumio-kitchen alsactl[628]: No state is present for card b1 Sep 17 17:06:58 volumio-kitchen alsactl[628]: /usr/share/alsa/init/bcm2835:14: control element not found Sep 17 17:06:58 volumio-kitchen alsactl[628]: No state is present for card b1 Sep 17 17:06:58 volumio-kitchen alsactl[628]: No state is present for card Headphones Sep 17 17:06:58 volumio-kitchen avahi-daemon[617]: avahi-daemon 0.7 starting up. Sep 17 17:06:58 volumio-kitchen alsactl[628]: /usr/share/alsa/init/bcm2835:20: control element not found Sep 17 17:06:58 volumio-kitchen alsactl[628]: No state is present for card Headphones Sep 17 17:06:58 volumio-kitchen alsactl[628]: No state is present for card BossDAC Sep 17 17:06:58 volumio-kitchen alsactl[628]: Found hardware: "BossDAC" "" "" "" "" Sep 17 17:06:58 volumio-kitchen alsactl[628]: Hardware is initialized using a generic method Sep 17 17:06:58 volumio-kitchen alsactl[628]: No state is present for card BossDAC Sep 17 17:06:58 volumio-kitchen alsactl[622]: No state is present for card b1 Sep 17 17:06:58 volumio-kitchen alsactl[622]: /usr/share/alsa/init/bcm2835:14: control element not found Sep 17 17:06:58 volumio-kitchen alsactl[622]: No state is present for card b1 Sep 17 17:06:58 volumio-kitchen alsactl[622]: No state is present for card Headphones Sep 17 17:06:58 volumio-kitchen alsactl[622]: /usr/share/alsa/init/bcm2835:20: control element not found Sep 17 17:06:58 volumio-kitchen alsactl[622]: No state is present for card Headphones Sep 17 17:06:58 volumio-kitchen alsactl[622]: No state is present for card BossDAC Sep 17 17:06:58 volumio-kitchen alsactl[622]: Found hardware: "BossDAC" "" "" "" "" Sep 17 17:06:58 volumio-kitchen alsactl[622]: Hardware is initialized using a generic method Sep 17 17:06:58 volumio-kitchen alsactl[622]: No state is present for card BossDAC Sep 17 17:06:58 volumio-kitchen systemd[1]: Started Volumio Iptables Module. Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting triggerhappy global hotkey daemon... Sep 17 17:06:58 volumio-kitchen kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Sep 17 17:06:58 volumio-kitchen kernel: bcmgenet fd580000.ethernet eth0: Link is Down Sep 17 17:06:58 volumio-kitchen sh[519]: eth0: waiting for carrier Sep 17 17:06:58 volumio-kitchen systemd[1]: Started volumio-remote-updater.service. Sep 17 17:06:58 volumio-kitchen dhcpcd[566]: eth0: waiting for carrier Sep 17 17:06:58 volumio-kitchen systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting WPA supplicant... Sep 17 17:06:58 volumio-kitchen systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting dhcpcd on all interfaces... Sep 17 17:06:58 volumio-kitchen systemd[1]: Started RPC bind portmap service. Sep 17 17:06:58 volumio-kitchen systemd[1]: hciuart.service: Succeeded. Sep 17 17:06:58 volumio-kitchen systemd[1]: Started Configure Bluetooth Modems connected by UART. Sep 17 17:06:58 volumio-kitchen systemd[1]: Started Save/Restore Sound Card State. Sep 17 17:06:58 volumio-kitchen systemd-logind[629]: New seat seat0. Sep 17 17:06:58 volumio-kitchen dhcpcd[646]: Not running dhcpcd because /etc/network/interfaces Sep 17 17:06:58 volumio-kitchen dhcpcd[646]: defines some interfaces that will use a Sep 17 17:06:58 volumio-kitchen dhcpcd[646]: DHCP client or static address Sep 17 17:06:58 volumio-kitchen thd[643]: Unable to parse trigger line: Sep 17 17:06:58 volumio-kitchen thd[643]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Sep 17 17:06:58 volumio-kitchen thd[643]: Unable to parse trigger line: Sep 17 17:06:58 volumio-kitchen thd[643]: Found socket passed from systemd Sep 17 17:06:58 volumio-kitchen systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Sep 17 17:06:58 volumio-kitchen systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Sep 17 17:06:58 volumio-kitchen systemd[1]: Failed to start dhcpcd on all interfaces. Sep 17 17:06:58 volumio-kitchen systemd[1]: Started triggerhappy global hotkey daemon. Sep 17 17:06:58 volumio-kitchen systemd[1]: Reached target Sound Card. Sep 17 17:06:58 volumio-kitchen sh[524]: wlan0=wlan0 Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting Raspberry Pi bluetooth helper... Sep 17 17:06:58 volumio-kitchen systemd[1]: Reached target RPC Port Mapper. Sep 17 17:06:58 volumio-kitchen systemd[1]: Reached target Remote File Systems (Pre). Sep 17 17:06:58 volumio-kitchen systemd[1]: Reached target Remote File Systems. Sep 17 17:06:58 volumio-kitchen systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Sep 17 17:06:59 volumio-kitchen dbus-daemon[594]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 17 17:06:59 volumio-kitchen systemd[1]: Started Login Service. Sep 17 17:06:59 volumio-kitchen avahi-daemon[617]: Successfully called chroot(). Sep 17 17:06:59 volumio-kitchen avahi-daemon[617]: Successfully dropped remaining capabilities. Sep 17 17:06:59 volumio-kitchen systemd[1]: Started Avahi mDNS/DNS-SD Stack. Sep 17 17:06:59 volumio-kitchen avahi-daemon[617]: Loading service file /services/volumio.service. Sep 17 17:06:59 volumio-kitchen avahi-daemon[617]: Network interface enumeration completed. Sep 17 17:06:59 volumio-kitchen avahi-daemon[617]: Server startup complete. Host name is volumio-kitchen.local. Local service cookie is 1715664333. Sep 17 17:06:59 volumio-kitchen avahi-daemon[617]: Service "Volumio Kitchen" (/services/volumio.service) successfully established. Sep 17 17:06:59 volumio-kitchen systemd[1]: Started Raise network interfaces. Sep 17 17:06:59 volumio-kitchen bthelper[664]: Raspberry Pi BDADDR already set Sep 17 17:06:59 volumio-kitchen wpa_supplicant[645]: Successfully initialized wpa_supplicant Sep 17 17:06:59 volumio-kitchen systemd[1]: Started Raspberry Pi bluetooth helper. Sep 17 17:06:59 volumio-kitchen systemd[1]: Started WPA supplicant. Sep 17 17:06:59 volumio-kitchen systemd[1]: Reached target Network. Sep 17 17:06:59 volumio-kitchen systemd[1]: Starting Network Time Service... Sep 17 17:06:59 volumio-kitchen systemd[1]: Reached target Network is Online. Sep 17 17:06:59 volumio-kitchen systemd[1]: Starting LSB: Brings up/down network automatically... Sep 17 17:06:59 volumio-kitchen systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Sep 17 17:06:59 volumio-kitchen systemd[1]: Starting /etc/rc.local Compatibility... Sep 17 17:06:59 volumio-kitchen systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 17 17:06:59 volumio-kitchen systemd[1]: Starting Samba NMB Daemon... Sep 17 17:06:59 volumio-kitchen systemd[1]: Starting Permit User Sessions... Sep 17 17:06:59 volumio-kitchen systemd[1]: Starting Bluetooth service... Sep 17 17:06:59 volumio-kitchen systemd[1]: Started /etc/rc.local Compatibility. Sep 17 17:06:59 volumio-kitchen kernel: hwmon hwmon1: Voltage normalised Sep 17 17:06:59 volumio-kitchen systemd[1]: Started Permit User Sessions. Sep 17 17:06:59 volumio-kitchen systemd[1]: Starting Terminate Plymouth Boot Screen... Sep 17 17:06:59 volumio-kitchen systemd[1]: Starting Hold until boot process finishes up... Sep 17 17:06:59 volumio-kitchen systemd[1]: Received SIGRTMIN+21 from PID 207 (plymouthd). Sep 17 17:07:00 volumio-kitchen systemd[1]: plymouth-quit.service: Succeeded. Sep 17 17:07:00 volumio-kitchen systemd[1]: Started Terminate Plymouth Boot Screen. Sep 17 17:07:00 volumio-kitchen systemd[1]: plymouth-quit-wait.service: Succeeded. Sep 17 17:07:00 volumio-kitchen systemd[1]: Started Hold until boot process finishes up. Sep 17 17:07:00 volumio-kitchen systemd[1]: Received SIGRTMIN+21 from PID 207 (n/a). Sep 17 17:07:00 volumio-kitchen ntpd[701]: ntpd 4.2.8p12@1.3728-o (1): Starting Sep 17 17:07:00 volumio-kitchen ntpd[701]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Sep 17 17:07:00 volumio-kitchen loadcpufreq[672]: Loading cpufreq kernel modules...done (none). Sep 17 17:07:00 volumio-kitchen systemd[1]: Started Getty on tty1. Sep 17 17:07:00 volumio-kitchen systemd[1]: Reached target Login Prompts. Sep 17 17:07:00 volumio-kitchen systemd[1]: Started Network Time Service. Sep 17 17:07:00 volumio-kitchen systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Sep 17 17:07:00 volumio-kitchen ntpd[752]: proto: precision = 2.111 usec (-19) Sep 17 17:07:00 volumio-kitchen systemd[1]: Starting LSB: set CPUFreq kernel parameters... Sep 17 17:07:00 volumio-kitchen ifplugd(eth0)[760]: ifplugd 0.28 initializing. Sep 17 17:07:00 volumio-kitchen ifplugd(eth0)[760]: Using interface eth0/DC:A6:32:AD:76:19 with driver (version: 6.1.69-v7l+) Sep 17 17:07:00 volumio-kitchen ifplugd(eth0)[760]: Using detection mode: SIOCETHTOOL Sep 17 17:07:00 volumio-kitchen ifplugd(eth0)[760]: Initialization complete, link beat not detected. Sep 17 17:07:00 volumio-kitchen ntpd[752]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Sep 17 17:07:00 volumio-kitchen ntpd[752]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Sep 17 17:07:00 volumio-kitchen ntpd[752]: Listen and drop on 0 v6wildcard [::]:123 Sep 17 17:07:00 volumio-kitchen ntpd[752]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 17 17:07:00 volumio-kitchen ntpd[752]: Listen normally on 2 lo 127.0.0.1:123 Sep 17 17:07:00 volumio-kitchen ifplugd[705]: Network Interface Plugging Daemon...start eth0...done. Sep 17 17:07:00 volumio-kitchen ntpd[752]: Listening on routing socket on fd #19 for interface updates Sep 17 17:07:00 volumio-kitchen ntpd[752]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 17 17:07:00 volumio-kitchen ntpd[752]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 17 17:07:00 volumio-kitchen systemd[1]: Started LSB: Brings up/down network automatically. Sep 17 17:07:00 volumio-kitchen bluetoothd[714]: Bluetooth daemon 5.50 Sep 17 17:07:00 volumio-kitchen bluetoothd[714]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Sep 17 17:07:00 volumio-kitchen systemd[1]: Started Bluetooth service. Sep 17 17:07:00 volumio-kitchen bluetoothd[714]: Starting SDP server Sep 17 17:07:00 volumio-kitchen bluetoothd[714]: Excluding (cli) sap Sep 17 17:07:00 volumio-kitchen systemd[1]: Reached target Bluetooth. Sep 17 17:07:00 volumio-kitchen volumio-remote-updater[644]: Error: No active session Sep 17 17:07:00 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:00] [info] asio async_connect error: system:111 (Connection refused) Sep 17 17:07:00 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 17 17:07:00 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:00] [error] handle_connect error: Underlying Transport Error Sep 17 17:07:00 volumio-kitchen cpufrequtils[757]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Sep 17 17:07:00 volumio-kitchen systemd[1]: Started LSB: set CPUFreq kernel parameters. Sep 17 17:07:00 volumio-kitchen kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Sep 17 17:07:00 volumio-kitchen kernel: Bluetooth: BNEP filters: protocol multicast Sep 17 17:07:00 volumio-kitchen kernel: Bluetooth: BNEP socket layer initialized Sep 17 17:07:00 volumio-kitchen dbus-daemon[594]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=714 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Sep 17 17:07:00 volumio-kitchen volumio[639]: Could not open config: /tmp/upmpdcli.conf Sep 17 17:07:00 volumio-kitchen bluetoothd[714]: Bluetooth management interface 1.22 initialized Sep 17 17:07:00 volumio-kitchen kernel: Bluetooth: MGMT ver 1.22 Sep 17 17:07:00 volumio-kitchen bluetoothd[714]: Failed to set privacy: Rejected (0x0b) Sep 17 17:07:00 volumio-kitchen systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Sep 17 17:07:00 volumio-kitchen systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Sep 17 17:07:00 volumio-kitchen systemd[1]: Starting Hostname Service... Sep 17 17:07:00 volumio-kitchen systemd[1]: iptables.service: Succeeded. Sep 17 17:07:01 volumio-kitchen dbus-daemon[594]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 17 17:07:01 volumio-kitchen systemd[1]: Started Hostname Service. Sep 17 17:07:01 volumio-kitchen ntpd[752]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Sep 17 17:07:01 volumio-kitchen nmbd[716]: [2024/09/17 17:07:01.616323, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Sep 17 17:07:01 volumio-kitchen nmbd[716]: started asyncdns process 788 Sep 17 17:07:01 volumio-kitchen nmbd[716]: [2024/09/17 17:07:01.619698, 0] ../lib/util/become_daemon.c:149(daemon_status) Sep 17 17:07:01 volumio-kitchen nmbd[716]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Sep 17 17:07:01 volumio-kitchen nmbd[716]: [2024/09/17 17:07:01.619946, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Sep 17 17:07:01 volumio-kitchen nmbd[716]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Sep 17 17:07:01 volumio-kitchen kernel: hwmon hwmon1: Undervoltage detected! Sep 17 17:07:01 volumio-kitchen haveged[571]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Sep 17 17:07:01 volumio-kitchen haveged[571]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Sep 17 17:07:01 volumio-kitchen haveged[571]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00089 Sep 17 17:07:01 volumio-kitchen haveged[571]: haveged: fills: 0, generated: 0 Sep 17 17:07:02 volumio-kitchen ntpd[752]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Sep 17 17:07:02 volumio-kitchen wireless.js[633]: Cleaning previous... Sep 17 17:07:02 volumio-kitchen sudo[796]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 17 17:07:02 volumio-kitchen sudo[796]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:02 volumio-kitchen sudo[796]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:02 volumio-kitchen sudo[798]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Sep 17 17:07:02 volumio-kitchen sudo[798]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:02 volumio-kitchen systemd[1]: systemd-rfkill.service: Succeeded. Sep 17 17:07:03 volumio-kitchen ntpd[752]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Sep 17 17:07:03 volumio-kitchen sudo[798]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:03 volumio-kitchen wireless.js[633]: Stopped aP Sep 17 17:07:03 volumio-kitchen sudo[805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 17 17:07:03 volumio-kitchen sudo[805]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:03 volumio-kitchen sudo[805]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:03 volumio-kitchen kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 17 17:07:03 volumio-kitchen sudo[807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Sep 17 17:07:03 volumio-kitchen sudo[807]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:03 volumio-kitchen sudo[807]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:03 volumio-kitchen sudo[814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 17 17:07:03 volumio-kitchen sudo[814]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:03 volumio-kitchen sudo[814]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:03 volumio-kitchen sudo[816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Sep 17 17:07:03 volumio-kitchen sudo[816]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:04 volumio-kitchen ntpd[752]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Sep 17 17:07:04 volumio-kitchen bthelper[664]: Changing power off succeeded Sep 17 17:07:04 volumio-kitchen bthelper[664]: [CHG] Controller DC:A6:32:AD:76:1B Powered: no Sep 17 17:07:04 volumio-kitchen bthelper[664]: [CHG] Controller DC:A6:32:AD:76:1B Discovering: no Sep 17 17:07:04 volumio-kitchen bthelper[664]: [CHG] Controller DC:A6:32:AD:76:1B Class: 0x00000000 Sep 17 17:07:04 volumio-kitchen bthelper[664]: [CHG] Controller DC:A6:32:AD:76:1B Class: 0x0000041c Sep 17 17:07:04 volumio-kitchen bthelper[664]: Changing power on succeeded Sep 17 17:07:05 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:05] [info] asio async_connect error: system:111 (Connection refused) Sep 17 17:07:05 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:05] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 17 17:07:05 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:05] [error] handle_connect error: Underlying Transport Error Sep 17 17:07:05 volumio-kitchen sudo[816]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:05 volumio-kitchen wireless.js[633]: SETTING APPROPRIATE REG DOMAIN: DE Sep 17 17:07:05 volumio-kitchen sudo[827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 17 17:07:05 volumio-kitchen sudo[827]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:05 volumio-kitchen sudo[827]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:05 volumio-kitchen sudo[829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Sep 17 17:07:05 volumio-kitchen sudo[829]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:05 volumio-kitchen sudo[829]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:05 volumio-kitchen wireless.js[633]: SUCCESSFULLY SET NEW REGDOMAIN: DE Sep 17 17:07:05 volumio-kitchen wireless.js[633]: Start wireless flow Sep 17 17:07:05 volumio-kitchen wireless.js[633]: Stopped hotspot (if there).. Sep 17 17:07:05 volumio-kitchen sudo[834]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 17 17:07:05 volumio-kitchen sudo[834]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:05 volumio-kitchen sudo[834]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:05 volumio-kitchen sudo[836]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Sep 17 17:07:05 volumio-kitchen sudo[836]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:06 volumio-kitchen sudo[836]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:06 volumio-kitchen wireless.js[633]: DHCP IP Sep 17 17:07:06 volumio-kitchen wireless.js[633]: Start ap Sep 17 17:07:06 volumio-kitchen wpa_supplicant[838]: Successfully initialized wpa_supplicant Sep 17 17:07:06 volumio-kitchen sudo[839]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Sep 17 17:07:06 volumio-kitchen sudo[839]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:06 volumio-kitchen kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 17 17:07:06 volumio-kitchen dhcpcd[840]: dev: loaded udev Sep 17 17:07:06 volumio-kitchen dhcpcd-run-hooks[858]: wlan0: starting wpa_supplicant Sep 17 17:07:06 volumio-kitchen dhcpcd-run-hooks[863]: wlan0: failed to start wpa_supplicant Sep 17 17:07:06 volumio-kitchen dhcpcd-run-hooks[864]: 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 Sep 17 17:07:06 volumio-kitchen dhcpcd[840]: wlan0: connected to Access Point `' Sep 17 17:07:06 volumio-kitchen dhcpcd[840]: no interfaces have a carrier Sep 17 17:07:06 volumio-kitchen dhcpcd[840]: forked to background, child pid 874 Sep 17 17:07:06 volumio-kitchen dhcpcd[874]: eth0: waiting for carrier Sep 17 17:07:06 volumio-kitchen dhcpcd[874]: wlan0: waiting for carrier Sep 17 17:07:06 volumio-kitchen sudo[839]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:07 volumio-kitchen wireless.js[633]: trying... Sep 17 17:07:07 volumio-kitchen sudo[876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 17:07:07 volumio-kitchen sudo[876]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:07 volumio-kitchen sudo[876]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:08 volumio-kitchen wireless.js[633]: trying... Sep 17 17:07:08 volumio-kitchen sudo[879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 17:07:08 volumio-kitchen sudo[879]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:08 volumio-kitchen sudo[879]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:09 volumio-kitchen wpa_supplicant[862]: wlan0: Trying to associate with SSID 'Y&B-2GHz' Sep 17 17:07:09 volumio-kitchen wireless.js[633]: trying... Sep 17 17:07:09 volumio-kitchen sudo[882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 17:07:09 volumio-kitchen sudo[882]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:09 volumio-kitchen sudo[882]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:10 volumio-kitchen wireless.js[633]: trying... Sep 17 17:07:10 volumio-kitchen sudo[885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 17:07:10 volumio-kitchen sudo[885]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:10 volumio-kitchen sudo[885]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:11 volumio-kitchen wireless.js[633]: trying... Sep 17 17:07:11 volumio-kitchen sudo[888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 17:07:11 volumio-kitchen sudo[888]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:11 volumio-kitchen sudo[888]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:11 volumio-kitchen dhcpcd[874]: wlan0: carrier acquired Sep 17 17:07:11 volumio-kitchen dhcpcd[874]: wlan0: connected to Access Point `Y&B-2GHz' Sep 17 17:07:11 volumio-kitchen wpa_supplicant[862]: wlan0: Associated with ec:6c:9a:62:e7:9c Sep 17 17:07:11 volumio-kitchen wpa_supplicant[862]: wlan0: CTRL-EVENT-CONNECTED - Connection to ec:6c:9a:62:e7:9c completed [id=0 id_str=] Sep 17 17:07:11 volumio-kitchen wpa_supplicant[862]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Sep 17 17:07:11 volumio-kitchen dhcpcd[874]: DUID 00:01:00:01:2e:7c:59:28:dc:a6:32:ad:76:1a Sep 17 17:07:11 volumio-kitchen dhcpcd[874]: wlan0: IAID 32:ad:76:1a Sep 17 17:07:11 volumio-kitchen dhcpcd[874]: wlan0: adding address fe80::8efc:c59a:ad99:2dc8 Sep 17 17:07:11 volumio-kitchen dhcpcd[874]: ipv6_addaddr1: Permission denied Sep 17 17:07:11 volumio-kitchen dhcpcd[874]: wlan0: carrier lost Sep 17 17:07:11 volumio-kitchen dhcpcd[874]: wlan0: carrier acquired Sep 17 17:07:11 volumio-kitchen dhcpcd[874]: wlan0: IAID 32:ad:76:1a Sep 17 17:07:12 volumio-kitchen dhcpcd[874]: wlan0: soliciting an IPv6 router Sep 17 17:07:12 volumio-kitchen dhcpcd[874]: wlan0: rebinding lease of 192.168.1.36 Sep 17 17:07:12 volumio-kitchen wireless.js[633]: trying... Sep 17 17:07:12 volumio-kitchen sudo[903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 17:07:12 volumio-kitchen sudo[903]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:12 volumio-kitchen sudo[903]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:12 volumio-kitchen dhcpcd[874]: wlan0: probing address 192.168.1.36/24 Sep 17 17:07:13 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:13] [info] asio async_connect error: system:111 (Connection refused) Sep 17 17:07:13 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:13] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 17 17:07:13 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:13] [error] handle_connect error: Underlying Transport Error Sep 17 17:07:13 volumio-kitchen wireless.js[633]: trying... Sep 17 17:07:13 volumio-kitchen sudo[906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 17:07:13 volumio-kitchen sudo[906]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:13 volumio-kitchen sudo[906]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:14 volumio-kitchen wireless.js[633]: trying... Sep 17 17:07:14 volumio-kitchen sudo[909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 17:07:14 volumio-kitchen sudo[909]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:14 volumio-kitchen sudo[909]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:15 volumio-kitchen wireless.js[633]: trying... Sep 17 17:07:15 volumio-kitchen sudo[912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 17:07:15 volumio-kitchen sudo[912]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:15 volumio-kitchen sudo[912]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:16 volumio-kitchen kernel: hwmon hwmon1: Voltage normalised Sep 17 17:07:16 volumio-kitchen wireless.js[633]: trying... Sep 17 17:07:16 volumio-kitchen sudo[916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 17:07:16 volumio-kitchen sudo[916]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:16 volumio-kitchen sudo[916]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:17 volumio-kitchen dhcpcd[874]: wlan0: leased 192.168.1.36 for 86400 seconds Sep 17 17:07:17 volumio-kitchen avahi-daemon[617]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.36. Sep 17 17:07:17 volumio-kitchen dhcpcd[874]: wlan0: adding route to 192.168.1.0/24 Sep 17 17:07:17 volumio-kitchen avahi-daemon[617]: New relevant interface wlan0.IPv4 for mDNS. Sep 17 17:07:17 volumio-kitchen dhcpcd[874]: wlan0: adding default route via 192.168.1.1 Sep 17 17:07:17 volumio-kitchen avahi-daemon[617]: Registering new address record for 192.168.1.36 on wlan0.IPv4. Sep 17 17:07:17 volumio-kitchen wireless.js[633]: trying... Sep 17 17:07:17 volumio-kitchen sudo[939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 17:07:17 volumio-kitchen sudo[939]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:17 volumio-kitchen sudo[939]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:17 volumio-kitchen wireless.js[633]: Connected to: ----Y&B-2GHz Sep 17 17:07:17 volumio-kitchen wireless.js[633]: ---- Sep 17 17:07:17 volumio-kitchen sudo[942]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 17:07:17 volumio-kitchen sudo[942]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:17 volumio-kitchen sudo[942]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:17 volumio-kitchen wireless.js[633]: ... joined AP, wlan0 IPv4 is 192.168.1.36, ipV6 is undefined Sep 17 17:07:17 volumio-kitchen wireless.js[633]: It's done! AP Sep 17 17:07:17 volumio-kitchen kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 17 17:07:17 volumio-kitchen systemd[1]: Started Wireless Services. Sep 17 17:07:17 volumio-kitchen systemd[1]: Started Volumio Backend Module. Sep 17 17:07:17 volumio-kitchen systemd[1]: Started Volumio Cpu Tweaker. Sep 17 17:07:17 volumio-kitchen volumio-cpu-tweak[948]: Setting RT Priority for mpd Sep 17 17:07:17 volumio-kitchen volumio-cpu-tweak[948]: pid 35's current scheduling policy: SCHED_OTHER Sep 17 17:07:17 volumio-kitchen volumio-cpu-tweak[948]: pid 35's current scheduling priority: 0 Sep 17 17:07:17 volumio-kitchen volumio-cpu-tweak[948]: Setting MPD Affinity Sep 17 17:07:17 volumio-kitchen volumio-cpu-tweak[948]: pid 3's current affinity mask: f Sep 17 17:07:17 volumio-kitchen volumio-cpu-tweak[948]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Sep 17 17:07:17 volumio-kitchen volumio-cpu-tweak[948]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Sep 17 17:07:17 volumio-kitchen systemd[1]: volumio_cpu_tweak.service: Succeeded. Sep 17 17:07:18 volumio-kitchen kernel: hwmon hwmon1: Undervoltage detected! Sep 17 17:07:19 volumio-kitchen ntpd[752]: Listen normally on 3 wlan0 192.168.1.36:123 Sep 17 17:07:19 volumio-kitchen ntpd[752]: new interface(s) found: waking up resolver Sep 17 17:07:21 volumio-kitchen volumio[947]: info: ------------------------------------------- Sep 17 17:07:21 volumio-kitchen volumio[947]: info: ----- Volumio3 ---- Sep 17 17:07:21 volumio-kitchen volumio[947]: info: ------------------------------------------- Sep 17 17:07:21 volumio-kitchen volumio[947]: info: ----- System startup ---- Sep 17 17:07:21 volumio-kitchen volumio[947]: info: ------------------------------------------- Sep 17 17:07:21 volumio-kitchen systemd[1]: Started Samba NMB Daemon. Sep 17 17:07:21 volumio-kitchen nmbd[716]: [2024/09/17 17:07:21.634216, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 17 17:07:21 volumio-kitchen nmbd[716]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Sep 17 17:07:21 volumio-kitchen systemd[1]: Starting Samba Winbind Daemon... Sep 17 17:07:22 volumio-kitchen winbindd[972]: [2024/09/17 17:07:22.191704, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Sep 17 17:07:22 volumio-kitchen winbindd[972]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Sep 17 17:07:22 volumio-kitchen winbindd[972]: [2024/09/17 17:07:22.220441, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 17 17:07:22 volumio-kitchen winbindd[972]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Sep 17 17:07:22 volumio-kitchen systemd[1]: Started Samba Winbind Daemon. Sep 17 17:07:22 volumio-kitchen systemd[1]: Starting Samba SMB Daemon... Sep 17 17:07:22 volumio-kitchen volumio[947]: info: MYVOLUMIO Environment detected Sep 17 17:07:23 volumio-kitchen winbindd[972]: [2024/09/17 17:07:23.004135, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Sep 17 17:07:23 volumio-kitchen winbindd[972]: res_names->count = 3, expected 5 Sep 17 17:07:23 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:23] [connect] Successful connection Sep 17 17:07:23 volumio-kitchen smbd[977]: [2024/09/17 17:07:23.050692, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 17 17:07:23 volumio-kitchen systemd[1]: Started Samba SMB Daemon. Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Plugin folders cleanup Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Scanning into folder /volumio/app/plugins/ Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Scanning category audio_interface Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Scanning category miscellanea Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Scanning category music_service Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Scanning category plugins.json Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Scanning category system_controller Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Scanning category user_interface Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Scanning into folder /data/plugins/ Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Scanning category audio_interface Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Scanning category music_service Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Plugin folders cleanup completed Sep 17 17:07:23 volumio-kitchen volumio[947]: info: ------------------------------------------- Sep 17 17:07:23 volumio-kitchen volumio[947]: info: ----- Core plugins startup ---- Sep 17 17:07:23 volumio-kitchen volumio[947]: info: ------------------------------------------- Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Loading plugins from folder /volumio/app/plugins/ Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Adding plugin upnp to MyMusic Plugins Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Loading plugins from folder /data/plugins/ Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Loading plugin "system"... Sep 17 17:07:23 volumio-kitchen smbd[977]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Sep 17 17:07:23 volumio-kitchen systemd[1]: Reached target Multi-User System. Sep 17 17:07:23 volumio-kitchen systemd[1]: Reached target Graphical Interface. Sep 17 17:07:23 volumio-kitchen systemd[1]: Starting Update UTMP about System Runlevel Changes... Sep 17 17:07:23 volumio-kitchen volumio[947]: info: Loading plugin "appearance"... Sep 17 17:07:23 volumio-kitchen systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Sep 17 17:07:23 volumio-kitchen systemd[1]: Started Update UTMP about System Runlevel Changes. Sep 17 17:07:23 volumio-kitchen systemd[1]: Startup finished in 15.511s (kernel) + 30.929s (userspace) = 46.441s. Sep 17 17:07:24 volumio-kitchen volumio[947]: info: Loading plugin "network"... Sep 17 17:07:24 volumio-kitchen volumio[947]: info: Refreshing Cached IP Addresses Sep 17 17:07:24 volumio-kitchen sudo[992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 17 17:07:24 volumio-kitchen sudo[992]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:24 volumio-kitchen sudo[992]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:24 volumio-kitchen sudo[994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 17:07:24 volumio-kitchen sudo[994]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:24 volumio-kitchen volumio[947]: info: Loading plugin "services"... Sep 17 17:07:24 volumio-kitchen sudo[994]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:24 volumio-kitchen volumio[947]: info: Loading plugin "alsa_controller"... Sep 17 17:07:24 volumio-kitchen sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 17 17:07:24 volumio-kitchen sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:24 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 17 17:07:24 volumio-kitchen volumio[947]: info: Loading plugin "wizard"... Sep 17 17:07:24 volumio-kitchen volumio[947]: info: Loading plugin "networkfs"... Sep 17 17:07:25 volumio-kitchen volumio[947]: info: Starting Udev Watcher for removable devices Sep 17 17:07:25 volumio-kitchen sudo[1003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.35/USB /mnt/NAS/USB Sep 17 17:07:25 volumio-kitchen sudo[1003]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:25 volumio-kitchen volumio[947]: info: Ignoring mount for partition: boot Sep 17 17:07:25 volumio-kitchen volumio[947]: info: Ignoring mount for partition: volumio Sep 17 17:07:25 volumio-kitchen volumio[947]: info: Ignoring mount for partition: volumio_data Sep 17 17:07:25 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 17 17:07:25 volumio-kitchen volumio[947]: info: Loading plugin "volumio_command_line_client"... Sep 17 17:07:25 volumio-kitchen volumio[947]: info: Loading plugin "upnp"... Sep 17 17:07:25 volumio-kitchen volumio[947]: info: [1726585645193] Starting Upmpd Daemon Sep 17 17:07:25 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 17 17:07:25 volumio-kitchen volumio[947]: info: Loading plugin "my_music"... Sep 17 17:07:25 volumio-kitchen volumio[947]: info: Loading plugin "mpd"... Sep 17 17:07:25 volumio-kitchen kernel: Key type cifs.spnego registered Sep 17 17:07:25 volumio-kitchen kernel: Key type cifs.idmap registered Sep 17 17:07:25 volumio-kitchen 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. Sep 17 17:07:25 volumio-kitchen kernel: CIFS: Attempting to mount \\192.168.1.35\USB Sep 17 17:07:25 volumio-kitchen volumio[947]: info: Loading plugin "upnp_browser"... Sep 17 17:07:26 volumio-kitchen sudo[1003]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:26 volumio-kitchen volumio[947]: info: Loading plugin "alarm-clock"... Sep 17 17:07:26 volumio-kitchen volumio[947]: info: Loading plugin "airplay_emulation"... Sep 17 17:07:26 volumio-kitchen volumio[947]: info: Starting Shairport Sync Sep 17 17:07:26 volumio-kitchen volumio[947]: info: Loading plugin "last_100"... Sep 17 17:07:26 volumio-kitchen volumio[947]: info: Loading plugin "webradio"... Sep 17 17:07:27 volumio-kitchen volumio[947]: info: Loading plugin "i2s_dacs"... Sep 17 17:07:27 volumio-kitchen volumio[947]: info: Loading plugin "volumiodiscovery"... Sep 17 17:07:27 volumio-kitchen volumio[947]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 17 17:07:27 volumio-kitchen volumio[947]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 17:07:27 volumio-kitchen node[947]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 17 17:07:27 volumio-kitchen volumio[947]: *** WARNING *** For more information see Sep 17 17:07:27 volumio-kitchen volumio[947]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 17 17:07:27 volumio-kitchen volumio[947]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 17:07:27 volumio-kitchen volumio[947]: *** WARNING *** For more information see Sep 17 17:07:27 volumio-kitchen node[947]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 17:07:27 volumio-kitchen node[947]: *** WARNING *** For more information see Sep 17 17:07:27 volumio-kitchen node[947]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 17 17:07:27 volumio-kitchen node[947]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 17:07:27 volumio-kitchen node[947]: *** WARNING *** For more information see Sep 17 17:07:27 volumio-kitchen volumio[947]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 17 17:07:27 volumio-kitchen volumio[947]: info: Discovery: Started advertising with name: Volumio Kitchen Sep 17 17:07:27 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 17 17:07:27 volumio-kitchen volumio[947]: info: Loading plugin "spop"... Sep 17 17:07:27 volumio-kitchen systemd[1]: systemd-fsckd.service: Succeeded. Sep 17 17:07:28 volumio-kitchen sudo[997]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:28 volumio-kitchen sh[519]: timed out Sep 17 17:07:28 volumio-kitchen dhcpcd[566]: timed out Sep 17 17:07:28 volumio-kitchen sh[519]: dhcpcd exited Sep 17 17:07:28 volumio-kitchen dhcpcd[566]: dhcpcd exited Sep 17 17:07:28 volumio-kitchen sh[519]: ifup: failed to bring up eth0 Sep 17 17:07:28 volumio-kitchen systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Sep 17 17:07:28 volumio-kitchen systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Sep 17 17:07:29 volumio-kitchen volumio[947]: info: Loading plugin "ytcr"... Sep 17 17:07:31 volumio-kitchen systemd[1]: systemd-hostnamed.service: Succeeded. Sep 17 17:07:32 volumio-kitchen volumio[947]: info: Loading plugin "outputs"... Sep 17 17:07:32 volumio-kitchen volumio[947]: info: Loading plugin "albumart"... Sep 17 17:07:32 volumio-kitchen volumio[947]: info: Plugin example_plugin is not enabled Sep 17 17:07:32 volumio-kitchen volumio[947]: info: Loading plugin "inputs"... Sep 17 17:07:32 volumio-kitchen volumio[947]: info: Loading plugin "updater_comm"... Sep 17 17:07:32 volumio-kitchen volumio[947]: info: Plugin mpdemulation is not enabled Sep 17 17:07:32 volumio-kitchen volumio[947]: info: Loading plugin "rest_api"... Sep 17 17:07:32 volumio-kitchen volumio[947]: info: Loading plugin "websocket"... Sep 17 17:07:32 volumio-kitchen volumio[947]: info: Starting Socket.io Server version 2.3.0 Sep 17 17:07:32 volumio-kitchen volumio[947]: info: Loading plugin "fusiondsp"... Sep 17 17:07:33 volumio-kitchen volumio[947]: Forking 3 albumart workers Sep 17 17:07:33 volumio-kitchen volumio[947]: info: Applying required configuration parameters for plugin fusiondsp Sep 17 17:07:33 volumio-kitchen volumio[947]: info: Loading i18n strings for locale en Sep 17 17:07:33 volumio-kitchen volumio[947]: Updating browse sources language Sep 17 17:07:33 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::initPlayerControls Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 17 17:07:34 volumio-kitchen volumio[947]: Express server listening on port 3000 Sep 17 17:07:34 volumio-kitchen volumio[947]: [Metrics] WebUI: 14s 196.32ms Sep 17 17:07:34 volumio-kitchen volumio[947]: Starting albumart workers Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreStateMachine::resetVolumioState Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreStateMachine::getcurrentVolume Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioRetrievevolume Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreStateMachine::pushState Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioPushState Sep 17 17:07:34 volumio-kitchen volumio[947]: Starting albumart workers Sep 17 17:07:34 volumio-kitchen volumio[947]: Starting albumart workers Sep 17 17:07:34 volumio-kitchen volumio[947]: verbose: New Socket.io Connection to 192.168.1.36:3000 from 192.168.1.35 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Sep 17 17:07:34 volumio-kitchen volumio[947]: verbose: New Socket.io Connection to 192.168.1.36:3000 from 192.168.1.35 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Sep 17 17:07:34 volumio-kitchen volumio[947]: verbose: New Socket.io Connection to 192.168.1.36:3000 from 192.168.1.35 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Sep 17 17:07:34 volumio-kitchen volumio[947]: verbose: New Socket.io Connection to 192.168.1.36:3000 from 192.168.1.35 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 17:07:34 volumio-kitchen volumio[947]: info: Discovery: Getting this device information Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:34 volumio-kitchen volumio[947]: info: Reloading queue from file Sep 17 17:07:34 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:34 volumio-kitchen volumio[947]: verbose: New Socket.io Connection to 192.168.1.36:3000 from 192.168.1.35 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreStateMachine::setRepeat null single undefined Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreStateMachine::pushState Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioPushState Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreStateMachine::setRandom null Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreStateMachine::pushState Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioPushState Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Setting Device type: Raspberry PI Sep 17 17:07:35 volumio-kitchen volumio[947]: verbose: New Socket.io Connection to 192.168.1.36:3000 from 192.168.1.44 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Completed loading Core Plugins Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Preparing to generate the ALSA configuration file Sep 17 17:07:35 volumio-kitchen sudo[1087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 17 17:07:35 volumio-kitchen sudo[1087]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:35 volumio-kitchen volumio[947]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Sep 17 17:07:35 volumio-kitchen volumio[947]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03112 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Sep 17 17:07:35 volumio-kitchen sudo[1087]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:35 volumio-kitchen volumio[947]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Reading ALSA contributions from plugins. Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:35 volumio-kitchen sudo[1089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 17 17:07:35 volumio-kitchen sudo[1089]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Sep 17 17:07:35 volumio-kitchen sudo[1089]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Discovery: adding d06fbe2b-3b7b-400e-bc7b-3a8e0c3dfd06 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Discovery: Found device Volumio Kitchen Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Discovery: adding 9a5587c1-41ba-495f-aa0a-53934c8f046c Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Discovery: Found device Volumio Livingroom Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Discovery: Connecting to remote: 169.254.211.55 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Asound.conf file unchanged, so no further update is needed Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Output device has changed, restarting MPD Sep 17 17:07:35 volumio-kitchen sudo[1101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 17 17:07:35 volumio-kitchen sudo[1101]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:35 volumio-kitchen sudo[1104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 17 17:07:35 volumio-kitchen sudo[1104]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Output device has changed, restarting Shairport Sync Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:35 volumio-kitchen sudo[1104]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:35 volumio-kitchen sudo[1106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 17 17:07:35 volumio-kitchen sudo[1106]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:35 volumio-kitchen systemd[1]: Started UPnP Renderer front-end to MPD. Sep 17 17:07:35 volumio-kitchen sudo[1101]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: ___________ START PLUGINS ___________ Sep 17 17:07:35 volumio-kitchen volumio[947]: info: ControllerMpd::onStart: Initializing MPD Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Creating MPD Configuration file Sep 17 17:07:35 volumio-kitchen systemd[1]: Listening on mpd.socket. Sep 17 17:07:35 volumio-kitchen systemd[1]: Starting Music Player Daemon... Sep 17 17:07:35 volumio-kitchen sudo[1116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 17 17:07:35 volumio-kitchen sudo[1116]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 17 17:07:35 volumio-kitchen volumio[947]: info: [1726585655845] CoreMusicLibrary::Adding element Media Servers Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 17:07:35 volumio-kitchen sudo[1116]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:35 volumio-kitchen sudo[1118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 17 17:07:35 volumio-kitchen sudo[1118]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:35 volumio-kitchen systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Sep 17 17:07:35 volumio-kitchen systemd[1]: mpd.service: Succeeded. Sep 17 17:07:35 volumio-kitchen systemd[1]: Stopped Music Player Daemon. Sep 17 17:07:35 volumio-kitchen volumio[947]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:35 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:36 volumio-kitchen systemd[1]: Starting Music Player Daemon... Sep 17 17:07:36 volumio-kitchen volumio[947]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 17 17:07:36 volumio-kitchen volumio[947]: info: [1726585656078] CoreMusicLibrary::Adding element Last_100 Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 17 17:07:36 volumio-kitchen volumio[947]: info: [1726585656083] CoreMusicLibrary::Adding element Webradio Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 17 17:07:36 volumio-kitchen volumio[947]: info: Initializing BBC Radios Sep 17 17:07:36 volumio-kitchen sudo[1124]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 17 17:07:36 volumio-kitchen sudo[1124]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:36 volumio-kitchen sudo[1124]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Sep 17 17:07:36 volumio-kitchen sudo[1124]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: Creating Spotify config file Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: Loading i18n strings for locale en Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: FusionDsp - mixtype--------------------- None Sep 17 17:07:36 volumio-kitchen volumio[947]: info: Volumio Calling Home Sep 17 17:07:36 volumio-kitchen volumio[947]: info: Preparing to generate the ALSA configuration file Sep 17 17:07:36 volumio-kitchen volumio[947]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Sep 17 17:07:36 volumio-kitchen volumio[947]: info: Reading ALSA contributions from plugins. Sep 17 17:07:36 volumio-kitchen volumio[947]: info: MPD Permissions set Sep 17 17:07:36 volumio-kitchen volumio[947]: info: MPD Permissions set Sep 17 17:07:36 volumio-kitchen volumio[947]: info: Upmpdcli Daemon Started Sep 17 17:07:36 volumio-kitchen volumio[947]: info: Spotify config file written Sep 17 17:07:36 volumio-kitchen sudo[1144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Sep 17 17:07:36 volumio-kitchen sudo[1144]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:36 volumio-kitchen volumio[947]: info: An error occurred while refreshing Spotify Token Error: certificate is not yet valid Sep 17 17:07:36 volumio-kitchen volumio[947]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Sep 17 17:07:36 volumio-kitchen volumio[947]: info: Volumio called home Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen systemd[1]: Started go-librespot Daemon. Sep 17 17:07:36 volumio-kitchen go-librespot[1150]: Librespot-go daemon starting... Sep 17 17:07:36 volumio-kitchen sudo[1144]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio-kitchen volumio[947]: info: No need to fix Spotify hosts Sep 17 17:07:37 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube) Failed to obtain lounge token with screen Id from stored MDX context (uv9uafuvgl0tsh1v277bgqiuca): Sep 17 17:07:37 volumio-kitchen volumio[947]: (ConnectionError) (YouTube) Connection error in getting lounge token Sep 17 17:07:37 volumio-kitchen volumio[947]: Error info: { Sep 17 17:07:37 volumio-kitchen volumio[947]: url: 'https://www.youtube.com/api/lounge/pairing/get_lounge_token_batch' Sep 17 17:07:37 volumio-kitchen volumio[947]: } Sep 17 17:07:37 volumio-kitchen volumio[947]: --->(FetchError) request to https://www.youtube.com/api/lounge/pairing/get_lounge_token_batch failed, reason: certificate is not yet valid Sep 17 17:07:37 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:37 volumio-kitchen volumio[947]: ConnectionError: (YouTube) Connection error in getting lounge token Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session._Session_getLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:435:15) Sep 17 17:07:37 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async Session.begin (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:131:31) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async Promise.all (index 0) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:110:13) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/YouTubeCastReceiver.js:91:13) Sep 17 17:07:37 volumio-kitchen volumio[947]: Going to generate fresh screen Id and try again... Sep 17 17:07:37 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube Music) Failed to obtain lounge token with screen Id from stored MDX context (1v55huph9iiaovfe1kojepbv5d): Sep 17 17:07:37 volumio-kitchen volumio[947]: (ConnectionError) (YouTube Music) Connection error in getting lounge token Sep 17 17:07:37 volumio-kitchen volumio[947]: Error info: { Sep 17 17:07:37 volumio-kitchen volumio[947]: url: 'https://www.youtube.com/api/lounge/pairing/get_lounge_token_batch' Sep 17 17:07:37 volumio-kitchen volumio[947]: } Sep 17 17:07:37 volumio-kitchen volumio[947]: --->(FetchError) request to https://www.youtube.com/api/lounge/pairing/get_lounge_token_batch failed, reason: certificate is not yet valid Sep 17 17:07:37 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:37 volumio-kitchen volumio[947]: ConnectionError: (YouTube Music) Connection error in getting lounge token Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session._Session_getLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:435:15) Sep 17 17:07:37 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async Session.begin (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:131:31) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async Promise.all (index 1) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:110:13) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/YouTubeCastReceiver.js:91:13) Sep 17 17:07:37 volumio-kitchen volumio[947]: Going to generate fresh screen Id and try again... Sep 17 17:07:37 volumio-kitchen volumio[947]: info: Starting Shairport Sync Sep 17 17:07:37 volumio-kitchen volumio[947]: info: Starting Shairport Sync Sep 17 17:07:37 volumio-kitchen volumio[947]: info: Starting Shairport Sync Sep 17 17:07:37 volumio-kitchen sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 17 17:07:37 volumio-kitchen sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:37 volumio-kitchen sudo[1164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 17 17:07:37 volumio-kitchen sudo[1164]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:37 volumio-kitchen systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 17 17:07:37 volumio-kitchen systemd[1]: shairport-sync.service: Succeeded. Sep 17 17:07:37 volumio-kitchen systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 17 17:07:37 volumio-kitchen sudo[1167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:37 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:37+02:00" level=info msg="generated new device id: cb8714134d15c7f8bbc5d1233e59ce200e74a566" Sep 17 17:07:37 volumio-kitchen sudo[1167]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:37 volumio-kitchen systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 17 17:07:37 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:37+02:00" level=debug msg="stored credentials found for basil85" Sep 17 17:07:37 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Sep 17 17:07:37 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:37 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:37 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:37 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:37 volumio-kitchen volumio[947]: } Sep 17 17:07:37 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:37 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:37 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:37 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:37 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:37 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:37 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:37 volumio-kitchen volumio[947]: at AsyncTaskQueue.push (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:39:18) Sep 17 17:07:37 volumio-kitchen volumio[947]: at /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:339:67 Sep 17 17:07:37 volumio-kitchen volumio[947]: at new Promise () Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session.sendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:338:16) Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:236:28) Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session.begin (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:207:26) Sep 17 17:07:37 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async Promise.all (index 1) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:110:13) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/YouTubeCastReceiver.js:91:13) Sep 17 17:07:37 volumio-kitchen sudo[1162]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:37 volumio-kitchen volumio[947]: error: [yt-cast-receiver] Failed to start receiver: Sep 17 17:07:37 volumio-kitchen volumio[947]: (AppError) Failed to start YouTubeApp Sep 17 17:07:37 volumio-kitchen volumio[947]: --->(SessionError) (YouTube Music) Failed to establish session Sep 17 17:07:37 volumio-kitchen volumio[947]: ------>(ConnectionError) (YouTube Music) Connection error in generating screen Id Sep 17 17:07:37 volumio-kitchen volumio[947]: Error info: { Sep 17 17:07:37 volumio-kitchen volumio[947]: url: 'https://www.youtube.com/api/lounge/pairing/generate_screen_id' Sep 17 17:07:37 volumio-kitchen volumio[947]: } Sep 17 17:07:37 volumio-kitchen volumio[947]: --------->(FetchError) request to https://www.youtube.com/api/lounge/pairing/generate_screen_id failed, reason: certificate is not yet valid Sep 17 17:07:37 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:37 volumio-kitchen volumio[947]: AppError: Failed to start YouTubeApp Sep 17 17:07:37 volumio-kitchen volumio[947]: at YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:125:19) Sep 17 17:07:37 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/YouTubeCastReceiver.js:91:13) Sep 17 17:07:37 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask: Sep 17 17:07:37 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:37 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:37 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:37 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:37 volumio-kitchen volumio[947]: } Sep 17 17:07:37 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:37 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:37 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:37 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:37 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:37 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:37 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:37 volumio-kitchen volumio[947]: at AsyncTaskQueue.push (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:39:18) Sep 17 17:07:37 volumio-kitchen volumio[947]: at /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:339:67 Sep 17 17:07:37 volumio-kitchen volumio[947]: at new Promise () Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session.sendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:338:16) Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:236:28) Sep 17 17:07:37 volumio-kitchen volumio[947]: at /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:118:35 Sep 17 17:07:37 volumio-kitchen volumio[947]: at Array.forEach () Sep 17 17:07:37 volumio-kitchen volumio[947]: at YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:114:24) Sep 17 17:07:37 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/YouTubeCastReceiver.js:91:13) Sep 17 17:07:37 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Sep 17 17:07:37 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:37 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:37 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:37 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:37 volumio-kitchen volumio[947]: } Sep 17 17:07:37 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:37 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:37 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:37 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:37 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:37 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:37 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Sep 17 17:07:37 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:37 volumio-kitchen volumio[947]: error: [ytcr] Failed to start plugin: Sep 17 17:07:37 volumio-kitchen volumio[947]: (AppError) Failed to start YouTubeApp Sep 17 17:07:37 volumio-kitchen volumio[947]: --->(SessionError) (YouTube Music) Failed to establish session Sep 17 17:07:37 volumio-kitchen volumio[947]: ------>(ConnectionError) (YouTube Music) Connection error in generating screen Id Sep 17 17:07:37 volumio-kitchen volumio[947]: Error info: { Sep 17 17:07:37 volumio-kitchen volumio[947]: url: 'https://www.youtube.com/api/lounge/pairing/generate_screen_id' Sep 17 17:07:37 volumio-kitchen volumio[947]: } Sep 17 17:07:37 volumio-kitchen volumio[947]: --------->(FetchError) request to https://www.youtube.com/api/lounge/pairing/generate_screen_id failed, reason: certificate is not yet valid Sep 17 17:07:37 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:37 volumio-kitchen volumio[947]: AppError: Failed to start YouTubeApp Sep 17 17:07:37 volumio-kitchen volumio[947]: at YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:125:19) Sep 17 17:07:37 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:37 volumio-kitchen systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 17 17:07:37 volumio-kitchen volumio[947]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/YouTubeCastReceiver.js:91:13) Sep 17 17:07:37 volumio-kitchen systemd[1]: shairport-sync.service: Succeeded. Sep 17 17:07:37 volumio-kitchen systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 17 17:07:37 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask: Sep 17 17:07:37 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:37 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:37 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:37 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:37 volumio-kitchen volumio[947]: } Sep 17 17:07:37 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:37 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:37 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:37 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:37 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:37 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:37 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:37 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Sep 17 17:07:37 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:37 volumio-kitchen volumio[947]: at async /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:118:21 Sep 17 17:07:37 volumio-kitchen systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 17 17:07:37 volumio-kitchen sudo[1164]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:37 volumio-kitchen sudo[1167]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:37 volumio-kitchen volumio[947]: info: Asound.conf file unchanged, so no further update is needed Sep 17 17:07:37 volumio-kitchen volumio[947]: info: Output device has changed, restarting MPD Sep 17 17:07:37 volumio-kitchen volumio[947]: info: Output device has changed, restarting Shairport Sync Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:37 volumio-kitchen sudo[1178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 17 17:07:37 volumio-kitchen sudo[1178]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:37 volumio-kitchen sudo[1178]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:37 volumio-kitchen sudo[1181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 17 17:07:37 volumio-kitchen sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:37 volumio-kitchen systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 17 17:07:37 volumio-kitchen systemd[1]: mpd.service: Succeeded. Sep 17 17:07:37 volumio-kitchen systemd[1]: Stopped Music Player Daemon. Sep 17 17:07:37 volumio-kitchen volumio[947]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 17 17:07:37 volumio-kitchen volumio[947]: info: Shairport-Sync Started Sep 17 17:07:37 volumio-kitchen volumio[947]: Error adding Membership: Error: addMembership EINVAL Sep 17 17:07:37 volumio-kitchen volumio[947]: info: Shairport-Sync Started Sep 17 17:07:37 volumio-kitchen systemd[1]: Starting Music Player Daemon... Sep 17 17:07:37 volumio-kitchen volumio[947]: info: MPD Permissions set Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:37 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:38 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:38] [connect] Successful connection Sep 17 17:07:38 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:38 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:38 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask: Sep 17 17:07:38 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:38 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:38 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:38 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:38 volumio-kitchen volumio[947]: } Sep 17 17:07:38 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:38 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:38 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:38 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (Use `node --trace-warnings ...` to show where the warning was created) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 7) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Sep 17 17:07:38 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Sep 17 17:07:38 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:38 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:38 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:38 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:38 volumio-kitchen volumio[947]: } Sep 17 17:07:38 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:38 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:38 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:38 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: at async /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:118:21 Sep 17 17:07:38 volumio-kitchen sudo[1187]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 17 17:07:38 volumio-kitchen sudo[1187]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 9) Sep 17 17:07:38 volumio-kitchen sudo[1187]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Sep 17 17:07:38 volumio-kitchen sudo[1187]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:38 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:38+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Sep 17 17:07:38 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:38+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Sep 17 17:07:38 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:38+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Sep 17 17:07:38 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:38+02:00" level=debug msg="zeroconf server listening on port 42979" Sep 17 17:07:38 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Sep 17 17:07:38 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:38 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:38 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:38 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:38 volumio-kitchen volumio[947]: } Sep 17 17:07:38 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:38 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:38 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:38 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 11) Sep 17 17:07:38 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask: Sep 17 17:07:38 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:38 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:38 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:38 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:38 volumio-kitchen volumio[947]: } Sep 17 17:07:38 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:38 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:38 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:38 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 13) Sep 17 17:07:38 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:38+02:00" level=debug msg="obtained new client token: AACSjoxYhxZ7+URaRrjGOnXkFz+wTtTQd+1PwLKx2lrI4ZupcCVZfeYhib8PKlXWRmL0e9aeYDDJws0hDBHEVpHDiqi5rU6qMlOOWEhXHC0ByHBqy9n+Rqwq2B+gCmud81TtS4nRfl2Au7XWV71Wni7/siimv1a4LqFl9hC8LhHUdRc81PNzfQAekc7zrrt3YPpOBx9HxCbT6b6ZvElYYsucX7Hzu61+1ENPcvRhkClNTHuVjKr4YBorw1VolA==" Sep 17 17:07:38 volumio-kitchen volumio-remote-updater[644]: [2024-09-17 17:07:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1726585658 101 Sep 17 17:07:38 volumio-kitchen volumio[947]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 8 Sep 17 17:07:38 volumio-kitchen volumio[947]: info: Starting Shairport Sync Sep 17 17:07:38 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:38+02:00" level=info msg="connected to ap-gew4.spotify.com:4070" Sep 17 17:07:38 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask: Sep 17 17:07:38 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:38 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:38 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:38 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:38 volumio-kitchen volumio[947]: } Sep 17 17:07:38 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:38 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:38 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:38 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 15) Sep 17 17:07:38 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:38+02:00" level=debug msg="completed keyexchange" Sep 17 17:07:38 volumio-kitchen sudo[1196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 17 17:07:38 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Sep 17 17:07:38 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:38 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:38 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:38 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:38 volumio-kitchen volumio[947]: } Sep 17 17:07:38 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:38 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:38 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:38 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen sudo[1196]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 17) Sep 17 17:07:38 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Sep 17 17:07:38 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:38 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:38 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:38 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:38 volumio-kitchen volumio[947]: } Sep 17 17:07:38 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:38 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:38 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:38 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 19) Sep 17 17:07:38 volumio-kitchen systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 17 17:07:38 volumio-kitchen volumio[947]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask: Sep 17 17:07:38 volumio-kitchen volumio[947]: LoungeScreenDisconnected { Sep 17 17:07:38 volumio-kitchen volumio[947]: AID: null, Sep 17 17:07:38 volumio-kitchen volumio[947]: name: 'loungeScreenDisconnected', Sep 17 17:07:38 volumio-kitchen volumio[947]: payload: {} Sep 17 17:07:38 volumio-kitchen volumio[947]: } Sep 17 17:07:38 volumio-kitchen volumio[947]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Sep 17 17:07:38 volumio-kitchen volumio[947]: Stack trace: Sep 17 17:07:38 volumio-kitchen volumio[947]: IncompleteAPIDataError: Missing data required to construct query string from bind params Sep 17 17:07:38 volumio-kitchen volumio[947]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Sep 17 17:07:38 volumio-kitchen volumio[947]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen systemd[1]: shairport-sync.service: Succeeded. Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Sep 17 17:07:38 volumio-kitchen volumio[947]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Sep 17 17:07:38 volumio-kitchen volumio[947]: (node:947) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 21) Sep 17 17:07:38 volumio-kitchen systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 17 17:07:38 volumio-kitchen systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 17 17:07:38 volumio-kitchen sudo[1196]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:38 volumio-kitchen volumio[947]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Sep 17 17:07:38 volumio-kitchen volumio[947]: info: camilladsp service started and running in background, instance 1 Sep 17 17:07:38 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:38 volumio-kitchen volumio[947]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 17 17:07:38 volumio-kitchen volumio[947]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Sep 17 17:07:38 volumio-kitchen volumio[947]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 17 17:07:38 volumio-kitchen volumio[947]: info: FusionDsp loaded Sep 17 17:07:38 volumio-kitchen volumio[947]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:38 volumio-kitchen sudo[1211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Sep 17 17:07:38 volumio-kitchen sudo[1211]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:38 volumio-kitchen volumio[947]: info: FusionDsp - Reporting Fusion DSP Enabled Sep 17 17:07:38 volumio-kitchen volumio[947]: info: Adding Signal Path Element [object Object] Sep 17 17:07:38 volumio-kitchen volumio[947]: info: Adding fusiondspeq DSP Signal Path Element Sep 17 17:07:38 volumio-kitchen volumio[947]: info: FusionDsp - ---- installed callbackRead Sep 17 17:07:38 volumio-kitchen volumio[947]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 17:07:38 volumio-kitchen volumio[947]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Sep 17 17:07:38 volumio-kitchen volumio[947]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Sep 17 17:07:38 volumio-kitchen volumio[947]: at onErrorNT (internal/child_process.js:465:16) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Sep 17 17:07:38 volumio-kitchen volumio[947]: at runNextTicks (internal/process/task_queues.js:62:3) Sep 17 17:07:38 volumio-kitchen volumio[947]: at listOnTimeout (internal/timers.js:523:9) Sep 17 17:07:38 volumio-kitchen volumio[947]: at processTimers (internal/timers.js:497:7) { Sep 17 17:07:38 volumio-kitchen volumio[947]: errno: -2, Sep 17 17:07:38 volumio-kitchen volumio[947]: code: 'ENOENT', Sep 17 17:07:38 volumio-kitchen volumio[947]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Sep 17 17:07:38 volumio-kitchen volumio[947]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Sep 17 17:07:38 volumio-kitchen volumio[947]: spawnargs: [ Sep 17 17:07:38 volumio-kitchen volumio[947]: '-p', Sep 17 17:07:38 volumio-kitchen volumio[947]: 9876, Sep 17 17:07:38 volumio-kitchen volumio[947]: '-o', Sep 17 17:07:38 volumio-kitchen volumio[947]: '/tmp/camilladsp.log', Sep 17 17:07:38 volumio-kitchen volumio[947]: '-l', Sep 17 17:07:38 volumio-kitchen volumio[947]: 'warn', Sep 17 17:07:38 volumio-kitchen volumio[947]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Sep 17 17:07:38 volumio-kitchen volumio[947]: ] Sep 17 17:07:38 volumio-kitchen volumio[947]: } Sep 17 17:07:38 volumio-kitchen volumio[947]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 17:07:38 volumio-kitchen systemd[1]: Started FusionDsp Daemon. Sep 17 17:07:38 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:38+02:00" level=debug msg="completed challenge" Sep 17 17:07:38 volumio-kitchen sudo[1211]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:38 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:38+02:00" level=debug msg="authenticated as basil85" Sep 17 17:07:39 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:39+02:00" level=debug msg="authenticated as basil85" Sep 17 17:07:39 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:39+02:00" level=debug msg="dealer connection opened" Sep 17 17:07:39 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:39+02:00" level=debug msg="initializing zeroconf session, username: basil85" Sep 17 17:07:39 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:39+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Sep 17 17:07:39 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:39+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Sep 17 17:07:39 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:39+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Sep 17 17:07:39 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:39+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Sep 17 17:07:39 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:39+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Sep 17 17:07:39 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:39+02:00" level=debug msg="autoplay enabled: false" Sep 17 17:07:39 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:39+02:00" level=debug msg="received connection id: YmU0MzQwOGItYWEwNy00MjMwLWI1NTItZTEwMzM2YTgzOTYyK2RlYWxlcit0Y3A6Ly8wYWNhNThhMS5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArNjVGOTg4MEEwM0FFQkY4OUY1QzA2MzdGNjVFNTdBMjk5RjYyNEQ1MDg4ODg1Nzg5NzE0OTFFREUwM0I4NzU4OA==" Sep 17 17:07:39 volumio-kitchen go-librespot[1150]: time="2024-09-17T17:07:39+02:00" level=debug msg="put connect state because NEW_DEVICE" Sep 17 17:07:39 volumio-kitchen sudo[1223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-17 17:06 Sep 17 17:07:39 volumio-kitchen sudo[1223]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"