-- Logs begin at Wed 2024-05-01 16:32:41 UTC, end at Wed 2024-05-01 16:33:32 UTC. -- May 01 16:32:41 volumio-wald kernel: Booting Linux on physical CPU 0xf00 May 01 16:32:41 volumio-wald kernel: Linux version 6.1.69-v7+ (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:14:13 GMT 2023 May 01 16:32:41 volumio-wald kernel: CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=10c5387d May 01 16:32:41 volumio-wald kernel: CPU: div instructions available: patching division code May 01 16:32:41 volumio-wald kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache May 01 16:32:41 volumio-wald kernel: OF: fdt: Machine model: Raspberry Pi 2 Model B Rev 1.1 May 01 16:32:41 volumio-wald kernel: random: crng init done May 01 16:32:41 volumio-wald kernel: Memory policy: Data cache writealloc May 01 16:32:41 volumio-wald kernel: Reserved memory: created CMA memory pool at 0x34000000, size 64 MiB May 01 16:32:41 volumio-wald kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool May 01 16:32:41 volumio-wald kernel: Zone ranges: May 01 16:32:41 volumio-wald kernel: DMA [mem 0x0000000000000000-0x0000000037ffffff] May 01 16:32:41 volumio-wald kernel: Normal empty May 01 16:32:41 volumio-wald kernel: Movable zone start for each node May 01 16:32:41 volumio-wald kernel: Early memory node ranges May 01 16:32:41 volumio-wald kernel: node 0: [mem 0x0000000000000000-0x0000000037ffffff] May 01 16:32:41 volumio-wald kernel: Initmem setup node 0 [mem 0x0000000000000000-0x0000000037ffffff] May 01 16:32:41 volumio-wald kernel: percpu: Embedded 17 pages/cpu s37012 r8192 d24428 u69632 May 01 16:32:41 volumio-wald kernel: pcpu-alloc: s37012 r8192 d24428 u69632 alloc=17*4096 May 01 16:32:41 volumio-wald kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 May 01 16:32:41 volumio-wald kernel: Built 1 zonelists, mobility grouping on. Total pages: 227360 May 01 16:32:41 volumio-wald kernel: Kernel command line: coherent_pool=1M 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 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=ttyAMA0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 May 01 16:32:41 volumio-wald kernel: Kernel parameter elevator= does not have any effect anymore. Please use sysfs to set IO scheduler for individual devices. May 01 16:32:41 volumio-wald kernel: Unknown kernel command line parameters "splash imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh bootdelay=5", will be passed to user space. May 01 16:32:41 volumio-wald kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) May 01 16:32:41 volumio-wald kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) May 01 16:32:41 volumio-wald kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 01 16:32:41 volumio-wald kernel: Memory: 811516K/917504K available (10240K kernel code, 1455K rwdata, 3144K rodata, 1024K init, 611K bss, 40452K reserved, 65536K cma-reserved) May 01 16:32:41 volumio-wald kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 01 16:32:41 volumio-wald kernel: ftrace: allocating 34929 entries in 103 pages May 01 16:32:41 volumio-wald kernel: ftrace: allocated 103 pages with 5 groups May 01 16:32:41 volumio-wald kernel: trace event string verifier disabled May 01 16:32:41 volumio-wald kernel: rcu: Hierarchical RCU implementation. May 01 16:32:41 volumio-wald kernel: Rude variant of Tasks RCU enabled. May 01 16:32:41 volumio-wald kernel: Tracing variant of Tasks RCU enabled. May 01 16:32:41 volumio-wald kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. May 01 16:32:41 volumio-wald kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 May 01 16:32:41 volumio-wald kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 01 16:32:41 volumio-wald kernel: arch_timer: cp15 timer(s) running at 19.20MHz (phys). May 01 16:32:41 volumio-wald kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns May 01 16:32:41 volumio-wald kernel: sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns May 01 16:32:41 volumio-wald kernel: Switching to timer-based delay loop, resolution 52ns May 01 16:32:41 volumio-wald kernel: Console: colour dummy device 80x30 May 01 16:32:41 volumio-wald kernel: printk: console [tty1] enabled May 01 16:32:41 volumio-wald kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000) May 01 16:32:41 volumio-wald kernel: CPU: Testing write buffer coherency: ok May 01 16:32:41 volumio-wald kernel: pid_max: default: 32768 minimum: 301 May 01 16:32:41 volumio-wald kernel: LSM: Security Framework initializing May 01 16:32:41 volumio-wald kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) May 01 16:32:41 volumio-wald kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) May 01 16:32:41 volumio-wald kernel: cgroup: Disabling memory control group subsystem May 01 16:32:41 volumio-wald kernel: CPU0: update cpu_capacity 1024 May 01 16:32:41 volumio-wald kernel: CPU0: thread -1, cpu 0, socket 15, mpidr 80000f00 May 01 16:32:41 volumio-wald kernel: cblist_init_generic: Setting adjustable number of callback queues. May 01 16:32:41 volumio-wald kernel: cblist_init_generic: Setting shift to 2 and lim to 1. May 01 16:32:41 volumio-wald kernel: cblist_init_generic: Setting adjustable number of callback queues. May 01 16:32:41 volumio-wald kernel: cblist_init_generic: Setting shift to 2 and lim to 1. May 01 16:32:41 volumio-wald kernel: Setting up static identity map for 0x100000 - 0x10003c May 01 16:32:41 volumio-wald kernel: rcu: Hierarchical SRCU implementation. May 01 16:32:41 volumio-wald kernel: rcu: Max phase no-delay instances is 1000. May 01 16:32:41 volumio-wald kernel: smp: Bringing up secondary CPUs ... May 01 16:32:41 volumio-wald kernel: CPU1: update cpu_capacity 1024 May 01 16:32:41 volumio-wald kernel: CPU1: thread -1, cpu 1, socket 15, mpidr 80000f01 May 01 16:32:41 volumio-wald kernel: CPU2: update cpu_capacity 1024 May 01 16:32:41 volumio-wald kernel: CPU2: thread -1, cpu 2, socket 15, mpidr 80000f02 May 01 16:32:41 volumio-wald kernel: CPU3: update cpu_capacity 1024 May 01 16:32:41 volumio-wald kernel: CPU3: thread -1, cpu 3, socket 15, mpidr 80000f03 May 01 16:32:41 volumio-wald kernel: smp: Brought up 1 node, 4 CPUs May 01 16:32:41 volumio-wald kernel: SMP: Total of 4 processors activated (153.60 BogoMIPS). May 01 16:32:41 volumio-wald kernel: CPU: All CPU(s) started in HYP mode. May 01 16:32:41 volumio-wald kernel: CPU: Virtualization extensions available. May 01 16:32:41 volumio-wald kernel: devtmpfs: initialized May 01 16:32:41 volumio-wald kernel: VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 5 May 01 16:32:41 volumio-wald kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns May 01 16:32:41 volumio-wald kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 01 16:32:41 volumio-wald kernel: pinctrl core: initialized pinctrl subsystem May 01 16:32:41 volumio-wald kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 01 16:32:41 volumio-wald kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations May 01 16:32:41 volumio-wald kernel: audit: initializing netlink subsys (disabled) May 01 16:32:41 volumio-wald kernel: audit: type=2000 audit(0.040:1): state=initialized audit_enabled=0 res=1 May 01 16:32:41 volumio-wald kernel: thermal_sys: Registered thermal governor 'step_wise' May 01 16:32:41 volumio-wald kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. May 01 16:32:41 volumio-wald kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. May 01 16:32:41 volumio-wald kernel: Serial: AMBA PL011 UART driver May 01 16:32:41 volumio-wald kernel: bcm2835-mbox 3f00b880.mailbox: mailbox enabled May 01 16:32:41 volumio-wald kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2023-10-17T15:42:39, variant start May 01 16:32:41 volumio-wald kernel: raspberrypi-firmware soc:firmware: Firmware hash is 30f0c5e4d076da3ab4f341d88e7d505760b93ad7 May 01 16:32:41 volumio-wald kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 01 16:32:41 volumio-wald kernel: bcm2835-dma 3f007000.dma: DMA legacy API manager, dmachans=0x1 May 01 16:32:41 volumio-wald kernel: SCSI subsystem initialized May 01 16:32:41 volumio-wald kernel: usbcore: registered new interface driver usbfs May 01 16:32:41 volumio-wald kernel: usbcore: registered new interface driver hub May 01 16:32:41 volumio-wald kernel: usbcore: registered new device driver usb May 01 16:32:41 volumio-wald kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator May 01 16:32:41 volumio-wald kernel: pps_core: LinuxPPS API ver. 1 registered May 01 16:32:41 volumio-wald kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti May 01 16:32:41 volumio-wald kernel: PTP clock support registered May 01 16:32:41 volumio-wald kernel: clocksource: Switched to clocksource arch_sys_counter May 01 16:32:41 volumio-wald kernel: VFS: Disk quotas dquot_6.6.0 May 01 16:32:41 volumio-wald kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) May 01 16:32:41 volumio-wald kernel: FS-Cache: Loaded May 01 16:32:41 volumio-wald kernel: CacheFiles: Loaded May 01 16:32:41 volumio-wald kernel: NET: Registered PF_INET protocol family May 01 16:32:41 volumio-wald kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) May 01 16:32:41 volumio-wald kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear) May 01 16:32:41 volumio-wald kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 01 16:32:41 volumio-wald kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) May 01 16:32:41 volumio-wald kernel: TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) May 01 16:32:41 volumio-wald kernel: TCP: Hash tables configured (established 8192 bind 8192) May 01 16:32:41 volumio-wald kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) May 01 16:32:41 volumio-wald kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) May 01 16:32:41 volumio-wald kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 01 16:32:41 volumio-wald kernel: RPC: Registered named UNIX socket transport module. May 01 16:32:41 volumio-wald kernel: RPC: Registered udp transport module. May 01 16:32:41 volumio-wald kernel: RPC: Registered tcp transport module. May 01 16:32:41 volumio-wald kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. May 01 16:32:41 volumio-wald kernel: Trying to unpack rootfs image as initramfs... May 01 16:32:41 volumio-wald kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 5 counters available May 01 16:32:41 volumio-wald kernel: Freeing initrd memory: 13628K May 01 16:32:41 volumio-wald kernel: Initialise system trusted keyrings May 01 16:32:41 volumio-wald kernel: workingset: timestamp_bits=14 max_order=18 bucket_order=4 May 01 16:32:41 volumio-wald kernel: zbud: loaded May 01 16:32:41 volumio-wald kernel: NFS: Registering the id_resolver key type May 01 16:32:41 volumio-wald kernel: Key type id_resolver registered May 01 16:32:41 volumio-wald kernel: Key type id_legacy registered May 01 16:32:41 volumio-wald kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... May 01 16:32:41 volumio-wald kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... May 01 16:32:41 volumio-wald kernel: Key type asymmetric registered May 01 16:32:41 volumio-wald kernel: Asymmetric key parser 'x509' registered May 01 16:32:41 volumio-wald kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) May 01 16:32:41 volumio-wald kernel: io scheduler mq-deadline registered May 01 16:32:41 volumio-wald kernel: io scheduler kyber registered May 01 16:32:41 volumio-wald kernel: bcm2708_fb soc:fb: FB found 1 display(s) May 01 16:32:41 volumio-wald kernel: Console: switching to colour frame buffer device 80x30 May 01 16:32:41 volumio-wald kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480 May 01 16:32:41 volumio-wald kernel: bcm2835-rng 3f104000.rng: hwrng registered May 01 16:32:41 volumio-wald kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) May 01 16:32:41 volumio-wald kernel: brd: module loaded May 01 16:32:41 volumio-wald kernel: loop: module loaded May 01 16:32:41 volumio-wald kernel: Loading iSCSI transport class v2.0-870. May 01 16:32:41 volumio-wald kernel: usbcore: registered new interface driver lan78xx May 01 16:32:41 volumio-wald kernel: usbcore: registered new interface driver smsc95xx May 01 16:32:41 volumio-wald kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) May 01 16:32:41 volumio-wald kernel: Core Release: 2.80a May 01 16:32:41 volumio-wald kernel: Setting default values for core params May 01 16:32:41 volumio-wald kernel: Finished setting default values for core params May 01 16:32:41 volumio-wald kernel: Using Buffer DMA mode May 01 16:32:41 volumio-wald kernel: Periodic Transfer Interrupt Enhancement - disabled May 01 16:32:41 volumio-wald kernel: Multiprocessor Interrupt Enhancement - disabled May 01 16:32:41 volumio-wald kernel: OTG VER PARAM: 0, OTG VER FLAG: 0 May 01 16:32:41 volumio-wald kernel: Dedicated Tx FIFOs mode May 01 16:32:41 volumio-wald kernel: May 01 16:32:41 volumio-wald kernel: WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = b4114000 dma = 0xf4114000 len=9024 May 01 16:32:41 volumio-wald kernel: FIQ FSM acceleration enabled for : Non-periodic Split Transactions Periodic Split Transactions High-Speed Isochronous Endpoints Interrupt/Control Split Transaction hack enabled May 01 16:32:41 volumio-wald kernel: dwc_otg: Microframe scheduler enabled May 01 16:32:41 volumio-wald kernel: May 01 16:32:41 volumio-wald kernel: WARN::hcd_init_fiq:457: FIQ on core 1 May 01 16:32:41 volumio-wald kernel: May 01 16:32:41 volumio-wald kernel: WARN::hcd_init_fiq:458: FIQ ASM at 807cb80c length 36 May 01 16:32:41 volumio-wald kernel: May 01 16:32:41 volumio-wald kernel: WARN::hcd_init_fiq:497: MPHI regs_base at b8810000 May 01 16:32:41 volumio-wald kernel: dwc_otg 3f980000.usb: DWC OTG Controller May 01 16:32:41 volumio-wald kernel: dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1 May 01 16:32:41 volumio-wald kernel: dwc_otg 3f980000.usb: irq 89, io mem 0x00000000 May 01 16:32:41 volumio-wald kernel: Init: Port Power? op_state=1 May 01 16:32:41 volumio-wald kernel: Init: Power Port (0) May 01 16:32:41 volumio-wald kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01 May 01 16:32:41 volumio-wald kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 May 01 16:32:41 volumio-wald kernel: usb usb1: Product: DWC OTG Controller May 01 16:32:41 volumio-wald kernel: usb usb1: Manufacturer: Linux 6.1.69-v7+ dwc_otg_hcd May 01 16:32:41 volumio-wald kernel: usb usb1: SerialNumber: 3f980000.usb May 01 16:32:41 volumio-wald kernel: hub 1-0:1.0: USB hub found May 01 16:32:41 volumio-wald kernel: hub 1-0:1.0: 1 port detected May 01 16:32:41 volumio-wald kernel: dwc_otg: FIQ enabled May 01 16:32:41 volumio-wald kernel: dwc_otg: NAK holdoff enabled May 01 16:32:41 volumio-wald kernel: dwc_otg: FIQ split-transaction FSM enabled May 01 16:32:41 volumio-wald kernel: Module dwc_common_port init May 01 16:32:41 volumio-wald kernel: usbcore: registered new interface driver usb-storage May 01 16:32:41 volumio-wald kernel: mousedev: PS/2 mouse device common for all mice May 01 16:32:41 volumio-wald kernel: sdhci: Secure Digital Host Controller Interface driver May 01 16:32:41 volumio-wald kernel: sdhci: Copyright(c) Pierre Ossman May 01 16:32:41 volumio-wald kernel: sdhci-pltfm: SDHCI platform and OF driver helper May 01 16:32:41 volumio-wald kernel: ledtrig-cpu: registered to indicate activity on CPUs May 01 16:32:41 volumio-wald kernel: hid: raw HID events driver (C) Jiri Kosina May 01 16:32:41 volumio-wald kernel: usbcore: registered new interface driver usbhid May 01 16:32:41 volumio-wald kernel: usbhid: USB HID core driver May 01 16:32:41 volumio-wald kernel: Initializing XFRM netlink socket May 01 16:32:41 volumio-wald kernel: NET: Registered PF_PACKET protocol family May 01 16:32:41 volumio-wald kernel: Key type dns_resolver registered May 01 16:32:41 volumio-wald kernel: Registering SWP/SWPB emulation handler May 01 16:32:41 volumio-wald kernel: registered taskstats version 1 May 01 16:32:41 volumio-wald kernel: Loading compiled-in X.509 certificates May 01 16:32:41 volumio-wald kernel: Key type .fscrypt registered May 01 16:32:41 volumio-wald kernel: Key type fscrypt-provisioning registered May 01 16:32:41 volumio-wald kernel: uart-pl011 3f201000.serial: cts_event_workaround enabled May 01 16:32:41 volumio-wald kernel: 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 114, base_baud = 0) is a PL011 rev2 May 01 16:32:41 volumio-wald kernel: printk: console [ttyAMA0] enabled May 01 16:32:41 volumio-wald kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer May 01 16:32:41 volumio-wald kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver May 01 16:32:41 volumio-wald kernel: sdhost: log_buf @ 0825fd69 (f4113000) May 01 16:32:41 volumio-wald kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) May 01 16:32:41 volumio-wald kernel: of_cfs_init May 01 16:32:41 volumio-wald kernel: of_cfs_init: OK May 01 16:32:41 volumio-wald kernel: Freeing unused kernel image (initmem) memory: 1024K May 01 16:32:41 volumio-wald kernel: Indeed it is in host mode hprt0 = 00021501 May 01 16:32:41 volumio-wald kernel: mmc0: host does not support reading read-only switch, assuming write-enable May 01 16:32:41 volumio-wald kernel: Run /init as init process May 01 16:32:41 volumio-wald kernel: with arguments: May 01 16:32:41 volumio-wald kernel: /init May 01 16:32:41 volumio-wald kernel: splash May 01 16:32:41 volumio-wald kernel: mmc0: new high speed SDHC card at address aaaa May 01 16:32:41 volumio-wald kernel: with environment: May 01 16:32:41 volumio-wald kernel: HOME=/ May 01 16:32:41 volumio-wald kernel: TERM=linux May 01 16:32:41 volumio-wald kernel: imgpart=/dev/mmcblk0p2 May 01 16:32:41 volumio-wald kernel: imgfile=/volumio_current.sqsh May 01 16:32:41 volumio-wald kernel: bootdelay=5 May 01 16:32:41 volumio-wald kernel: mmcblk0: mmc0:aaaa SL08G 7.40 GiB May 01 16:32:41 volumio-wald kernel: mmcblk0: p1 p2 p3 May 01 16:32:41 volumio-wald kernel: mmcblk0: mmc0:aaaa SL08G 7.40 GiB (quirks 0x00004000) May 01 16:32:41 volumio-wald kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg May 01 16:32:41 volumio-wald kernel: Indeed it is in host mode hprt0 = 00001101 May 01 16:32:41 volumio-wald initramfs: Booting Volumio for BCM2835 May 01 16:32:41 volumio-wald initramfs: This script mounts rootfs RO with an overlay RW layer. May 01 16:32:41 volumio-wald kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 01 16:32:41 volumio-wald kernel: usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcdDevice= 2.00 May 01 16:32:41 volumio-wald kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 May 01 16:32:41 volumio-wald kernel: hub 1-1:1.0: USB hub found May 01 16:32:41 volumio-wald kernel: hub 1-1:1.0: 5 ports detected May 01 16:32:41 volumio-wald initramfs: IMGPART=/dev/mmcblk0p2 May 01 16:32:41 volumio-wald initramfs: IMGFILE=/volumio_current.sqsh May 01 16:32:41 volumio-wald initramfs: Boot delay (except first time) will be 5 seconds May 01 16:32:41 volumio-wald initramfs: /dev/mmcblk0p2: May 01 16:32:41 volumio-wald kernel: EXT4-fs (mmcblk0p2): recovery complete May 01 16:32:41 volumio-wald kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. May 01 16:32:41 volumio-wald initramfs: Doing a 5 second delay here to give kernel load a headstart May 01 16:32:41 volumio-wald kernel: usb 1-1.1: new high-speed USB device number 3 using dwc_otg May 01 16:32:41 volumio-wald kernel: usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, bcdDevice= 2.00 May 01 16:32:41 volumio-wald kernel: usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 May 01 16:32:41 volumio-wald kernel: smsc95xx v2.0.0 May 01 16:32:41 volumio-wald kernel: SMSC LAN8700 usb-001:003:01: attached PHY driver (mii_bus:phy_addr=usb-001:003:01, irq=199) May 01 16:32:41 volumio-wald kernel: smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:30:24:48 May 01 16:32:41 volumio-wald kernel: usb 1-1.4: new full-speed USB device number 4 using dwc_otg May 01 16:32:41 volumio-wald kernel: usb 1-1.4: New USB device found, idVendor=8087, idProduct=1024, bcdDevice= 1.00 May 01 16:32:41 volumio-wald kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 May 01 16:32:41 volumio-wald kernel: usb 1-1.4: Product: USB2.0 Device May 01 16:32:41 volumio-wald kernel: usb 1-1.4: Manufacturer: Generic May 01 16:32:41 volumio-wald kernel: usb 1-1.4: SerialNumber: 20170726905965 May 01 16:32:41 volumio-wald kernel: usb-storage 1-1.4:1.0: USB Mass Storage device detected May 01 16:32:41 volumio-wald kernel: scsi host0: usb-storage 1-1.4:1.0 May 01 16:32:41 volumio-wald kernel: input: Generic USB2.0 Device as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.3/0003:8087:1024.0001/input/input0 May 01 16:32:41 volumio-wald kernel: hid-generic 0003:8087:1024.0001: input,hidraw0: USB HID v2.01 Device [Generic USB2.0 Device] on usb-3f980000.usb-1.4/input3 May 01 16:32:41 volumio-wald kernel: scsi 0:0:0:0: Direct-Access Generic Masstorage 1.00 PQ: 0 ANSI: 2 May 01 16:32:41 volumio-wald kernel: sd 0:0:0:0: [sda] Media removed, stopped polling May 01 16:32:41 volumio-wald kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk May 01 16:32:41 volumio-wald initramfs: Checking for USB updates May 01 16:32:41 volumio-wald initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) May 01 16:32:41 volumio-wald kernel: loop0: detected capacity change from 0 to 967536 May 01 16:32:41 volumio-wald kernel: EXT4-fs (mmcblk0p3): recovery complete May 01 16:32:41 volumio-wald kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. May 01 16:32:41 volumio-wald initramfs: With Option: May 01 16:32:41 volumio-wald initramfs: VOLUMIO_VERSION="3.631" May 01 16:32:41 volumio-wald initramfs: Finish initramfs, continue booting Volumio May 01 16:32:41 volumio-wald systemd[1]: System time before build time, advancing clock. May 01 16:32:41 volumio-wald kernel: NET: Registered PF_INET6 protocol family May 01 16:32:41 volumio-wald kernel: Segment Routing with IPv6 May 01 16:32:41 volumio-wald kernel: In-situ OAM (IOAM) with IPv6 May 01 16:32:41 volumio-wald 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) May 01 16:32:41 volumio-wald systemd[1]: Detected architecture arm. May 01 16:32:41 volumio-wald systemd[1]: Set hostname to . May 01 16:32:41 volumio-wald kernel: uart-pl011 3f201000.serial: no DMA platform data May 01 16:32:41 volumio-wald 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. May 01 16:32:41 volumio-wald systemd[1]: Listening on Journal Socket. May 01 16:32:41 volumio-wald systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped. May 01 16:32:41 volumio-wald systemd[1]: Started Forward Password Requests to Wall Directory Watch. May 01 16:32:41 volumio-wald systemd[1]: Condition check resulted in Huge Pages File System being skipped. May 01 16:32:41 volumio-wald systemd[1]: Created slice system-systemd\x2dfsck.slice. May 01 16:32:41 volumio-wald systemd[1]: Listening on udev Control Socket. May 01 16:32:41 volumio-wald kernel: i2c_dev: i2c /dev entries driver May 01 16:32:41 volumio-wald systemd-journald[204]: Journal started May 01 16:32:41 volumio-wald systemd-journald[204]: Runtime journal (/run/log/journal/6c9b1d414d94da048f39d3e06336abc2) is 3.7M, max 30.0M, 26.2M free. May 01 16:32:41 volumio-wald systemd-modules-load[202]: Inserted module 'i2c_dev' May 01 16:32:41 volumio-wald fake-hwclock[198]: Wed May 1 16:32:41 UTC 2024 May 01 16:32:41 volumio-wald systemd[1]: Started Create System Users. May 01 16:32:41 volumio-wald systemd[1]: Started Apply Kernel Variables. May 01 16:32:41 volumio-wald systemd[1]: Starting Create Static Device Nodes in /dev... May 01 16:32:41 volumio-wald systemd[1]: Started udev Coldplug all Devices. May 01 16:32:41 volumio-wald systemd[1]: Starting Helper to synchronize boot up for ifupdown... May 01 16:32:41 volumio-wald systemd[1]: Started Helper to synchronize boot up for ifupdown. May 01 16:32:41 volumio-wald systemd[1]: Started Create Static Device Nodes in /dev. May 01 16:32:41 volumio-wald systemd[1]: Reached target Local File Systems (Pre). May 01 16:32:41 volumio-wald systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. May 01 16:32:41 volumio-wald systemd[1]: Mounting /var/log... May 01 16:32:41 volumio-wald systemd[1]: Mounting /var/spool/cups... May 01 16:32:41 volumio-wald systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. May 01 16:32:41 volumio-wald systemd[1]: Mounting /tmp... May 01 16:32:41 volumio-wald systemd[1]: Starting udev Kernel Device Manager... May 01 16:32:41 volumio-wald systemd[1]: Mounted /var/log. May 01 16:32:41 volumio-wald systemd[1]: Mounted /var/spool/cups. May 01 16:32:41 volumio-wald systemd[1]: Mounted /tmp. May 01 16:32:41 volumio-wald systemd[1]: Mounting /var/spool/cups/tmp... May 01 16:32:41 volumio-wald systemd[1]: Starting Flush Journal to Persistent Storage... May 01 16:32:41 volumio-wald systemd[1]: Mounted /var/spool/cups/tmp. May 01 16:32:41 volumio-wald systemd-udevd[238]: Network interface NamePolicy= disabled on kernel command line, ignoring. May 01 16:32:41 volumio-wald systemd-journald[204]: Runtime journal (/run/log/journal/6c9b1d414d94da048f39d3e06336abc2) is 3.7M, max 30.0M, 26.2M free. May 01 16:32:41 volumio-wald systemd[1]: Started Flush Journal to Persistent Storage. May 01 16:32:41 volumio-wald systemd[1]: Started udev Kernel Device Manager. May 01 16:32:41 volumio-wald systemd[1]: Starting Show Plymouth Boot Screen... May 01 16:32:42 volumio-wald systemd[1]: Received SIGRTMIN+20 from PID 252 (plymouthd). May 01 16:32:42 volumio-wald systemd[1]: Started Show Plymouth Boot Screen. May 01 16:32:42 volumio-wald systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. May 01 16:32:42 volumio-wald systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 01 16:32:42 volumio-wald systemd[1]: Reached target Local Encrypted Volumes. May 01 16:32:42 volumio-wald systemd[1]: Reached target Paths. May 01 16:32:42 volumio-wald kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. May 01 16:32:42 volumio-wald kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver May 01 16:32:42 volumio-wald kernel: [vc_sm_connected_init]: start May 01 16:32:42 volumio-wald kernel: [vc_sm_connected_init]: installed successfully May 01 16:32:42 volumio-wald kernel: mc: Linux media interface: v0.10 May 01 16:32:42 volumio-wald kernel: rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 May 01 16:32:42 volumio-wald kernel: rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem May 01 16:32:42 volumio-wald kernel: videodev: Linux video capture interface: v2.00 May 01 16:32:42 volumio-wald kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. May 01 16:32:42 volumio-wald kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. May 01 16:32:42 volumio-wald kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller May 01 16:32:42 volumio-wald kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp May 01 16:32:42 volumio-wald systemd[1]: Found device /dev/ttyAMA0. May 01 16:32:42 volumio-wald kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. May 01 16:32:43 volumio-wald systemd-udevd[241]: Using default interface naming scheme 'v240'. May 01 16:32:43 volumio-wald kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. May 01 16:32:43 volumio-wald kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 May 01 16:32:43 volumio-wald kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode May 01 16:32:43 volumio-wald systemd-udevd[241]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 01 16:32:43 volumio-wald kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 May 01 16:32:43 volumio-wald kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode May 01 16:32:43 volumio-wald kernel: usbcore: registered new interface driver uas May 01 16:32:43 volumio-wald kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 May 01 16:32:43 volumio-wald kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp May 01 16:32:43 volumio-wald kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 May 01 16:32:43 volumio-wald kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx May 01 16:32:43 volumio-wald kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 May 01 16:32:43 volumio-wald kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image May 01 16:32:43 volumio-wald kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. May 01 16:32:43 volumio-wald kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored May 01 16:32:43 volumio-wald kernel: bcm2835_audio bcm2835_audio: card created with 4 channels May 01 16:32:43 volumio-wald kernel: bcm2835_audio bcm2835_audio: card created with 4 channels May 01 16:32:43 volumio-wald kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 May 01 16:32:43 volumio-wald systemd-udevd[246]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 01 16:32:43 volumio-wald systemd[1]: Found device /dev/mmcblk0p1. May 01 16:32:43 volumio-wald systemd-udevd[248]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 01 16:32:43 volumio-wald kernel: usb 1-1.4: 2:1: bogus dB values (-12800/-12700), disabling dB reporting May 01 16:32:43 volumio-wald kernel: usbcore: registered new interface driver snd-usb-audio May 01 16:32:45 volumio-wald systemd-udevd[242]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. May 01 16:32:46 volumio-wald systemd[1]: Condition check resulted in SMSC9512/9514 Fast Ethernet Adapter being skipped. May 01 16:32:46 volumio-wald systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 01 16:32:46 volumio-wald systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. May 01 16:32:46 volumio-wald systemd[1]: Condition check resulted in FUSE Control File System being skipped. May 01 16:32:46 volumio-wald systemd[1]: Condition check resulted in Huge Pages File System being skipped. May 01 16:32:46 volumio-wald systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. May 01 16:32:46 volumio-wald systemd[1]: Starting File System Check on /dev/mmcblk0p1... May 01 16:32:46 volumio-wald systemd[1]: Started File System Check Daemon to report status. May 01 16:32:46 volumio-wald systemd-fsck[332]: fsck.fat 4.1 (2017-01-24) May 01 16:32:46 volumio-wald systemd-fsck[332]: /dev/mmcblk0p1: 452 files, 33800/46774 clusters May 01 16:32:46 volumio-wald systemd[1]: Started File System Check on /dev/mmcblk0p1. May 01 16:32:46 volumio-wald systemd[1]: Mounting /boot... May 01 16:32:47 volumio-wald systemd[1]: Mounted /boot. May 01 16:32:47 volumio-wald systemd[1]: Reached target Local File Systems. May 01 16:32:47 volumio-wald systemd[1]: Starting Create Volatile Files and Directories... May 01 16:32:47 volumio-wald systemd[1]: Started ifup for eth0. May 01 16:32:47 volumio-wald systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. May 01 16:32:47 volumio-wald systemd[1]: Starting Raise network interfaces... May 01 16:32:47 volumio-wald systemd[1]: Starting Preprocess NFS configuration... May 01 16:32:47 volumio-wald systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... May 01 16:32:47 volumio-wald systemd[1]: Received SIGRTMIN+20 from PID 252 (plymouthd). May 01 16:32:47 volumio-wald systemd[1]: plymouth-read-write.service: Succeeded. May 01 16:32:47 volumio-wald systemd[1]: Started Tell Plymouth To Write Out Runtime Data. May 01 16:32:47 volumio-wald systemd[1]: nfs-config.service: Succeeded. May 01 16:32:47 volumio-wald systemd[1]: Started Preprocess NFS configuration. May 01 16:32:47 volumio-wald systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. May 01 16:32:47 volumio-wald systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. May 01 16:32:47 volumio-wald systemd[1]: Reached target NFS client services. May 01 16:32:47 volumio-wald systemd[1]: Started Create Volatile Files and Directories. May 01 16:32:47 volumio-wald systemd[1]: Condition check resulted in Network Time Synchronization being skipped. May 01 16:32:47 volumio-wald systemd[1]: Starting Update UTMP about System Boot/Shutdown... May 01 16:32:47 volumio-wald systemd[1]: Starting RPC bind portmap service... May 01 16:32:47 volumio-wald systemd[1]: Started Entropy daemon using the HAVEGE algorithm. May 01 16:32:47 volumio-wald systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. May 01 16:32:47 volumio-wald systemd[1]: Started RPC bind portmap service. May 01 16:32:47 volumio-wald systemd[1]: Reached target Remote File Systems (Pre). May 01 16:32:47 volumio-wald systemd[1]: Reached target Remote File Systems. May 01 16:32:47 volumio-wald systemd[1]: Reached target RPC Port Mapper. May 01 16:32:47 volumio-wald systemd[1]: Started Update UTMP about System Boot/Shutdown. May 01 16:32:47 volumio-wald systemd[1]: Reached target System Initialization. May 01 16:32:47 volumio-wald kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database May 01 16:32:47 volumio-wald systemd[1]: Started Volumio Splash. May 01 16:32:47 volumio-wald systemd[367]: volumiosplash.service: Failed to execute command: No such file or directory May 01 16:32:47 volumio-wald systemd[367]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory May 01 16:32:47 volumio-wald systemd[1]: Listening on D-Bus System Message Bus Socket. May 01 16:32:47 volumio-wald systemd[1]: Started Daily Cleanup of Temporary Directories. May 01 16:32:47 volumio-wald systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. May 01 16:32:47 volumio-wald systemd[1]: Started Daily apt download activities. May 01 16:32:47 volumio-wald systemd[1]: Started Daily apt upgrade and clean activities. May 01 16:32:47 volumio-wald systemd[1]: Reached target Timers. May 01 16:32:47 volumio-wald systemd[1]: Listening on triggerhappy.socket. May 01 16:32:47 volumio-wald systemd[1]: Reached target Sockets. May 01 16:32:47 volumio-wald systemd[1]: Reached target Basic System. May 01 16:32:47 volumio-wald systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. May 01 16:32:47 volumio-wald systemd[1]: Started Volumio Log Rotation Service. May 01 16:32:47 volumio-wald kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' May 01 16:32:47 volumio-wald kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' May 01 16:32:47 volumio-wald systemd[1]: Starting Avahi mDNS/DNS-SD Stack... May 01 16:32:47 volumio-wald kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' May 01 16:32:47 volumio-wald systemd[1]: Started Manage Sound Card State (restore and store). May 01 16:32:47 volumio-wald systemd[1]: Started Volumio Iptables Module. May 01 16:32:47 volumio-wald alsactl[379]: alsactl 1.1.8 daemon started May 01 16:32:47 volumio-wald systemd[1]: Starting Save/Restore Sound Card State... May 01 16:32:47 volumio-wald systemd[1]: Started D-Bus System Message Bus. May 01 16:32:47 volumio-wald ifup[340]: command failed: No such device (-19) May 01 16:32:47 volumio-wald avahi-daemon[378]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). May 01 16:32:47 volumio-wald avahi-daemon[378]: Successfully dropped root privileges. May 01 16:32:47 volumio-wald avahi-daemon[378]: avahi-daemon 0.7 starting up. May 01 16:32:47 volumio-wald systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. May 01 16:32:47 volumio-wald sh[339]: command failed: No such device (-19) May 01 16:32:48 volumio-wald systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... May 01 16:32:48 volumio-wald systemd[1]: Started UPnP Renderer front-end to MPD. May 01 16:32:48 volumio-wald systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. May 01 16:32:48 volumio-wald systemd[1]: Starting Login Service... May 01 16:32:48 volumio-wald systemd[1]: Starting Wireless Services... May 01 16:32:48 volumio-wald systemd[1]: Started volumio-remote-updater.service. May 01 16:32:48 volumio-wald systemd[1]: Starting triggerhappy global hotkey daemon... May 01 16:32:48 volumio-wald systemd[1]: Starting dhcpcd on all interfaces... May 01 16:32:48 volumio-wald systemd[1]: Starting WPA supplicant... May 01 16:32:48 volumio-wald systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped. May 01 16:32:48 volumio-wald systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC May 01 16:32:48 volumio-wald systemd[1]: volumiosplash.service: Failed with result 'exit-code'. May 01 16:32:48 volumio-wald dhcpcd[415]: Not running dhcpcd because /etc/network/interfaces May 01 16:32:48 volumio-wald dhcpcd[415]: defines some interfaces that will use a May 01 16:32:48 volumio-wald dhcpcd[415]: DHCP client or static address May 01 16:32:48 volumio-wald systemd[1]: Started Save/Restore Sound Card State. May 01 16:32:48 volumio-wald systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED May 01 16:32:48 volumio-wald systemd[1]: dhcpcd.service: Failed with result 'exit-code'. May 01 16:32:48 volumio-wald systemd[1]: Failed to start dhcpcd on all interfaces. May 01 16:32:48 volumio-wald thd[410]: Unable to parse trigger line: May 01 16:32:48 volumio-wald thd[410]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle May 01 16:32:48 volumio-wald thd[410]: Unable to parse trigger line: May 01 16:32:48 volumio-wald thd[410]: Found socket passed from systemd May 01 16:32:48 volumio-wald systemd[1]: Started triggerhappy global hotkey daemon. May 01 16:32:48 volumio-wald systemd[1]: Reached target Sound Card. May 01 16:32:48 volumio-wald systemd-logind[402]: New seat seat0. May 01 16:32:48 volumio-wald ifup[340]: command failed: No such device (-19) May 01 16:32:49 volumio-wald kernel: 8021q: 802.1Q VLAN Support v1.8 May 01 16:32:49 volumio-wald volumio-remote-updater[409]: Error: No active session May 01 16:32:49 volumio-wald volumio-remote-updater[409]: [2024-05-01 16:32:49] [info] asio async_connect error: system:111 (Connection refused) May 01 16:32:49 volumio-wald volumio-remote-updater[409]: [2024-05-01 16:32:49] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 01 16:32:49 volumio-wald volumio-remote-updater[409]: [2024-05-01 16:32:49] [error] handle_connect error: Underlying Transport Error May 01 16:32:49 volumio-wald volumio[399]: Could not open config: /tmp/upmpdcli.conf May 01 16:32:49 volumio-wald dbus-daemon[386]: [system] Successfully activated service 'org.freedesktop.systemd1' May 01 16:32:49 volumio-wald avahi-daemon[378]: Successfully called chroot(). May 01 16:32:49 volumio-wald avahi-daemon[378]: Successfully dropped remaining capabilities. May 01 16:32:49 volumio-wald wpa_supplicant[417]: Successfully initialized wpa_supplicant May 01 16:32:49 volumio-wald systemd[1]: Started WPA supplicant. May 01 16:32:49 volumio-wald systemd[1]: Started Login Service. May 01 16:32:49 volumio-wald systemd[1]: Started Avahi mDNS/DNS-SD Stack. May 01 16:32:49 volumio-wald systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 01 16:32:49 volumio-wald systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 01 16:32:49 volumio-wald avahi-daemon[378]: Loading service file /services/volumio.service. May 01 16:32:49 volumio-wald avahi-daemon[378]: Network interface enumeration completed. May 01 16:32:49 volumio-wald avahi-daemon[378]: Server startup complete. Host name is volumio-wald.local. Local service cookie is 671565826. May 01 16:32:49 volumio-wald avahi-daemon[378]: Service "Volumio Wald" (/services/volumio.service) successfully established. May 01 16:32:49 volumio-wald loadcpufreq[395]: Loading cpufreq kernel modules...done (none). May 01 16:32:49 volumio-wald systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. May 01 16:32:50 volumio-wald systemd[1]: Starting LSB: set CPUFreq kernel parameters... May 01 16:32:50 volumio-wald sh[339]: eth0: waiting for carrier May 01 16:32:50 volumio-wald dhcpcd[420]: eth0: waiting for carrier May 01 16:32:50 volumio-wald kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup May 01 16:32:50 volumio-wald kernel: smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control off May 01 16:32:50 volumio-wald sh[339]: eth0: carrier acquired May 01 16:32:50 volumio-wald dhcpcd[420]: eth0: carrier acquired May 01 16:32:50 volumio-wald systemd[1]: iptables.service: Succeeded. May 01 16:32:50 volumio-wald sh[339]: DUID 00:01:00:01:2a:c9:69:f8:b8:27:eb:30:24:48 May 01 16:32:50 volumio-wald sh[339]: eth0: IAID eb:30:24:48 May 01 16:32:50 volumio-wald dhcpcd[420]: DUID 00:01:00:01:2a:c9:69:f8:b8:27:eb:30:24:48 May 01 16:32:50 volumio-wald sh[339]: eth0: adding address fe80::5004:36f0:3463:ead May 01 16:32:50 volumio-wald sh[339]: ipv6_addaddr1: Permission denied May 01 16:32:50 volumio-wald dhcpcd[420]: eth0: IAID eb:30:24:48 May 01 16:32:50 volumio-wald dhcpcd[420]: eth0: adding address fe80::5004:36f0:3463:ead May 01 16:32:50 volumio-wald dhcpcd[420]: ipv6_addaddr1: Permission denied May 01 16:32:50 volumio-wald systemd[1]: Started Raise network interfaces. May 01 16:32:50 volumio-wald systemd[1]: Reached target Network. May 01 16:32:50 volumio-wald systemd[1]: Starting Permit User Sessions... May 01 16:32:50 volumio-wald systemd[1]: Starting OpenBSD Secure Shell server... May 01 16:32:50 volumio-wald systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. May 01 16:32:50 volumio-wald sh[339]: eth0: soliciting an IPv6 router May 01 16:32:50 volumio-wald dhcpcd[420]: eth0: soliciting an IPv6 router May 01 16:32:50 volumio-wald systemd[1]: Starting Network Time Service... May 01 16:32:50 volumio-wald systemd[1]: Reached target Network is Online. May 01 16:32:50 volumio-wald systemd[1]: Starting /etc/rc.local Compatibility... May 01 16:32:50 volumio-wald cpufrequtils[504]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. May 01 16:32:50 volumio-wald systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 01 16:32:50 volumio-wald sh[339]: eth0: soliciting a DHCP lease May 01 16:32:50 volumio-wald dhcpcd[420]: eth0: soliciting a DHCP lease May 01 16:32:50 volumio-wald systemd[1]: Starting LSB: Brings up/down network automatically... May 01 16:32:50 volumio-wald systemd[1]: Starting Samba NMB Daemon... May 01 16:32:50 volumio-wald sh[339]: eth0: offered 192.168.1.22 from 192.168.1.1 May 01 16:32:50 volumio-wald dhcpcd[420]: eth0: offered 192.168.1.22 from 192.168.1.1 May 01 16:32:50 volumio-wald sh[339]: eth0: probing address 192.168.1.22/24 May 01 16:32:50 volumio-wald dhcpcd[420]: eth0: probing address 192.168.1.22/24 May 01 16:32:50 volumio-wald systemd[1]: Started LSB: set CPUFreq kernel parameters. May 01 16:32:50 volumio-wald systemd[1]: Started Permit User Sessions. May 01 16:32:50 volumio-wald systemd[1]: Started /etc/rc.local Compatibility. May 01 16:32:50 volumio-wald systemd[1]: Starting Terminate Plymouth Boot Screen... May 01 16:32:50 volumio-wald systemd[1]: Starting Hold until boot process finishes up... May 01 16:32:50 volumio-wald systemd[1]: plymouth-start.service: Succeeded. May 01 16:32:51 volumio-wald systemd[1]: plymouth-quit.service: Succeeded. May 01 16:32:51 volumio-wald systemd[1]: Started Terminate Plymouth Boot Screen. May 01 16:32:51 volumio-wald systemd[1]: plymouth-quit-wait.service: Succeeded. May 01 16:32:51 volumio-wald systemd[1]: Started Hold until boot process finishes up. May 01 16:32:51 volumio-wald systemd[1]: Received SIGRTMIN+21 from PID 252 (n/a). May 01 16:32:51 volumio-wald systemd[1]: Received SIGRTMIN+21 from PID 252 (n/a). May 01 16:32:51 volumio-wald systemd[1]: Started Getty on tty1. May 01 16:32:51 volumio-wald ifplugd(eth0)[570]: ifplugd 0.28 initializing. May 01 16:32:51 volumio-wald ifplugd(eth0)[570]: Using interface eth0/B8:27:EB:30:24:48 with driver (version: 6.1.69-v7+) May 01 16:32:51 volumio-wald ifplugd(eth0)[570]: Using detection mode: SIOCETHTOOL May 01 16:32:51 volumio-wald ifplugd(eth0)[570]: Initialization complete, link beat detected. May 01 16:32:51 volumio-wald ntpd[536]: ntpd 4.2.8p12@1.3728-o (1): Starting May 01 16:32:51 volumio-wald ntpd[536]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 May 01 16:32:51 volumio-wald systemd[1]: Started Serial Getty on ttyAMA0. May 01 16:32:51 volumio-wald sshd[558]: Server listening on 0.0.0.0 port 22. May 01 16:32:51 volumio-wald sshd[558]: Server listening on :: port 22. May 01 16:32:51 volumio-wald systemd[1]: Reached target Login Prompts. May 01 16:32:51 volumio-wald systemd[1]: Started OpenBSD Secure Shell server. May 01 16:32:51 volumio-wald systemd[1]: Started Network Time Service. May 01 16:32:51 volumio-wald ntpd[572]: proto: precision = 1.093 usec (-20) May 01 16:32:51 volumio-wald ifplugd(eth0)[570]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. May 01 16:32:51 volumio-wald ntpd[572]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 01 16:32:51 volumio-wald ntpd[572]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 01 16:32:51 volumio-wald ntpd[572]: Listen and drop on 0 v6wildcard [::]:123 May 01 16:32:51 volumio-wald ntpd[572]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 01 16:32:51 volumio-wald ntpd[572]: Listen normally on 2 lo 127.0.0.1:123 May 01 16:32:51 volumio-wald ntpd[572]: Listening on routing socket on fd #19 for interface updates May 01 16:32:51 volumio-wald ntpd[572]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 01 16:32:51 volumio-wald ntpd[572]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 01 16:32:51 volumio-wald haveged[366]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K May 01 16:32:51 volumio-wald haveged[366]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 May 01 16:32:51 volumio-wald haveged[366]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00279 May 01 16:32:51 volumio-wald haveged[366]: haveged: fills: 0, generated: 0 May 01 16:32:51 volumio-wald ifplugd(eth0)[570]: client: ifup: waiting for lock on /run/network/ifstate.eth0 May 01 16:32:52 volumio-wald nmbd[553]: [2024/05/01 16:32:52.098384, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) May 01 16:32:52 volumio-wald nmbd[553]: started asyncdns process 580 May 01 16:32:52 volumio-wald nmbd[553]: [2024/05/01 16:32:52.104036, 0] ../lib/util/become_daemon.c:149(daemon_status) May 01 16:32:52 volumio-wald nmbd[553]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... May 01 16:32:52 volumio-wald nmbd[553]: [2024/05/01 16:32:52.104468, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) May 01 16:32:52 volumio-wald nmbd[553]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). May 01 16:32:52 volumio-wald ntpd[572]: error resolving pool 0.debian.pool.ntp.org: System error (-11) May 01 16:32:52 volumio-wald wireless.js[405]: WIRELESS: No wireless interface, exiting May 01 16:32:52 volumio-wald iw[585]: command failed: No such device (-19) May 01 16:32:53 volumio-wald iwconfig[588]: Error for wireless request "Set Power Management" (8B2C) : May 01 16:32:53 volumio-wald iwconfig[588]: SET failed on device wlan0 ; No such device. May 01 16:32:53 volumio-wald systemd[1]: wireless.service: Succeeded. May 01 16:32:53 volumio-wald systemd[1]: Started Wireless Services. May 01 16:32:53 volumio-wald systemd[1]: Started Volumio Backend Module. May 01 16:32:53 volumio-wald systemd[1]: Started Volumio Cpu Tweaker. May 01 16:32:53 volumio-wald ntpd[572]: error resolving pool 1.debian.pool.ntp.org: System error (-11) May 01 16:32:53 volumio-wald volumio-cpu-tweak[592]: Setting RT Priority for mpd May 01 16:32:53 volumio-wald volumio-cpu-tweak[592]: pid 35's current scheduling policy: SCHED_OTHER May 01 16:32:53 volumio-wald volumio-cpu-tweak[592]: pid 35's current scheduling priority: 0 May 01 16:32:53 volumio-wald volumio-cpu-tweak[592]: Setting MPD Affinity May 01 16:32:53 volumio-wald volumio-cpu-tweak[592]: pid 3's current affinity mask: f May 01 16:32:53 volumio-wald volumio-cpu-tweak[592]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 01 16:32:53 volumio-wald volumio-cpu-tweak[592]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 01 16:32:53 volumio-wald systemd[1]: volumio_cpu_tweak.service: Succeeded. May 01 16:32:54 volumio-wald ntpd[572]: error resolving pool 2.debian.pool.ntp.org: System error (-11) May 01 16:32:54 volumio-wald volumio-remote-updater[409]: [2024-05-01 16:32:54] [info] asio async_connect error: system:111 (Connection refused) May 01 16:32:54 volumio-wald volumio-remote-updater[409]: [2024-05-01 16:32:54] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 01 16:32:54 volumio-wald volumio-remote-updater[409]: [2024-05-01 16:32:54] [error] handle_connect error: Underlying Transport Error May 01 16:32:55 volumio-wald ntpd[572]: error resolving pool 3.debian.pool.ntp.org: System error (-11) May 01 16:32:55 volumio-wald sh[339]: eth0: leased 192.168.1.22 for 86400 seconds May 01 16:32:55 volumio-wald dhcpcd[420]: eth0: leased 192.168.1.22 for 86400 seconds May 01 16:32:55 volumio-wald avahi-daemon[378]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.22. May 01 16:32:55 volumio-wald sh[339]: eth0: adding route to 192.168.1.0/24 May 01 16:32:55 volumio-wald sh[339]: eth0: adding default route via 192.168.1.1 May 01 16:32:55 volumio-wald dhcpcd[420]: eth0: adding route to 192.168.1.0/24 May 01 16:32:55 volumio-wald avahi-daemon[378]: New relevant interface eth0.IPv4 for mDNS. May 01 16:32:55 volumio-wald dhcpcd[420]: eth0: adding default route via 192.168.1.1 May 01 16:32:55 volumio-wald avahi-daemon[378]: Registering new address record for 192.168.1.22 on eth0.IPv4. May 01 16:32:55 volumio-wald sh[339]: forked to background, child pid 629 May 01 16:32:55 volumio-wald dhcpcd[420]: forked to background, child pid 629 May 01 16:32:56 volumio-wald ifplugd(eth0)[570]: client: ifup: interface eth0 already configured May 01 16:32:56 volumio-wald sh[339]: eth0=eth0 May 01 16:32:56 volumio-wald ifplugd(eth0)[570]: Program executed successfully. May 01 16:32:56 volumio-wald ifplugd[540]: Network Interface Plugging Daemon...start eth0...done. May 01 16:32:56 volumio-wald systemd[1]: Started LSB: Brings up/down network automatically. May 01 16:32:57 volumio-wald ntpd[572]: Listen normally on 3 eth0 192.168.1.22:123 May 01 16:32:57 volumio-wald ntpd[572]: new interface(s) found: waking up resolver May 01 16:32:57 volumio-wald nmbd[553]: [2024/05/01 16:32:57.122436, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 01 16:32:57 volumio-wald systemd[1]: Started Samba NMB Daemon. May 01 16:32:57 volumio-wald nmbd[553]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 01 16:32:57 volumio-wald systemd[1]: Starting Samba Winbind Daemon... May 01 16:32:57 volumio-wald winbindd[655]: [2024/05/01 16:32:57.779967, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 01 16:32:57 volumio-wald winbindd[655]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 01 16:32:57 volumio-wald winbindd[655]: [2024/05/01 16:32:57.858739, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 01 16:32:57 volumio-wald winbindd[655]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 01 16:32:57 volumio-wald systemd[1]: Started Samba Winbind Daemon. May 01 16:32:57 volumio-wald systemd[1]: Starting Samba SMB Daemon... May 01 16:32:58 volumio-wald volumio[591]: info: ------------------------------------------- May 01 16:32:58 volumio-wald volumio[591]: info: ----- Volumio3 ---- May 01 16:32:58 volumio-wald volumio[591]: info: ------------------------------------------- May 01 16:32:58 volumio-wald volumio[591]: info: ----- System startup ---- May 01 16:32:58 volumio-wald volumio[591]: info: ------------------------------------------- May 01 16:32:58 volumio-wald smbd[668]: [2024/05/01 16:32:58.879338, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 01 16:32:58 volumio-wald systemd[1]: Started Samba SMB Daemon. May 01 16:32:58 volumio-wald systemd[1]: Reached target Multi-User System. May 01 16:32:58 volumio-wald systemd[1]: Reached target Graphical Interface. May 01 16:32:58 volumio-wald smbd[668]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 01 16:32:58 volumio-wald systemd[1]: Starting Update UTMP about System Runlevel Changes... May 01 16:32:59 volumio-wald systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 01 16:32:59 volumio-wald systemd[1]: Started Update UTMP about System Runlevel Changes. May 01 16:32:59 volumio-wald systemd[1]: Startup finished in 10.719s (kernel) + 20.652s (userspace) = 31.371s. May 01 16:33:00 volumio-wald volumio[591]: info: MYVOLUMIO Environment detected May 01 16:33:01 volumio-wald volumio[591]: info: Plugin folders cleanup May 01 16:33:01 volumio-wald volumio[591]: info: Scanning into folder /volumio/app/plugins/ May 01 16:33:01 volumio-wald volumio[591]: info: Scanning category audio_interface May 01 16:33:01 volumio-wald volumio[591]: info: Scanning category miscellanea May 01 16:33:01 volumio-wald volumio[591]: info: Scanning category music_service May 01 16:33:01 volumio-wald volumio[591]: info: Scanning category plugins.json May 01 16:33:01 volumio-wald volumio[591]: info: Scanning category system_controller May 01 16:33:01 volumio-wald volumio[591]: info: Scanning category user_interface May 01 16:33:01 volumio-wald volumio[591]: info: Scanning into folder /data/plugins/ May 01 16:33:01 volumio-wald volumio[591]: info: Scanning category audio_interface May 01 16:33:01 volumio-wald volumio[591]: info: Plugin folders cleanup completed May 01 16:33:01 volumio-wald volumio[591]: info: ------------------------------------------- May 01 16:33:01 volumio-wald volumio[591]: info: ----- Core plugins startup ---- May 01 16:33:01 volumio-wald volumio[591]: info: ------------------------------------------- May 01 16:33:01 volumio-wald volumio[591]: info: Loading plugins from folder /volumio/app/plugins/ May 01 16:33:01 volumio-wald volumio[591]: info: Adding plugin upnp to MyMusic Plugins May 01 16:33:01 volumio-wald volumio[591]: info: Adding plugin airplay_emulation to MyMusic Plugins May 01 16:33:01 volumio-wald volumio[591]: info: Adding plugin upnp_browser to MyMusic Plugins May 01 16:33:01 volumio-wald volumio[591]: info: Loading plugins from folder /data/plugins/ May 01 16:33:01 volumio-wald volumio[591]: info: Loading plugin "system"... May 01 16:33:01 volumio-wald volumio[591]: info: Loading plugin "appearance"... May 01 16:33:01 volumio-wald volumio-remote-updater[409]: [2024-05-01 16:33:01] [connect] Successful connection May 01 16:33:03 volumio-wald volumio[591]: info: Loading plugin "network"... May 01 16:33:04 volumio-wald volumio[591]: info: Refreshing Cached IP Addresses May 01 16:33:04 volumio-wald volumio[591]: info: Loading plugin "services"... May 01 16:33:04 volumio-wald volumio[591]: info: Loading plugin "alsa_controller"... May 01 16:33:04 volumio-wald sudo[687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 01 16:33:04 volumio-wald sudo[683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 16:33:04 volumio-wald sudo[685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 16:33:04 volumio-wald sudo[683]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 16:33:04 volumio-wald sudo[685]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 16:33:04 volumio-wald sudo[687]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 16:33:04 volumio-wald sudo[683]: pam_unix(sudo:session): session closed for user root May 01 16:33:04 volumio-wald sudo[685]: pam_unix(sudo:session): session closed for user root May 01 16:33:04 volumio-wald sudo[687]: pam_unix(sudo:session): session closed for user root May 01 16:33:04 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 01 16:33:04 volumio-wald volumio[591]: info: Loading plugin "wizard"... May 01 16:33:04 volumio-wald volumio[591]: info: Loading plugin "networkfs"... May 01 16:33:04 volumio-wald volumio[591]: info: Starting Udev Watcher for removable devices May 01 16:33:04 volumio-wald sudo[700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=share,password=Go0dMusiK,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.10/Share/Musik /mnt/NAS/Musik May 01 16:33:04 volumio-wald sudo[700]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 16:33:04 volumio-wald volumio[591]: info: Ignoring mount for partition: boot May 01 16:33:04 volumio-wald volumio[591]: info: Ignoring mount for partition: volumio May 01 16:33:04 volumio-wald volumio[591]: info: Ignoring mount for partition: volumio_data May 01 16:33:04 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 16:33:04 volumio-wald volumio[591]: info: Loading plugin "volumio_command_line_client"... May 01 16:33:04 volumio-wald volumio[591]: info: Plugin upnp is not enabled May 01 16:33:04 volumio-wald volumio[591]: info: Loading plugin "my_music"... May 01 16:33:04 volumio-wald volumio[591]: info: Loading plugin "mpd"... May 01 16:33:04 volumio-wald kernel: Key type cifs.spnego registered May 01 16:33:04 volumio-wald kernel: Key type cifs.idmap registered May 01 16:33:04 volumio-wald 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. May 01 16:33:04 volumio-wald kernel: CIFS: Attempting to mount \\192.168.1.10\Share May 01 16:33:05 volumio-wald sudo[700]: pam_unix(sudo:session): session closed for user root May 01 16:33:05 volumio-wald volumio[591]: info: Plugin upnp_browser is not enabled May 01 16:33:05 volumio-wald volumio[591]: info: Loading plugin "alarm-clock"... May 01 16:33:06 volumio-wald volumio[591]: info: Loading plugin "airplay_emulation"... May 01 16:33:06 volumio-wald volumio[591]: info: Starting Shairport Sync May 01 16:33:06 volumio-wald volumio[591]: info: Loading plugin "last_100"... May 01 16:33:06 volumio-wald volumio[591]: info: Loading plugin "webradio"... May 01 16:33:06 volumio-wald volumio[591]: info: Loading plugin "i2s_dacs"... May 01 16:33:06 volumio-wald volumio[591]: info: Loading plugin "volumiodiscovery"... May 01 16:33:06 volumio-wald volumio[591]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 16:33:06 volumio-wald volumio[591]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 16:33:06 volumio-wald volumio[591]: *** WARNING *** For more information see May 01 16:33:06 volumio-wald volumio[591]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 16:33:06 volumio-wald volumio[591]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 16:33:06 volumio-wald volumio[591]: *** WARNING *** For more information see May 01 16:33:06 volumio-wald node[591]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 16:33:06 volumio-wald node[591]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 16:33:06 volumio-wald node[591]: *** WARNING *** For more information see May 01 16:33:06 volumio-wald node[591]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 16:33:06 volumio-wald node[591]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 16:33:06 volumio-wald node[591]: *** WARNING *** For more information see May 01 16:33:06 volumio-wald volumio[591]: info: Applying required configuration parameters for plugin volumiodiscovery May 01 16:33:06 volumio-wald volumio[591]: info: Discovery: Started advertising with name: Volumio Wald May 01 16:33:06 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 16:33:06 volumio-wald volumio[591]: info: Loading plugin "outputs"... May 01 16:33:06 volumio-wald volumio[591]: info: Loading plugin "albumart"... May 01 16:33:06 volumio-wald volumio[591]: info: Plugin example_plugin is not enabled May 01 16:33:06 volumio-wald volumio[591]: info: Loading plugin "inputs"... May 01 16:33:06 volumio-wald volumio[591]: info: Loading plugin "updater_comm"... May 01 16:33:07 volumio-wald volumio[591]: info: Plugin mpdemulation is not enabled May 01 16:33:07 volumio-wald volumio[591]: info: Loading plugin "rest_api"... May 01 16:33:07 volumio-wald volumio[591]: info: Loading plugin "websocket"... May 01 16:33:07 volumio-wald volumio[591]: info: Loading plugin "fusiondsp"... May 01 16:33:07 volumio-wald volumio[591]: Forking 3 albumart workers May 01 16:33:08 volumio-wald volumio[591]: info: Applying required configuration parameters for plugin fusiondsp May 01 16:33:09 volumio-wald volumio[591]: info: Loading i18n strings for locale de May 01 16:33:09 volumio-wald volumio[591]: Updating browse sources language May 01 16:33:09 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 16:33:09 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 16:33:09 volumio-wald volumio[591]: info: CoreCommandRouter::initPlayerControls May 01 16:33:09 volumio-wald volumio[591]: Starting albumart workers May 01 16:33:10 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 16:33:10 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 16:33:10 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 16:33:10 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 16:33:10 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 16:33:10 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 16:33:10 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 16:33:10 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 16:33:10 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 16:33:10 volumio-wald volumio[591]: Express server listening on port 3000 May 01 16:33:10 volumio-wald volumio[591]: [Metrics] WebUI: 13s 556.74ms May 01 16:33:10 volumio-wald volumio[591]: Starting albumart workers May 01 16:33:10 volumio-wald volumio[591]: info: CoreStateMachine::resetVolumioState May 01 16:33:10 volumio-wald volumio[591]: info: CoreStateMachine::getcurrentVolume May 01 16:33:10 volumio-wald volumio[591]: info: CoreCommandRouter::volumioRetrievevolume May 01 16:33:10 volumio-wald volumio[591]: Starting albumart workers May 01 16:33:10 volumio-wald volumio[591]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 01 16:33:10 volumio-wald volumio[591]: wlan0 Interface doesn't support scanning. May 01 16:33:10 volumio-wald volumio[591]: info: Cannot use regular scanning, forcing with ap-force May 01 16:33:10 volumio-wald sudo[765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 01 16:33:10 volumio-wald sudo[765]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 16:33:10 volumio-wald sudo[765]: pam_unix(sudo:session): session closed for user root May 01 16:33:10 volumio-wald volumio[591]: command failed: No such device (-19) May 01 16:33:10 volumio-wald volumio[591]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force May 01 16:33:10 volumio-wald volumio[591]: command failed: No such device (-19) May 01 16:33:10 volumio-wald volumio[591]: verbose: New Socket.io Connection to 192.168.1.22:3000 from 192.168.1.20 UA: node-XMLHttpRequest Total Clients: 1 May 01 16:33:10 volumio-wald volumio[591]: verbose: New Socket.io Connection to 192.168.1.22:3000 from 192.168.1.20 UA: node-XMLHttpRequest Total Clients: 2 May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetState May 01 16:33:11 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:11 volumio-wald volumio[591]: info: Reloading queue from file May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 16:33:11 volumio-wald volumio[591]: info: VolumeController:: Volume=44 Mute =false May 01 16:33:11 volumio-wald volumio[591]: info: CoreStateMachine::pushState May 01 16:33:11 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::volumioPushState May 01 16:33:11 volumio-wald volumio[591]: info: CoreStateMachine::updateTrackBlock May 01 16:33:11 volumio-wald volumio[591]: info: CorePlayQueue::getTrackBlock May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::volumioRetrievevolume May 01 16:33:11 volumio-wald volumio[591]: info: CoreStateMachine::setRepeat null single undefined May 01 16:33:11 volumio-wald volumio[591]: info: CoreStateMachine::pushState May 01 16:33:11 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::volumioPushState May 01 16:33:11 volumio-wald volumio[591]: info: CoreStateMachine::setRandom true May 01 16:33:11 volumio-wald volumio[591]: info: CoreStateMachine::pushState May 01 16:33:11 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::volumioPushState May 01 16:33:11 volumio-wald volumio[591]: info: Setting Device type: Raspberry PI May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetState May 01 16:33:11 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:11 volumio-wald volumio[591]: info: VolumeController:: Volume=44 Mute =false May 01 16:33:11 volumio-wald volumio[591]: info: CoreStateMachine::pushState May 01 16:33:11 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::volumioPushState May 01 16:33:11 volumio-wald volumio[591]: info: Discovery: adding 80cb75e5-178f-4b1a-abb3-8510604ba9f3 May 01 16:33:11 volumio-wald volumio[591]: info: Discovery: Found device Volumio Wald May 01 16:33:11 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetState May 01 16:33:11 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:11 volumio-wald volumio[591]: info: Discovery: adding fbbe472b-e9e2-4719-a841-f1437a9a3aeb May 01 16:33:11 volumio-wald volumio[591]: info: Discovery: Found device Volumio Wohnzimmer May 01 16:33:11 volumio-wald volumio[591]: info: Discovery: Connecting to remote: 192.168.1.20 May 01 16:33:12 volumio-wald volumio[591]: info: Discovery: Connected to remote: 192.168.1.20 May 01 16:33:15 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 16:33:15 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 16:33:15 volumio-wald volumio[591]: info: Discovery: Getting this device information May 01 16:33:15 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetState May 01 16:33:15 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:15 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 16:33:15 volumio-wald volumio[591]: verbose: New Socket.io Connection to 192.168.1.22 from 192.168.1.100 UA: unknown Total Clients: 3 May 01 16:33:16 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetState May 01 16:33:16 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:16 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 01 16:33:16 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 01 16:33:16 volumio-wald volumio-remote-updater[409]: [2024-05-01 16:33:16] [connect] Successful connection May 01 16:33:16 volumio-wald volumio-remote-updater[409]: [2024-05-01 16:33:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714581196 101 May 01 16:33:16 volumio-wald volumio[591]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 4 May 01 16:33:16 volumio-wald systemd[1]: systemd-fsckd.service: Succeeded. May 01 16:33:18 volumio-wald sudo[803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 16:33:18 volumio-wald sudo[803]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 16:33:18 volumio-wald sudo[803]: pam_unix(sudo:session): session closed for user root May 01 16:33:18 volumio-wald sudo[805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 16:33:18 volumio-wald sudo[805]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 16:33:18 volumio-wald sudo[805]: pam_unix(sudo:session): session closed for user root May 01 16:33:18 volumio-wald volumio[591]: verbose: New Socket.io Connection to 192.168.1.22 from 192.168.1.100 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5 May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetVisibleSources May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetState May 01 16:33:18 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 16:33:18 volumio-wald volumio[591]: info: Received Get System Info May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 16:33:18 volumio-wald volumio[591]: info: Discovery: Getting this device information May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetState May 01 16:33:18 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetState May 01 16:33:18 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:18 volumio-wald volumio[591]: info: Listing playlists May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 01 16:33:18 volumio-wald volumio[591]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 16:33:20 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 16:33:20 volumio-wald volumio[591]: info: Received Get System Info May 01 16:33:20 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 16:33:20 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 16:33:20 volumio-wald volumio[591]: info: Discovery: Getting this device information May 01 16:33:20 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetState May 01 16:33:20 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:20 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 16:33:20 volumio-wald volumio[591]: info: CoreCommandRouter::volumioPlay May 01 16:33:20 volumio-wald volumio[591]: info: CoreStateMachine::play index undefined May 01 16:33:20 volumio-wald volumio[591]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 16:33:20 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:20 volumio-wald volumio[591]: info: CoreStateMachine::startPlaybackTimer May 01 16:33:20 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:20 volumio-wald volumio[591]: verbose: ControllerMpd::clearAddPlayTracks NAS/Musik/02 - ALBEN - NON ROCK/Thievery Corporation/2020 - Symphonik/ 01 - Heaven's Gonna Burn Your Eyes (feat. Natalia Clavier).mp3 May 01 16:33:20 volumio-wald volumio[591]: verbose: ControllerMpd::sendMpdCommand stop May 01 16:33:20 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 01 16:33:22 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 16:33:22 volumio-wald volumio[591]: info: Received Get System Info May 01 16:33:22 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 16:33:22 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 16:33:22 volumio-wald volumio[591]: info: Discovery: Getting this device information May 01 16:33:22 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetState May 01 16:33:22 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:22 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 16:33:22 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 01 16:33:25 volumio-wald volumio[591]: info: CoreCommandRouter::volumioPlay May 01 16:33:25 volumio-wald volumio[591]: info: CoreStateMachine::play index undefined May 01 16:33:25 volumio-wald volumio[591]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 16:33:25 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:25 volumio-wald volumio[591]: info: CoreStateMachine::startPlaybackTimer May 01 16:33:25 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:25 volumio-wald volumio[591]: verbose: ControllerMpd::clearAddPlayTracks NAS/Musik/02 - ALBEN - NON ROCK/Thievery Corporation/2020 - Symphonik/ 01 - Heaven's Gonna Burn Your Eyes (feat. Natalia Clavier).mp3 May 01 16:33:25 volumio-wald volumio[591]: verbose: ControllerMpd::sendMpdCommand stop May 01 16:33:26 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetQueue May 01 16:33:26 volumio-wald volumio[591]: info: CoreStateMachine::getQueue May 01 16:33:26 volumio-wald volumio[591]: info: CorePlayQueue::getQueue May 01 16:33:27 volumio-wald volumio[591]: info: CoreCommandRouter::volumioGetState May 01 16:33:27 volumio-wald volumio[591]: info: CorePlayQueue::getTrack 0 May 01 16:33:27 volumio-wald volumio[591]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 16:33:27 volumio-wald volumio[591]: info: CURURI: playlists May 01 16:33:27 volumio-wald volumio[591]: info: Listing playlists May 01 16:33:27 volumio-wald volumio[591]: info: Preload queue cleared May 01 16:33:31 volumio-wald volumio[591]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 16:33:31 volumio-wald volumio[591]: info: CoreStateMachine::ClearQueue May 01 16:33:31 volumio-wald volumio[591]: info: CoreStateMachine::stop May 01 16:33:31 volumio-wald volumio[591]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 16:33:31 volumio-wald volumio[591]: info: CorePlayQueue::clearPlayQueue May 01 16:33:31 volumio-wald volumio[591]: info: CorePlayQueue::saveQueue May 01 16:33:31 volumio-wald volumio[591]: info: CoreCommandRouter::volumioPushQueue May 01 16:33:31 volumio-wald volumio[591]: info: Play playlist Session Dub May 01 16:33:31 volumio-wald volumio[591]: info: CoreCommandRouter::volumioClearQueue May 01 16:33:31 volumio-wald volumio[591]: info: CoreStateMachine::ClearQueue May 01 16:33:31 volumio-wald volumio[591]: info: CoreStateMachine::stop May 01 16:33:31 volumio-wald volumio[591]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 16:33:31 volumio-wald volumio[591]: info: CorePlayQueue::clearPlayQueue May 01 16:33:31 volumio-wald volumio[591]: info: CorePlayQueue::saveQueue May 01 16:33:31 volumio-wald volumio[591]: info: CoreCommandRouter::volumioPushState May 01 16:33:31 volumio-wald volumio[591]: info: CoreCommandRouter::volumioPushQueue May 01 16:33:31 volumio-wald volumio[591]: info: CoreCommandRouter::volumioAddQueueItems May 01 16:33:31 volumio-wald volumio[591]: info: CoreStateMachine::addQueueItems May 01 16:33:31 volumio-wald volumio[591]: info: CorePlayQueue::addQueueItems May 01 16:33:31 volumio-wald volumio[591]: info: Preload queue cleared May 01 16:33:31 volumio-wald volumio[591]: info: Adding Item to queue: mnt/NAS/Musik/02 - ALBEN - NON ROCK/Fat Freddy's Drop/2009 - Dr. Boondigga & The Big BW/02 - Shiverman.mp3 May 01 16:33:31 volumio-wald volumio[591]: info: Exploding uri mnt/NAS/Musik/02 - ALBEN - NON ROCK/Fat Freddy's Drop/2009 - Dr. Boondigga & The Big BW/02 - Shiverman.mp3 in service mpd May 01 16:33:31 volumio-wald volumio[591]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 16:33:31 volumio-wald volumio[591]: TypeError: Cannot read property 'then' of undefined May 01 16:33:31 volumio-wald volumio[591]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) May 01 16:33:31 volumio-wald volumio[591]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) May 01 16:33:31 volumio-wald volumio[591]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16) May 01 16:33:31 volumio-wald volumio[591]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) May 01 16:33:31 volumio-wald volumio[591]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) May 01 16:33:31 volumio-wald volumio[591]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) May 01 16:33:31 volumio-wald volumio[591]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) May 01 16:33:31 volumio-wald volumio[591]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:447:28) May 01 16:33:31 volumio-wald volumio[591]: at /volumio/app/playlistManager.js:726:30 May 01 16:33:31 volumio-wald volumio[591]: at /volumio/node_modules/jsonfile/index.js:46:5 May 01 16:33:31 volumio-wald volumio[591]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 16:33:32 volumio-wald sudo[819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 16:32 May 01 16:33:32 volumio-wald sudo[819]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"