-- Logs begin at Mon 2024-05-06 10:14:23 CEST, end at Mon 2024-05-06 10:15:11 CEST. -- May 06 10:14:23 piaudio kernel: Booting Linux on physical CPU 0x0 May 06 10:14:23 piaudio 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 06 10:14:23 piaudio kernel: CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d May 06 10:14:23 piaudio kernel: CPU: div instructions available: patching division code May 06 10:14:23 piaudio kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache May 06 10:14:23 piaudio kernel: OF: fdt: Machine model: Raspberry Pi 3 Model B Rev 1.2 May 06 10:14:23 piaudio kernel: random: crng init done May 06 10:14:23 piaudio kernel: Memory policy: Data cache writealloc May 06 10:14:23 piaudio kernel: Reserved memory: created CMA memory pool at 0x34000000, size 64 MiB May 06 10:14:23 piaudio kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool May 06 10:14:23 piaudio kernel: Zone ranges: May 06 10:14:23 piaudio kernel: DMA [mem 0x0000000000000000-0x0000000037ffffff] May 06 10:14:23 piaudio kernel: Normal empty May 06 10:14:23 piaudio kernel: Movable zone start for each node May 06 10:14:23 piaudio kernel: Early memory node ranges May 06 10:14:23 piaudio kernel: node 0: [mem 0x0000000000000000-0x0000000037ffffff] May 06 10:14:23 piaudio kernel: Initmem setup node 0 [mem 0x0000000000000000-0x0000000037ffffff] May 06 10:14:23 piaudio kernel: percpu: Embedded 17 pages/cpu s37012 r8192 d24428 u69632 May 06 10:14:23 piaudio kernel: pcpu-alloc: s37012 r8192 d24428 u69632 alloc=17*4096 May 06 10:14:23 piaudio kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 May 06 10:14:23 piaudio kernel: Built 1 zonelists, mobility grouping on. Total pages: 227360 May 06 10:14:23 piaudio 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 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 May 06 10:14:23 piaudio kernel: Kernel parameter elevator= does not have any effect anymore. Please use sysfs to set IO scheduler for individual devices. May 06 10:14:23 piaudio kernel: Unknown kernel command line parameters "splash imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh bootdelay=5", will be passed to user space. May 06 10:14:23 piaudio kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) May 06 10:14:23 piaudio kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) May 06 10:14:23 piaudio kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 06 10:14:23 piaudio kernel: Memory: 811480K/917504K available (10240K kernel code, 1455K rwdata, 3144K rodata, 1024K init, 611K bss, 40488K reserved, 65536K cma-reserved) May 06 10:14:23 piaudio kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 06 10:14:23 piaudio kernel: ftrace: allocating 34929 entries in 103 pages May 06 10:14:23 piaudio kernel: ftrace: allocated 103 pages with 5 groups May 06 10:14:23 piaudio kernel: trace event string verifier disabled May 06 10:14:23 piaudio kernel: rcu: Hierarchical RCU implementation. May 06 10:14:23 piaudio kernel: Rude variant of Tasks RCU enabled. May 06 10:14:23 piaudio kernel: Tracing variant of Tasks RCU enabled. May 06 10:14:23 piaudio kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. May 06 10:14:23 piaudio kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 May 06 10:14:23 piaudio kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 06 10:14:23 piaudio kernel: arch_timer: cp15 timer(s) running at 19.20MHz (phys). May 06 10:14:23 piaudio kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns May 06 10:14:23 piaudio kernel: sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns May 06 10:14:23 piaudio kernel: Switching to timer-based delay loop, resolution 52ns May 06 10:14:23 piaudio kernel: Console: colour dummy device 80x30 May 06 10:14:23 piaudio kernel: printk: console [tty1] enabled May 06 10:14:23 piaudio kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000) May 06 10:14:23 piaudio kernel: CPU: Testing write buffer coherency: ok May 06 10:14:23 piaudio kernel: pid_max: default: 32768 minimum: 301 May 06 10:14:23 piaudio kernel: LSM: Security Framework initializing May 06 10:14:23 piaudio kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) May 06 10:14:23 piaudio kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) May 06 10:14:23 piaudio kernel: cgroup: Disabling memory control group subsystem May 06 10:14:23 piaudio kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 May 06 10:14:23 piaudio kernel: cblist_init_generic: Setting adjustable number of callback queues. May 06 10:14:23 piaudio kernel: cblist_init_generic: Setting shift to 2 and lim to 1. May 06 10:14:23 piaudio kernel: cblist_init_generic: Setting adjustable number of callback queues. May 06 10:14:23 piaudio kernel: cblist_init_generic: Setting shift to 2 and lim to 1. May 06 10:14:23 piaudio kernel: Setting up static identity map for 0x100000 - 0x10003c May 06 10:14:23 piaudio kernel: rcu: Hierarchical SRCU implementation. May 06 10:14:23 piaudio kernel: rcu: Max phase no-delay instances is 1000. May 06 10:14:23 piaudio kernel: smp: Bringing up secondary CPUs ... May 06 10:14:23 piaudio kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 May 06 10:14:23 piaudio kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 May 06 10:14:23 piaudio kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 May 06 10:14:23 piaudio kernel: smp: Brought up 1 node, 4 CPUs May 06 10:14:23 piaudio kernel: SMP: Total of 4 processors activated (153.60 BogoMIPS). May 06 10:14:23 piaudio kernel: CPU: All CPU(s) started in HYP mode. May 06 10:14:23 piaudio kernel: CPU: Virtualization extensions available. May 06 10:14:23 piaudio kernel: devtmpfs: initialized May 06 10:14:23 piaudio kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4 May 06 10:14:23 piaudio kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns May 06 10:14:23 piaudio kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 06 10:14:23 piaudio kernel: pinctrl core: initialized pinctrl subsystem May 06 10:14:23 piaudio kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 06 10:14:23 piaudio kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations May 06 10:14:23 piaudio kernel: audit: initializing netlink subsys (disabled) May 06 10:14:23 piaudio kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 May 06 10:14:23 piaudio kernel: thermal_sys: Registered thermal governor 'step_wise' May 06 10:14:23 piaudio kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. May 06 10:14:23 piaudio kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. May 06 10:14:23 piaudio kernel: Serial: AMBA PL011 UART driver May 06 10:14:23 piaudio kernel: bcm2835-mbox 3f00b880.mailbox: mailbox enabled May 06 10:14:23 piaudio kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2023-10-17T15:42:39, variant start May 06 10:14:23 piaudio kernel: raspberrypi-firmware soc:firmware: Firmware hash is 30f0c5e4d076da3ab4f341d88e7d505760b93ad7 May 06 10:14:23 piaudio kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 06 10:14:23 piaudio kernel: bcm2835-dma 3f007000.dma: DMA legacy API manager, dmachans=0x1 May 06 10:14:23 piaudio kernel: SCSI subsystem initialized May 06 10:14:23 piaudio kernel: usbcore: registered new interface driver usbfs May 06 10:14:23 piaudio kernel: usbcore: registered new interface driver hub May 06 10:14:23 piaudio kernel: usbcore: registered new device driver usb May 06 10:14:23 piaudio kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator May 06 10:14:23 piaudio kernel: pps_core: LinuxPPS API ver. 1 registered May 06 10:14:23 piaudio kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti May 06 10:14:23 piaudio kernel: PTP clock support registered May 06 10:14:23 piaudio kernel: clocksource: Switched to clocksource arch_sys_counter May 06 10:14:23 piaudio kernel: VFS: Disk quotas dquot_6.6.0 May 06 10:14:23 piaudio kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) May 06 10:14:23 piaudio kernel: FS-Cache: Loaded May 06 10:14:23 piaudio kernel: CacheFiles: Loaded May 06 10:14:23 piaudio kernel: NET: Registered PF_INET protocol family May 06 10:14:23 piaudio kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) May 06 10:14:23 piaudio kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear) May 06 10:14:23 piaudio kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 06 10:14:23 piaudio kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) May 06 10:14:23 piaudio kernel: TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) May 06 10:14:23 piaudio kernel: TCP: Hash tables configured (established 8192 bind 8192) May 06 10:14:23 piaudio kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) May 06 10:14:23 piaudio kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) May 06 10:14:23 piaudio kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 06 10:14:23 piaudio kernel: RPC: Registered named UNIX socket transport module. May 06 10:14:23 piaudio kernel: RPC: Registered udp transport module. May 06 10:14:23 piaudio kernel: RPC: Registered tcp transport module. May 06 10:14:23 piaudio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. May 06 10:14:23 piaudio kernel: Trying to unpack rootfs image as initramfs... May 06 10:14:23 piaudio kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available May 06 10:14:23 piaudio kernel: Freeing initrd memory: 13656K May 06 10:14:23 piaudio kernel: Initialise system trusted keyrings May 06 10:14:23 piaudio kernel: workingset: timestamp_bits=14 max_order=18 bucket_order=4 May 06 10:14:23 piaudio kernel: zbud: loaded May 06 10:14:23 piaudio kernel: NFS: Registering the id_resolver key type May 06 10:14:23 piaudio kernel: Key type id_resolver registered May 06 10:14:23 piaudio kernel: Key type id_legacy registered May 06 10:14:23 piaudio kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... May 06 10:14:23 piaudio kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... May 06 10:14:23 piaudio kernel: Key type asymmetric registered May 06 10:14:23 piaudio kernel: Asymmetric key parser 'x509' registered May 06 10:14:23 piaudio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) May 06 10:14:23 piaudio kernel: io scheduler mq-deadline registered May 06 10:14:23 piaudio kernel: io scheduler kyber registered May 06 10:14:23 piaudio kernel: bcm2708_fb soc:fb: FB found 1 display(s) May 06 10:14:23 piaudio kernel: Console: switching to colour frame buffer device 80x30 May 06 10:14:23 piaudio kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480 May 06 10:14:23 piaudio kernel: bcm2835-rng 3f104000.rng: hwrng registered May 06 10:14:23 piaudio kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) May 06 10:14:23 piaudio kernel: brd: module loaded May 06 10:14:23 piaudio kernel: loop: module loaded May 06 10:14:23 piaudio kernel: Loading iSCSI transport class v2.0-870. May 06 10:14:23 piaudio kernel: usbcore: registered new interface driver lan78xx May 06 10:14:23 piaudio kernel: usbcore: registered new interface driver smsc95xx May 06 10:14:23 piaudio kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) May 06 10:14:23 piaudio kernel: Core Release: 2.80a May 06 10:14:23 piaudio kernel: Setting default values for core params May 06 10:14:23 piaudio kernel: Finished setting default values for core params May 06 10:14:23 piaudio kernel: Using Buffer DMA mode May 06 10:14:23 piaudio kernel: Periodic Transfer Interrupt Enhancement - disabled May 06 10:14:23 piaudio kernel: Multiprocessor Interrupt Enhancement - disabled May 06 10:14:23 piaudio kernel: OTG VER PARAM: 0, OTG VER FLAG: 0 May 06 10:14:23 piaudio kernel: Dedicated Tx FIFOs mode May 06 10:14:23 piaudio kernel: May 06 10:14:23 piaudio kernel: WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = b4104000 dma = 0xf4104000 len=9024 May 06 10:14:23 piaudio kernel: FIQ FSM acceleration enabled for : Non-periodic Split Transactions Periodic Split Transactions High-Speed Isochronous Endpoints Interrupt/Control Split Transaction hack enabled May 06 10:14:23 piaudio kernel: dwc_otg: Microframe scheduler enabled May 06 10:14:23 piaudio kernel: May 06 10:14:23 piaudio kernel: WARN::hcd_init_fiq:457: FIQ on core 1 May 06 10:14:23 piaudio kernel: May 06 10:14:23 piaudio kernel: WARN::hcd_init_fiq:458: FIQ ASM at 807cb80c length 36 May 06 10:14:23 piaudio kernel: May 06 10:14:23 piaudio kernel: WARN::hcd_init_fiq:497: MPHI regs_base at b8810000 May 06 10:14:23 piaudio kernel: dwc_otg 3f980000.usb: DWC OTG Controller May 06 10:14:23 piaudio kernel: dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1 May 06 10:14:23 piaudio kernel: dwc_otg 3f980000.usb: irq 89, io mem 0x00000000 May 06 10:14:23 piaudio kernel: Init: Port Power? op_state=1 May 06 10:14:23 piaudio kernel: Init: Power Port (0) May 06 10:14:23 piaudio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01 May 06 10:14:23 piaudio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 May 06 10:14:23 piaudio kernel: usb usb1: Product: DWC OTG Controller May 06 10:14:23 piaudio kernel: usb usb1: Manufacturer: Linux 6.1.69-v7+ dwc_otg_hcd May 06 10:14:23 piaudio kernel: usb usb1: SerialNumber: 3f980000.usb May 06 10:14:23 piaudio kernel: hub 1-0:1.0: USB hub found May 06 10:14:23 piaudio kernel: hub 1-0:1.0: 1 port detected May 06 10:14:23 piaudio kernel: dwc_otg: FIQ enabled May 06 10:14:23 piaudio kernel: dwc_otg: NAK holdoff enabled May 06 10:14:23 piaudio kernel: dwc_otg: FIQ split-transaction FSM enabled May 06 10:14:23 piaudio kernel: Module dwc_common_port init May 06 10:14:23 piaudio kernel: usbcore: registered new interface driver usb-storage May 06 10:14:23 piaudio kernel: mousedev: PS/2 mouse device common for all mice May 06 10:14:23 piaudio kernel: sdhci: Secure Digital Host Controller Interface driver May 06 10:14:23 piaudio kernel: sdhci: Copyright(c) Pierre Ossman May 06 10:14:23 piaudio kernel: sdhci-pltfm: SDHCI platform and OF driver helper May 06 10:14:23 piaudio kernel: ledtrig-cpu: registered to indicate activity on CPUs May 06 10:14:23 piaudio kernel: hid: raw HID events driver (C) Jiri Kosina May 06 10:14:23 piaudio kernel: usbcore: registered new interface driver usbhid May 06 10:14:23 piaudio kernel: usbhid: USB HID core driver May 06 10:14:23 piaudio kernel: Initializing XFRM netlink socket May 06 10:14:23 piaudio kernel: NET: Registered PF_PACKET protocol family May 06 10:14:23 piaudio kernel: Key type dns_resolver registered May 06 10:14:23 piaudio kernel: Registering SWP/SWPB emulation handler May 06 10:14:23 piaudio kernel: registered taskstats version 1 May 06 10:14:23 piaudio kernel: Loading compiled-in X.509 certificates May 06 10:14:23 piaudio kernel: Key type .fscrypt registered May 06 10:14:23 piaudio kernel: Key type fscrypt-provisioning registered May 06 10:14:23 piaudio kernel: uart-pl011 3f201000.serial: cts_event_workaround enabled May 06 10:14:23 piaudio kernel: 3f201000.serial: ttyAMA1 at MMIO 0x3f201000 (irq = 114, base_baud = 0) is a PL011 rev2 May 06 10:14:23 piaudio kernel: serial serial0: tty port ttyAMA1 registered May 06 10:14:23 piaudio kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer May 06 10:14:23 piaudio kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver May 06 10:14:23 piaudio kernel: mmc-bcm2835 3f300000.mmcnr: mmc_debug:0 mmc_debug2:0 May 06 10:14:23 piaudio kernel: mmc-bcm2835 3f300000.mmcnr: DMA channel allocated May 06 10:14:23 piaudio kernel: sdhost: log_buf @ 5bc1b94a (f4107000) May 06 10:14:23 piaudio kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) May 06 10:14:23 piaudio kernel: of_cfs_init May 06 10:14:23 piaudio kernel: of_cfs_init: OK May 06 10:14:23 piaudio kernel: Freeing unused kernel image (initmem) memory: 1024K May 06 10:14:23 piaudio kernel: Indeed it is in host mode hprt0 = 00021501 May 06 10:14:23 piaudio kernel: mmc0: host does not support reading read-only switch, assuming write-enable May 06 10:14:23 piaudio kernel: mmc0: new high speed SDHC card at address 0007 May 06 10:14:23 piaudio kernel: mmcblk0: mmc0:0007 SL16G 14.5 GiB May 06 10:14:23 piaudio kernel: mmcblk0: p1 p2 p3 May 06 10:14:23 piaudio kernel: mmcblk0: mmc0:0007 SL16G 14.5 GiB May 06 10:14:23 piaudio kernel: mmc1: new high speed SDIO card at address 0001 May 06 10:14:23 piaudio kernel: Run /init as init process May 06 10:14:23 piaudio kernel: with arguments: May 06 10:14:23 piaudio kernel: /init May 06 10:14:23 piaudio kernel: splash May 06 10:14:23 piaudio kernel: with environment: May 06 10:14:23 piaudio kernel: HOME=/ May 06 10:14:23 piaudio kernel: TERM=linux May 06 10:14:23 piaudio kernel: imgpart=/dev/mmcblk0p2 May 06 10:14:23 piaudio kernel: imgfile=/volumio_current.sqsh May 06 10:14:23 piaudio kernel: bootdelay=5 May 06 10:14:23 piaudio kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg May 06 10:14:23 piaudio kernel: Indeed it is in host mode hprt0 = 00001101 May 06 10:14:23 piaudio initramfs: Booting Volumio for BCM2835 May 06 10:14:23 piaudio initramfs: This script mounts rootfs RO with an overlay RW layer. May 06 10:14:23 piaudio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 06 10:14:23 piaudio initramfs: IMGPART=/dev/mmcblk0p2 May 06 10:14:23 piaudio initramfs: IMGFILE=/volumio_current.sqsh May 06 10:14:23 piaudio initramfs: Boot delay (except first time) will be 5 seconds May 06 10:14:23 piaudio initramfs: /dev/mmcblk0p2: May 06 10:14:23 piaudio kernel: usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcdDevice= 2.00 May 06 10:14:23 piaudio kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 May 06 10:14:23 piaudio kernel: hub 1-1:1.0: USB hub found May 06 10:14:23 piaudio kernel: hub 1-1:1.0: 5 ports detected May 06 10:14:23 piaudio kernel: EXT4-fs (mmcblk0p2): recovery complete May 06 10:14:23 piaudio kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. May 06 10:14:23 piaudio initramfs: Doing a 5 second delay here to give kernel load a headstart May 06 10:14:23 piaudio kernel: usb 1-1.1: new high-speed USB device number 3 using dwc_otg May 06 10:14:23 piaudio kernel: usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, bcdDevice= 2.00 May 06 10:14:23 piaudio kernel: usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 May 06 10:14:23 piaudio kernel: smsc95xx v2.0.0 May 06 10:14:23 piaudio kernel: SMSC LAN8700 usb-001:003:01: attached PHY driver (mii_bus:phy_addr=usb-001:003:01, irq=199) May 06 10:14:23 piaudio kernel: smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:1f:f1:24 May 06 10:14:23 piaudio initramfs: Checking for USB updates May 06 10:14:23 piaudio initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) May 06 10:14:23 piaudio kernel: loop0: detected capacity change from 0 to 976664 May 06 10:14:23 piaudio kernel: EXT4-fs (mmcblk0p3): warning: mounting fs with errors, running e2fsck is recommended May 06 10:14:23 piaudio kernel: EXT4-fs (mmcblk0p3): recovery complete May 06 10:14:23 piaudio kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. May 06 10:14:23 piaudio initramfs: With Option: May 06 10:14:23 piaudio initramfs: VOLUMIO_VERSION="3.661" May 06 10:14:23 piaudio initramfs: Finish initramfs, continue booting Volumio May 06 10:14:23 piaudio systemd[1]: System time before build time, advancing clock. May 06 10:14:23 piaudio kernel: NET: Registered PF_INET6 protocol family May 06 10:14:23 piaudio kernel: Segment Routing with IPv6 May 06 10:14:23 piaudio kernel: In-situ OAM (IOAM) with IPv6 May 06 10:14:23 piaudio 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 06 10:14:23 piaudio systemd[1]: Detected architecture arm. May 06 10:14:23 piaudio systemd[1]: Set hostname to . May 06 10:14:23 piaudio 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 06 10:14:23 piaudio systemd[1]: Listening on fsck to fsckd communication Socket. May 06 10:14:23 piaudio systemd[1]: Reached target System Time Synchronized. May 06 10:14:23 piaudio systemd[1]: Listening on Journal Socket. May 06 10:14:23 piaudio systemd[1]: Starting Create list of required static device nodes for the current kernel... May 06 10:14:23 piaudio systemd[1]: Condition check resulted in Huge Pages File System being skipped. May 06 10:14:23 piaudio systemd[1]: Listening on initctl Compatibility Named Pipe. May 06 10:14:23 piaudio kernel: i2c_dev: i2c /dev entries driver May 06 10:14:23 piaudio systemd-journald[199]: Journal started May 06 10:14:23 piaudio systemd-journald[199]: Runtime journal (/run/log/journal/a4d620ccb4a6a12010c39c5d649876fe) is 3.7M, max 30.0M, 26.2M free. May 06 10:14:23 piaudio systemd-modules-load[191]: Inserted module 'i2c_dev' May 06 10:14:23 piaudio fake-hwclock[188]: Mon May 6 08:14:23 UTC 2024 May 06 10:14:23 piaudio systemd[1]: Started Apply Kernel Variables. May 06 10:14:23 piaudio systemd[1]: Started Load/Save Random Seed. May 06 10:14:23 piaudio systemd[1]: dynamicswap.service: Succeeded. May 06 10:14:23 piaudio systemd[1]: Started Create System Users. May 06 10:14:23 piaudio systemd[1]: Starting Create Static Device Nodes in /dev... May 06 10:14:23 piaudio systemd[1]: Started udev Coldplug all Devices. May 06 10:14:23 piaudio systemd[1]: Starting Helper to synchronize boot up for ifupdown... May 06 10:14:23 piaudio systemd[1]: Started Create Static Device Nodes in /dev. May 06 10:14:23 piaudio systemd[1]: Starting udev Kernel Device Manager... May 06 10:14:23 piaudio systemd[1]: Reached target Local File Systems (Pre). May 06 10:14:23 piaudio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. May 06 10:14:23 piaudio systemd[1]: Mounting /var/log... May 06 10:14:23 piaudio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. May 06 10:14:23 piaudio systemd[1]: Mounting /tmp... May 06 10:14:23 piaudio systemd[1]: Mounting /var/spool/cups... May 06 10:14:23 piaudio systemd[1]: Mounted /var/log. May 06 10:14:23 piaudio systemd[1]: Mounted /tmp. May 06 10:14:23 piaudio systemd[1]: Mounted /var/spool/cups. May 06 10:14:23 piaudio systemd[1]: Mounting /var/spool/cups/tmp... May 06 10:14:23 piaudio systemd[1]: Starting Flush Journal to Persistent Storage... May 06 10:14:23 piaudio systemd[1]: Mounted /var/spool/cups/tmp. May 06 10:14:23 piaudio systemd-udevd[227]: Network interface NamePolicy= disabled on kernel command line, ignoring. May 06 10:14:23 piaudio systemd-journald[199]: Runtime journal (/run/log/journal/a4d620ccb4a6a12010c39c5d649876fe) is 3.7M, max 30.0M, 26.2M free. May 06 10:14:23 piaudio systemd[1]: Started udev Kernel Device Manager. May 06 10:14:23 piaudio systemd[1]: Started Flush Journal to Persistent Storage. May 06 10:14:23 piaudio systemd[1]: Starting Show Plymouth Boot Screen... May 06 10:14:23 piaudio systemd[1]: Received SIGRTMIN+20 from PID 244 (plymouthd). May 06 10:14:23 piaudio systemd[1]: Started Show Plymouth Boot Screen. May 06 10:14:23 piaudio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 06 10:14:23 piaudio systemd[1]: Reached target Local Encrypted Volumes. May 06 10:14:23 piaudio systemd[1]: Reached target Paths. May 06 10:14:23 piaudio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. May 06 10:14:23 piaudio kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. May 06 10:14:23 piaudio kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver May 06 10:14:23 piaudio kernel: [vc_sm_connected_init]: start May 06 10:14:24 piaudio kernel: [vc_sm_connected_init]: installed successfully May 06 10:14:24 piaudio kernel: mc: Linux media interface: v0.10 May 06 10:14:24 piaudio kernel: rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 May 06 10:14:24 piaudio kernel: rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem May 06 10:14:24 piaudio kernel: videodev: Linux video capture interface: v2.00 May 06 10:14:24 piaudio kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. May 06 10:14:24 piaudio kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. May 06 10:14:24 piaudio kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. May 06 10:14:24 piaudio kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. May 06 10:14:24 piaudio kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller May 06 10:14:24 piaudio kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp May 06 10:14:24 piaudio kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. May 06 10:14:24 piaudio kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 May 06 10:14:24 piaudio kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode May 06 10:14:24 piaudio kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 May 06 10:14:24 piaudio kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode May 06 10:14:24 piaudio kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 May 06 10:14:24 piaudio kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp May 06 10:14:24 piaudio kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 May 06 10:14:24 piaudio kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx May 06 10:14:24 piaudio kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 May 06 10:14:24 piaudio kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image May 06 10:14:24 piaudio kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. May 06 10:14:24 piaudio kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored May 06 10:14:24 piaudio kernel: bcm2835_audio bcm2835_audio: card created with 4 channels May 06 10:14:24 piaudio kernel: bcm2835_audio bcm2835_audio: card created with 4 channels May 06 10:14:24 piaudio systemd-udevd[238]: Using default interface naming scheme 'v240'. May 06 10:14:24 piaudio kernel: Bluetooth: Core ver 2.22 May 06 10:14:24 piaudio kernel: NET: Registered PF_BLUETOOTH protocol family May 06 10:14:24 piaudio kernel: Bluetooth: HCI device and connection manager initialized May 06 10:14:24 piaudio kernel: Bluetooth: HCI socket layer initialized May 06 10:14:24 piaudio kernel: Bluetooth: L2CAP socket layer initialized May 06 10:14:24 piaudio kernel: Bluetooth: SCO socket layer initialized May 06 10:14:24 piaudio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database May 06 10:14:24 piaudio systemd-udevd[238]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 06 10:14:24 piaudio kernel: Bluetooth: HCI UART driver ver 2.3 May 06 10:14:24 piaudio kernel: Bluetooth: HCI UART protocol H4 registered May 06 10:14:24 piaudio kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered May 06 10:14:24 piaudio kernel: Bluetooth: HCI UART protocol Broadcom registered May 06 10:14:24 piaudio kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator May 06 10:14:24 piaudio kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator May 06 10:14:25 piaudio kernel: uart-pl011 3f201000.serial: no DMA platform data May 06 10:14:25 piaudio systemd[1]: Found device /dev/mmcblk0p1. May 06 10:14:25 piaudio systemd-udevd[233]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 06 10:14:25 piaudio kernel: Bluetooth: hci0: BCM: chip id 94 May 06 10:14:25 piaudio kernel: Bluetooth: hci0: BCM: features 0x2e May 06 10:14:25 piaudio kernel: Bluetooth: hci0: BCM43430A1 May 06 10:14:25 piaudio kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0000 May 06 10:14:25 piaudio kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' May 06 10:14:25 piaudio kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' May 06 10:14:25 piaudio kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' May 06 10:14:25 piaudio kernel: Bluetooth: hci0: BCM43430A1 'brcm/BCM43430A1.hcd' Patch May 06 10:14:25 piaudio kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6 May 06 10:14:25 piaudio kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 May 06 10:14:25 piaudio kernel: usbcore: registered new interface driver brcmfmac May 06 10:14:26 piaudio kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Jul 19 2021 03:24:18 version 7.45.98 (TOB) (56df937 CY) FWID 01-8e14b897 May 06 10:14:26 piaudio systemd-udevd[243]: Using default interface naming scheme 'v240'. May 06 10:14:26 piaudio systemd-udevd[243]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 06 10:14:26 piaudio kernel: Bluetooth: hci0: BCM: features 0x2e May 06 10:14:26 piaudio kernel: Bluetooth: hci0: BCM43438A1 37.4MHz Raspberry Pi 3-0141 May 06 10:14:26 piaudio kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0508 May 06 10:14:26 piaudio systemd-udevd[234]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 0' failed with exit code 17. May 06 10:14:26 piaudio systemd[1]: Started Helper to synchronize boot up for ifupdown. May 06 10:14:27 piaudio systemd[1]: Condition check resulted in SMSC9512/9514 Fast Ethernet Adapter being skipped. May 06 10:14:27 piaudio systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. May 06 10:14:27 piaudio systemd[1]: Created slice system-bthelper.slice. May 06 10:14:27 piaudio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. May 06 10:14:27 piaudio systemd[1]: Condition check resulted in Huge Pages File System being skipped. May 06 10:14:27 piaudio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 06 10:14:27 piaudio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. May 06 10:14:27 piaudio systemd[1]: Condition check resulted in FUSE Control File System being skipped. May 06 10:14:27 piaudio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. May 06 10:14:27 piaudio systemd[1]: Starting File System Check on /dev/mmcblk0p1... May 06 10:14:27 piaudio systemd[1]: Starting Load/Save RF Kill Switch Status... May 06 10:14:27 piaudio systemd[1]: Started File System Check Daemon to report status. May 06 10:14:27 piaudio systemd[1]: Started Load/Save RF Kill Switch Status. May 06 10:14:27 piaudio systemd-fsck[388]: fsck.fat 4.1 (2017-01-24) May 06 10:14:27 piaudio systemd-fsck[388]: /dev/mmcblk0p1: 374 files, 33375/46774 clusters May 06 10:14:27 piaudio systemd[1]: Started File System Check on /dev/mmcblk0p1. May 06 10:14:27 piaudio systemd[1]: Mounting /boot... May 06 10:14:27 piaudio systemd[1]: Mounted /boot. May 06 10:14:27 piaudio systemd[1]: Reached target Local File Systems. May 06 10:14:27 piaudio systemd[1]: Starting Create Volatile Files and Directories... May 06 10:14:27 piaudio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... May 06 10:14:27 piaudio systemd[1]: Starting Preprocess NFS configuration... May 06 10:14:27 piaudio systemd[1]: Started ifup for wlan0. May 06 10:14:27 piaudio systemd[1]: Started ifup for eth0. May 06 10:14:27 piaudio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. May 06 10:14:27 piaudio systemd[1]: Starting Raise network interfaces... May 06 10:14:27 piaudio systemd[1]: Received SIGRTMIN+20 from PID 244 (plymouthd). May 06 10:14:27 piaudio systemd[1]: plymouth-read-write.service: Succeeded. May 06 10:14:27 piaudio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. May 06 10:14:27 piaudio systemd[1]: nfs-config.service: Succeeded. May 06 10:14:27 piaudio systemd[1]: Started Preprocess NFS configuration. May 06 10:14:27 piaudio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. May 06 10:14:27 piaudio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. May 06 10:14:27 piaudio systemd[1]: Reached target NFS client services. May 06 10:14:27 piaudio systemd[1]: Started Create Volatile Files and Directories. May 06 10:14:28 piaudio systemd[1]: Starting Update UTMP about System Boot/Shutdown... May 06 10:14:28 piaudio systemd[1]: Starting RPC bind portmap service... May 06 10:14:28 piaudio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. May 06 10:14:28 piaudio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. May 06 10:14:28 piaudio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 06 10:14:28 piaudio systemd[1]: Started Update UTMP about System Boot/Shutdown. May 06 10:14:28 piaudio systemd[1]: Reached target System Initialization. May 06 10:14:28 piaudio kernel: 8021q: 802.1Q VLAN Support v1.8 May 06 10:14:28 piaudio systemd[1]: Started Volumio Splash. May 06 10:14:28 piaudio systemd[472]: volumiosplash.service: Failed to execute command: No such file or directory May 06 10:14:28 piaudio systemd[472]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory May 06 10:14:28 piaudio systemd[1]: Listening on triggerhappy.socket. May 06 10:14:28 piaudio systemd[1]: Started Daily apt download activities. May 06 10:14:28 piaudio systemd[1]: Started Daily apt upgrade and clean activities. May 06 10:14:28 piaudio systemd[1]: Listening on D-Bus System Message Bus Socket. May 06 10:14:28 piaudio systemd[1]: Started Daily Cleanup of Temporary Directories. May 06 10:14:28 piaudio systemd[1]: Reached target Timers. May 06 10:14:28 piaudio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. May 06 10:14:28 piaudio systemd[1]: Reached target Sockets. May 06 10:14:28 piaudio systemd[1]: Reached target Basic System. May 06 10:14:28 piaudio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. May 06 10:14:28 piaudio systemd[1]: Started UPnP Renderer front-end to MPD. May 06 10:14:28 piaudio systemd[1]: Starting Configure Bluetooth Modems connected by UART... May 06 10:14:28 piaudio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. May 06 10:14:28 piaudio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... May 06 10:14:28 piaudio systemd[1]: Started volumio-remote-updater.service. May 06 10:14:28 piaudio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. May 06 10:14:28 piaudio systemd[1]: Starting dhcpcd on all interfaces... May 06 10:14:28 piaudio systemd[1]: Starting Wireless Services... May 06 10:14:28 piaudio systemd[1]: Started D-Bus System Message Bus. May 06 10:14:28 piaudio systemd[1]: Starting WPA supplicant... May 06 10:14:28 piaudio dhcpcd[498]: Not running dhcpcd because /etc/network/interfaces May 06 10:14:28 piaudio dhcpcd[498]: defines some interfaces that will use a May 06 10:14:28 piaudio dhcpcd[498]: DHCP client or static address May 06 10:14:28 piaudio systemd[1]: Started Volumio Log Rotation Service. May 06 10:14:28 piaudio systemd[1]: Starting triggerhappy global hotkey daemon... May 06 10:14:28 piaudio systemd[1]: Started Volumio Iptables Module. May 06 10:14:28 piaudio systemd[1]: Started Manage Sound Card State (restore and store). May 06 10:14:28 piaudio alsactl[513]: alsactl 1.1.8 daemon started May 06 10:14:28 piaudio systemd[1]: Starting Save/Restore Sound Card State... May 06 10:14:28 piaudio systemd[1]: Starting Login Service... May 06 10:14:28 piaudio systemd[1]: Started RPC bind portmap service. May 06 10:14:28 piaudio systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC May 06 10:14:28 piaudio systemd[1]: volumiosplash.service: Failed with result 'exit-code'. May 06 10:14:28 piaudio systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED May 06 10:14:28 piaudio systemd[1]: dhcpcd.service: Failed with result 'exit-code'. May 06 10:14:28 piaudio systemd[1]: Failed to start dhcpcd on all interfaces. May 06 10:14:28 piaudio systemd[1]: Reached target Remote File Systems (Pre). May 06 10:14:28 piaudio systemd[1]: Reached target Remote File Systems. May 06 10:14:28 piaudio thd[510]: Unable to parse trigger line: May 06 10:14:28 piaudio thd[510]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle May 06 10:14:28 piaudio thd[510]: Unable to parse trigger line: May 06 10:14:28 piaudio thd[510]: Found socket passed from systemd May 06 10:14:28 piaudio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... May 06 10:14:28 piaudio systemd[1]: Reached target RPC Port Mapper. May 06 10:14:28 piaudio systemd[1]: Started triggerhappy global hotkey daemon. May 06 10:14:28 piaudio ifup[400]: ifup: waiting for lock on /run/network/ifstate.wlan0 May 06 10:14:28 piaudio sh[398]: wlan0=wlan0 May 06 10:14:28 piaudio avahi-daemon[496]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). May 06 10:14:28 piaudio avahi-daemon[496]: Successfully dropped root privileges. May 06 10:14:28 piaudio avahi-daemon[496]: avahi-daemon 0.7 starting up. May 06 10:14:29 piaudio systemd-logind[516]: New seat seat0. May 06 10:14:29 piaudio sh[399]: eth0: waiting for carrier May 06 10:14:29 piaudio dhcpcd[444]: eth0: waiting for carrier May 06 10:14:29 piaudio kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup May 06 10:14:29 piaudio kernel: smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control off May 06 10:14:29 piaudio dhcpcd[444]: eth0: carrier acquired May 06 10:14:29 piaudio sh[399]: eth0: carrier acquired May 06 10:14:29 piaudio sh[399]: DUID 00:01:00:01:2c:2b:35:46:b8:27:eb:1f:f1:24 May 06 10:14:29 piaudio sh[399]: eth0: IAID eb:1f:f1:24 May 06 10:14:29 piaudio sh[399]: eth0: adding address fe80::ba27:ebff:fe1f:f124 May 06 10:14:29 piaudio sh[399]: ipv6_addaddr1: Permission denied May 06 10:14:29 piaudio dhcpcd[444]: DUID 00:01:00:01:2c:2b:35:46:b8:27:eb:1f:f1:24 May 06 10:14:29 piaudio dhcpcd[444]: eth0: IAID eb:1f:f1:24 May 06 10:14:29 piaudio dhcpcd[444]: eth0: adding address fe80::ba27:ebff:fe1f:f124 May 06 10:14:29 piaudio dhcpcd[444]: ipv6_addaddr1: Permission denied May 06 10:14:29 piaudio systemd[1]: hciuart.service: Succeeded. May 06 10:14:29 piaudio systemd[1]: Started Configure Bluetooth Modems connected by UART. May 06 10:14:29 piaudio systemd[1]: Started Save/Restore Sound Card State. May 06 10:14:29 piaudio avahi-daemon[496]: Successfully called chroot(). May 06 10:14:29 piaudio avahi-daemon[496]: Successfully dropped remaining capabilities. May 06 10:14:29 piaudio wpa_supplicant[507]: Successfully initialized wpa_supplicant May 06 10:14:29 piaudio avahi-daemon[496]: Loading service file /services/volumio.service. May 06 10:14:29 piaudio sh[399]: eth0: soliciting an IPv6 router May 06 10:14:29 piaudio dhcpcd[444]: eth0: soliciting an IPv6 router May 06 10:14:29 piaudio sh[399]: eth0: soliciting a DHCP lease May 06 10:14:29 piaudio dhcpcd[444]: eth0: soliciting a DHCP lease May 06 10:14:29 piaudio avahi-daemon[496]: Network interface enumeration completed. May 06 10:14:29 piaudio avahi-daemon[496]: Server startup complete. Host name is piaudio.local. Local service cookie is 2216675866. May 06 10:14:29 piaudio avahi-daemon[496]: Service "PIAUDIO" (/services/volumio.service) successfully established. May 06 10:14:30 piaudio systemd[1]: Started Login Service. May 06 10:14:30 piaudio systemd[1]: Started Raise network interfaces. May 06 10:14:30 piaudio systemd[1]: Started Avahi mDNS/DNS-SD Stack. May 06 10:14:30 piaudio systemd[1]: Started WPA supplicant. May 06 10:14:30 piaudio systemd[1]: Reached target Network. May 06 10:14:30 piaudio sh[399]: eth0: offered 192.168.178.56 from 192.168.178.1 May 06 10:14:30 piaudio dhcpcd[444]: eth0: offered 192.168.178.56 from 192.168.178.1 May 06 10:14:30 piaudio volumio-remote-updater[497]: Error: No active session May 06 10:14:30 piaudio systemd[1]: Starting Permit User Sessions... May 06 10:14:30 piaudio volumio-remote-updater[497]: [2024-05-06 10:14:30] [info] asio async_connect error: system:111 (Connection refused) May 06 10:14:30 piaudio volumio-remote-updater[497]: [2024-05-06 10:14:30] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 06 10:14:30 piaudio volumio-remote-updater[497]: [2024-05-06 10:14:30] [error] handle_connect error: Underlying Transport Error May 06 10:14:30 piaudio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. May 06 10:14:30 piaudio systemd[1]: Reached target Network is Online. May 06 10:14:30 piaudio systemd[1]: Starting Samba NMB Daemon... May 06 10:14:30 piaudio systemd[1]: Starting /etc/rc.local Compatibility... May 06 10:14:30 piaudio systemd[1]: Starting LSB: Brings up/down network automatically... May 06 10:14:30 piaudio systemd[1]: Starting Network Time Service... May 06 10:14:30 piaudio systemd[1]: Reached target Sound Card. May 06 10:14:30 piaudio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 06 10:14:30 piaudio sh[399]: eth0: probing address 192.168.178.56/24 May 06 10:14:30 piaudio dhcpcd[444]: eth0: probing address 192.168.178.56/24 May 06 10:14:30 piaudio systemd[1]: Starting Raspberry Pi bluetooth helper... May 06 10:14:30 piaudio volumio[490]: Could not open config: /tmp/upmpdcli.conf May 06 10:14:30 piaudio systemd[1]: Started Permit User Sessions. May 06 10:14:30 piaudio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 06 10:14:30 piaudio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 06 10:14:30 piaudio systemd[1]: Started /etc/rc.local Compatibility. May 06 10:14:30 piaudio systemd[1]: Starting Hold until boot process finishes up... May 06 10:14:30 piaudio systemd[1]: Starting Terminate Plymouth Boot Screen... May 06 10:14:30 piaudio systemd[1]: iptables.service: Succeeded. May 06 10:14:30 piaudio systemd[1]: Received SIGRTMIN+21 from PID 244 (plymouthd). May 06 10:14:30 piaudio systemd[1]: plymouth-quit-wait.service: Succeeded. May 06 10:14:30 piaudio systemd[1]: Started Hold until boot process finishes up. May 06 10:14:30 piaudio systemd[1]: plymouth-quit.service: Succeeded. May 06 10:14:30 piaudio systemd[1]: Started Terminate Plymouth Boot Screen. May 06 10:14:30 piaudio systemd[1]: Received SIGRTMIN+21 from PID 244 (plymouthd). May 06 10:14:30 piaudio systemd[1]: Started Getty on tty1. May 06 10:14:30 piaudio systemd[1]: Reached target Login Prompts. May 06 10:14:30 piaudio bthelper[607]: Raspberry Pi BDADDR already set May 06 10:14:30 piaudio loadcpufreq[532]: Loading cpufreq kernel modules...done (none). May 06 10:14:30 piaudio systemd[1]: plymouth-start.service: Succeeded. May 06 10:14:30 piaudio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. May 06 10:14:30 piaudio systemd[1]: Started Raspberry Pi bluetooth helper. May 06 10:14:31 piaudio systemd[1]: Starting Bluetooth service... May 06 10:14:31 piaudio systemd[1]: Starting LSB: set CPUFreq kernel parameters... May 06 10:14:31 piaudio ifplugd(eth0)[666]: ifplugd 0.28 initializing. May 06 10:14:31 piaudio ifplugd(eth0)[666]: Using interface eth0/B8:27:EB:1F:F1:24 with driver (version: 6.1.69-v7+) May 06 10:14:31 piaudio ifplugd(eth0)[666]: Using detection mode: SIOCETHTOOL May 06 10:14:31 piaudio ifplugd(eth0)[666]: Initialization complete, link beat detected. May 06 10:14:31 piaudio ifplugd(eth0)[666]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. May 06 10:14:31 piaudio ntpd[603]: ntpd 4.2.8p12@1.3728-o (1): Starting May 06 10:14:31 piaudio ntpd[603]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 May 06 10:14:31 piaudio haveged[459]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K May 06 10:14:31 piaudio haveged[459]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 May 06 10:14:31 piaudio haveged[459]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99899 May 06 10:14:31 piaudio haveged[459]: haveged: fills: 0, generated: 0 May 06 10:14:31 piaudio systemd[1]: Started Network Time Service. May 06 10:14:31 piaudio ntpd[670]: proto: precision = 1.458 usec (-19) May 06 10:14:31 piaudio ntpd[670]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 06 10:14:31 piaudio ntpd[670]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 06 10:14:31 piaudio ntpd[670]: Listen and drop on 0 v6wildcard [::]:123 May 06 10:14:31 piaudio ntpd[670]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 06 10:14:31 piaudio ntpd[670]: Listen normally on 2 lo 127.0.0.1:123 May 06 10:14:31 piaudio ntpd[670]: Listening on routing socket on fd #19 for interface updates May 06 10:14:31 piaudio ntpd[670]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 06 10:14:31 piaudio ntpd[670]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 06 10:14:31 piaudio cpufrequtils[658]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. May 06 10:14:31 piaudio systemd[1]: Started LSB: set CPUFreq kernel parameters. May 06 10:14:31 piaudio ifplugd(eth0)[666]: client: ifup: waiting for lock on /run/network/ifstate.eth0 May 06 10:14:31 piaudio bluetoothd[644]: Bluetooth daemon 5.50 May 06 10:14:31 piaudio bluetoothd[644]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf May 06 10:14:31 piaudio systemd[1]: Started Bluetooth service. May 06 10:14:31 piaudio systemd[1]: Reached target Bluetooth. May 06 10:14:31 piaudio bluetoothd[644]: Starting SDP server May 06 10:14:31 piaudio bluetoothd[644]: Excluding (cli) sap May 06 10:14:31 piaudio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 May 06 10:14:31 piaudio kernel: Bluetooth: BNEP filters: protocol multicast May 06 10:14:31 piaudio kernel: Bluetooth: BNEP socket layer initialized May 06 10:14:31 piaudio dbus-daemon[503]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=644 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") May 06 10:14:31 piaudio bluetoothd[644]: Bluetooth management interface 1.22 initialized May 06 10:14:31 piaudio kernel: Bluetooth: MGMT ver 1.22 May 06 10:14:31 piaudio bluetoothd[644]: Failed to set privacy: Rejected (0x0b) May 06 10:14:31 piaudio systemd[1]: Starting Hostname Service... May 06 10:14:31 piaudio dbus-daemon[503]: [system] Successfully activated service 'org.freedesktop.hostname1' May 06 10:14:31 piaudio systemd[1]: Started Hostname Service. May 06 10:14:32 piaudio nmbd[614]: [2024/05/06 10:14:32.199305, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) May 06 10:14:32 piaudio nmbd[614]: started asyncdns process 690 May 06 10:14:32 piaudio nmbd[614]: [2024/05/06 10:14:32.201792, 0] ../lib/util/become_daemon.c:149(daemon_status) May 06 10:14:32 piaudio nmbd[614]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... May 06 10:14:32 piaudio nmbd[614]: [2024/05/06 10:14:32.201997, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) May 06 10:14:32 piaudio nmbd[614]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). May 06 10:14:32 piaudio ntpd[670]: error resolving pool 0.debian.pool.ntp.org: System error (-11) May 06 10:14:32 piaudio systemd[1]: systemd-rfkill.service: Succeeded. May 06 10:14:32 piaudio wireless.js[499]: Cleaning previous... May 06 10:14:32 piaudio sudo[698]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 06 10:14:32 piaudio sudo[698]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:32 piaudio sudo[698]: pam_unix(sudo:session): session closed for user root May 06 10:14:32 piaudio sudo[700]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 06 10:14:32 piaudio sudo[700]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:33 piaudio ntpd[670]: error resolving pool 1.debian.pool.ntp.org: System error (-11) May 06 10:14:33 piaudio sudo[700]: pam_unix(sudo:session): session closed for user root May 06 10:14:33 piaudio wireless.js[499]: Stopped aP May 06 10:14:33 piaudio wireless.js[499]: Wireless Networking DISABLED, not starting wireless flow May 06 10:14:33 piaudio systemd[1]: wireless.service: Succeeded. May 06 10:14:33 piaudio systemd[1]: Started Wireless Services. May 06 10:14:33 piaudio systemd[1]: Started Volumio Backend Module. May 06 10:14:33 piaudio systemd[1]: Started Volumio Cpu Tweaker. May 06 10:14:33 piaudio volumio-cpu-tweak[709]: Setting RT Priority for mpd May 06 10:14:33 piaudio volumio-cpu-tweak[709]: pid 35's current scheduling policy: SCHED_OTHER May 06 10:14:33 piaudio volumio-cpu-tweak[709]: pid 35's current scheduling priority: 0 May 06 10:14:33 piaudio volumio-cpu-tweak[709]: Setting MPD Affinity May 06 10:14:33 piaudio volumio-cpu-tweak[709]: pid 3's current affinity mask: f May 06 10:14:33 piaudio volumio-cpu-tweak[709]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 06 10:14:33 piaudio volumio-cpu-tweak[709]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 06 10:14:33 piaudio systemd[1]: volumio_cpu_tweak.service: Succeeded. May 06 10:14:34 piaudio ntpd[670]: error resolving pool 2.debian.pool.ntp.org: System error (-11) May 06 10:14:35 piaudio ntpd[670]: error resolving pool 3.debian.pool.ntp.org: System error (-11) May 06 10:14:35 piaudio volumio-remote-updater[497]: [2024-05-06 10:14:35] [info] asio async_connect error: system:111 (Connection refused) May 06 10:14:35 piaudio volumio-remote-updater[497]: [2024-05-06 10:14:35] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 06 10:14:35 piaudio volumio-remote-updater[497]: [2024-05-06 10:14:35] [error] handle_connect error: Underlying Transport Error May 06 10:14:35 piaudio sh[399]: eth0: leased 192.168.178.56 for 86400 seconds May 06 10:14:35 piaudio dhcpcd[444]: eth0: leased 192.168.178.56 for 86400 seconds May 06 10:14:35 piaudio sh[399]: eth0: adding route to 192.168.178.0/24 May 06 10:14:35 piaudio sh[399]: eth0: adding default route via 192.168.178.1 May 06 10:14:35 piaudio dhcpcd[444]: eth0: adding route to 192.168.178.0/24 May 06 10:14:35 piaudio dhcpcd[444]: eth0: adding default route via 192.168.178.1 May 06 10:14:35 piaudio avahi-daemon[496]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.178.56. May 06 10:14:35 piaudio avahi-daemon[496]: New relevant interface eth0.IPv4 for mDNS. May 06 10:14:35 piaudio avahi-daemon[496]: Registering new address record for 192.168.178.56 on eth0.IPv4. May 06 10:14:35 piaudio sh[399]: forked to background, child pid 745 May 06 10:14:35 piaudio dhcpcd[444]: forked to background, child pid 745 May 06 10:14:35 piaudio ifplugd(eth0)[666]: client: ifup: interface eth0 already configured May 06 10:14:35 piaudio sh[399]: eth0=eth0 May 06 10:14:35 piaudio bthelper[607]: Changing power off succeeded May 06 10:14:36 piaudio ifplugd(eth0)[666]: Program executed successfully. May 06 10:14:36 piaudio ifplugd[598]: Network Interface Plugging Daemon...start eth0...done. May 06 10:14:36 piaudio systemd[1]: Started LSB: Brings up/down network automatically. May 06 10:14:36 piaudio bthelper[607]: [CHG] Controller B8:27:EB:B5:5B:8E Class: 0x0000041c May 06 10:14:36 piaudio bthelper[607]: Changing power on succeeded May 06 10:14:36 piaudio volumio[708]: info: ------------------------------------------- May 06 10:14:36 piaudio volumio[708]: info: ----- Volumio3 ---- May 06 10:14:36 piaudio volumio[708]: info: ------------------------------------------- May 06 10:14:36 piaudio volumio[708]: info: ----- System startup ---- May 06 10:14:36 piaudio volumio[708]: info: ------------------------------------------- May 06 10:14:37 piaudio nmbd[614]: [2024/05/06 10:14:37.207984, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 06 10:14:37 piaudio systemd[1]: Started Samba NMB Daemon. May 06 10:14:37 piaudio nmbd[614]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 06 10:14:37 piaudio ntpd[670]: Listen normally on 3 eth0 192.168.178.56:123 May 06 10:14:37 piaudio ntpd[670]: new interface(s) found: waking up resolver May 06 10:14:37 piaudio nmbd[614]: [2024/05/06 10:14:37.232315, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 06 10:14:37 piaudio nmbd[614]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.56 for name WORKGROUP<1d>. May 06 10:14:37 piaudio nmbd[614]: This response was from IP 192.168.178.68, reporting an IP address of 192.168.178.68. May 06 10:14:37 piaudio systemd[1]: Starting Samba Winbind Daemon... May 06 10:14:37 piaudio winbindd[786]: [2024/05/06 10:14:37.657636, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 06 10:14:37 piaudio winbindd[786]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 06 10:14:39 piaudio systemd[1]: Started Samba Winbind Daemon. May 06 10:14:39 piaudio winbindd[786]: [2024/05/06 10:14:39.184127, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 06 10:14:39 piaudio winbindd[786]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 06 10:14:39 piaudio systemd[1]: Starting Samba SMB Daemon... May 06 10:14:39 piaudio volumio[708]: info: MYVOLUMIO Environment detected May 06 10:14:39 piaudio volumio[708]: info: Plugin folders cleanup May 06 10:14:39 piaudio volumio[708]: info: Scanning into folder /volumio/app/plugins/ May 06 10:14:39 piaudio volumio[708]: info: Scanning category audio_interface May 06 10:14:39 piaudio volumio[708]: info: Scanning category miscellanea May 06 10:14:39 piaudio volumio[708]: info: Scanning category music_service May 06 10:14:39 piaudio volumio[708]: info: Scanning category plugins.json May 06 10:14:39 piaudio volumio[708]: info: Scanning category system_controller May 06 10:14:39 piaudio volumio[708]: info: Scanning category user_interface May 06 10:14:39 piaudio volumio[708]: info: Scanning into folder /data/plugins/ May 06 10:14:39 piaudio volumio[708]: info: Plugin folders cleanup completed May 06 10:14:39 piaudio volumio[708]: info: ------------------------------------------- May 06 10:14:39 piaudio volumio[708]: info: ----- Core plugins startup ---- May 06 10:14:39 piaudio volumio[708]: info: ------------------------------------------- May 06 10:14:39 piaudio volumio[708]: info: Loading plugins from folder /volumio/app/plugins/ May 06 10:14:39 piaudio volumio[708]: info: Adding plugin upnp to MyMusic Plugins May 06 10:14:39 piaudio volumio[708]: info: Adding plugin airplay_emulation to MyMusic Plugins May 06 10:14:39 piaudio volumio[708]: info: Adding plugin upnp_browser to MyMusic Plugins May 06 10:14:39 piaudio volumio[708]: info: Loading plugins from folder /data/plugins/ May 06 10:14:39 piaudio volumio[708]: info: Loading plugin "system"... May 06 10:14:39 piaudio volumio[708]: info: Loading plugin "appearance"... May 06 10:14:42 piaudio systemd[1]: Started Samba SMB Daemon. May 06 10:14:42 piaudio systemd[1]: Reached target Multi-User System. May 06 10:14:42 piaudio smbd[791]: [2024/05/06 10:14:42.731862, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 06 10:14:42 piaudio systemd[1]: Reached target Graphical Interface. May 06 10:14:42 piaudio smbd[791]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 06 10:14:42 piaudio systemd[1]: Starting Update UTMP about System Runlevel Changes... May 06 10:14:42 piaudio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 06 10:14:42 piaudio systemd[1]: Started Update UTMP about System Runlevel Changes. May 06 10:14:42 piaudio systemd[1]: Startup finished in 12.020s (kernel) + 21.912s (userspace) = 33.932s. May 06 10:14:42 piaudio volumio-remote-updater[497]: [2024-05-06 10:14:42] [connect] Successful connection May 06 10:14:44 piaudio volumio[708]: info: Loading plugin "network"... May 06 10:14:44 piaudio volumio[708]: info: Refreshing Cached IP Addresses May 06 10:14:44 piaudio volumio[708]: info: Loading plugin "services"... May 06 10:14:44 piaudio sudo[806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 10:14:44 piaudio sudo[806]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:44 piaudio volumio[708]: info: Loading plugin "alsa_controller"... May 06 10:14:44 piaudio sudo[806]: pam_unix(sudo:session): session closed for user root May 06 10:14:44 piaudio sudo[808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 10:14:44 piaudio sudo[808]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:44 piaudio sudo[808]: pam_unix(sudo:session): session closed for user root May 06 10:14:44 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 06 10:14:44 piaudio volumio[708]: info: Loading plugin "wizard"... May 06 10:14:44 piaudio volumio[708]: info: Loading plugin "networkfs"... May 06 10:14:44 piaudio sudo[816]: 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.178.13/Public\\ALBUMS /mnt/NAS/albums May 06 10:14:44 piaudio sudo[816]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:44 piaudio sudo[818]: 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.178.13/Public/ERUDITA /mnt/NAS/Erudita May 06 10:14:44 piaudio sudo[818]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:44 piaudio sudo[822]: 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.178.13/Public\\Hi-Res Audio /mnt/NAS/HiResA May 06 10:14:44 piaudio sudo[822]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:44 piaudio sudo[831]: 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.178.13/Public\\jazz /mnt/NAS/Jazz May 06 10:14:44 piaudio sudo[831]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:44 piaudio volumio[708]: info: Starting Udev Watcher for removable devices May 06 10:14:44 piaudio sudo[841]: 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.178.68/Public /mnt/NAS/Public May 06 10:14:44 piaudio sudo[838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=file101,password=Kano609,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.103/Seagate USB drive\\ALBUMS /mnt/NAS/Shield May 06 10:14:44 piaudio sudo[838]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:44 piaudio sudo[841]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:44 piaudio volumio[708]: info: Ignoring mount for partition: boot May 06 10:14:44 piaudio volumio[708]: info: Ignoring mount for partition: volumio May 06 10:14:44 piaudio volumio[708]: info: Ignoring mount for partition: volumio_data May 06 10:14:44 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 06 10:14:44 piaudio volumio[708]: info: Loading plugin "volumio_command_line_client"... May 06 10:14:44 piaudio volumio[708]: info: Loading plugin "upnp"... May 06 10:14:44 piaudio volumio[708]: info: [1714983284815] Starting Upmpd Daemon May 06 10:14:44 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 06 10:14:44 piaudio volumio[708]: info: Loading plugin "my_music"... May 06 10:14:44 piaudio volumio[708]: info: Loading plugin "mpd"... May 06 10:14:44 piaudio kernel: Key type cifs.spnego registered May 06 10:14:44 piaudio kernel: Key type cifs.idmap registered May 06 10:14:44 piaudio 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 06 10:14:44 piaudio kernel: CIFS: Attempting to mount \\192.168.178.13\Public May 06 10:14:45 piaudio volumio[708]: info: Loading plugin "upnp_browser"... May 06 10:14:45 piaudio volumio[708]: info: Loading plugin "alarm-clock"... May 06 10:14:46 piaudio volumio[708]: info: Loading plugin "airplay_emulation"... May 06 10:14:46 piaudio volumio[708]: info: Starting Shairport Sync May 06 10:14:46 piaudio volumio[708]: info: Loading plugin "last_100"... May 06 10:14:46 piaudio volumio[708]: info: Loading plugin "webradio"... May 06 10:14:46 piaudio volumio[708]: info: Loading plugin "i2s_dacs"... May 06 10:14:46 piaudio volumio[708]: info: I2S DAC not set, start Auto-detection May 06 10:14:46 piaudio volumio[708]: info: Loading plugin "volumiodiscovery"... May 06 10:14:46 piaudio volumio[708]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 06 10:14:46 piaudio volumio[708]: *** WARNING *** Please fix your application to use the native API of Avahi! May 06 10:14:46 piaudio volumio[708]: *** WARNING *** For more information see May 06 10:14:46 piaudio volumio[708]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 06 10:14:46 piaudio volumio[708]: *** WARNING *** Please fix your application to use the native API of Avahi! May 06 10:14:46 piaudio volumio[708]: *** WARNING *** For more information see May 06 10:14:46 piaudio node[708]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 06 10:14:46 piaudio node[708]: *** WARNING *** Please fix your application to use the native API of Avahi! May 06 10:14:46 piaudio node[708]: *** WARNING *** For more information see May 06 10:14:46 piaudio node[708]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 06 10:14:46 piaudio node[708]: *** WARNING *** Please fix your application to use the native API of Avahi! May 06 10:14:46 piaudio node[708]: *** WARNING *** For more information see May 06 10:14:46 piaudio volumio[708]: info: Applying required configuration parameters for plugin volumiodiscovery May 06 10:14:46 piaudio volumio[708]: info: Discovery: Started advertising with name: PIAUDIO May 06 10:14:46 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 06 10:14:46 piaudio volumio[708]: info: Loading plugin "outputs"... May 06 10:14:46 piaudio volumio[708]: info: Loading plugin "albumart"... May 06 10:14:46 piaudio volumio[708]: info: Plugin example_plugin is not enabled May 06 10:14:46 piaudio volumio[708]: info: Loading plugin "inputs"... May 06 10:14:46 piaudio volumio[708]: info: Loading plugin "updater_comm"... May 06 10:14:47 piaudio volumio[708]: info: Plugin mpdemulation is not enabled May 06 10:14:47 piaudio volumio[708]: info: Loading plugin "rest_api"... May 06 10:14:47 piaudio volumio[708]: info: Loading plugin "websocket"... May 06 10:14:47 piaudio volumio[708]: info: Loading i18n strings for locale en May 06 10:14:47 piaudio volumio[708]: Updating browse sources language May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 10:14:47 piaudio volumio[708]: Forking 3 albumart workers May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::initPlayerControls May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 10:14:47 piaudio volumio[708]: Express server listening on port 3000 May 06 10:14:47 piaudio volumio[708]: [Metrics] WebUI: 12s 158.42ms May 06 10:14:47 piaudio volumio[708]: info: CoreStateMachine::resetVolumioState May 06 10:14:47 piaudio volumio[708]: info: CoreStateMachine::getcurrentVolume May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::volumioRetrievevolume May 06 10:14:47 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 06 10:14:48 piaudio volumio[708]: Starting albumart workers May 06 10:14:48 piaudio volumio[708]: Starting albumart workers May 06 10:14:48 piaudio volumio[708]: Starting albumart workers May 06 10:14:48 piaudio volumio[708]: verbose: New Socket.io Connection to 192.168.178.56 from 192.168.178.126 UA: okhttp/4.9.2 Total Clients: 1 May 06 10:14:48 piaudio volumio[708]: verbose: New Socket.io Connection to 192.168.178.56 from 192.168.178.126 UA: okhttp/4.9.2 Total Clients: 2 May 06 10:14:49 piaudio volumio[708]: verbose: New Socket.io Connection to 192.168.178.56 from 192.168.178.126 UA: okhttp/4.9.2 Total Clients: 3 May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 10:14:49 piaudio volumio[708]: info: Discovery: Getting this device information May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::volumioGetState May 06 10:14:49 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 10:14:49 piaudio volumio[708]: info: Reloading queue from file May 06 10:14:49 piaudio volumio[708]: info: VolumeController:: Volume=28 Mute =false May 06 10:14:49 piaudio volumio[708]: info: CoreStateMachine::pushState May 06 10:14:49 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::volumioPushState May 06 10:14:49 piaudio volumio[708]: info: CoreStateMachine::updateTrackBlock May 06 10:14:49 piaudio volumio[708]: info: CorePlayQueue::getTrackBlock May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::volumioRetrievevolume May 06 10:14:49 piaudio volumio[708]: info: Setting Device type: Raspberry PI May 06 10:14:49 piaudio volumio[708]: info: CoreStateMachine::setRepeat false single undefined May 06 10:14:49 piaudio volumio[708]: info: CoreStateMachine::pushState May 06 10:14:49 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::volumioPushState May 06 10:14:49 piaudio volumio[708]: info: CoreStateMachine::setRandom false May 06 10:14:49 piaudio volumio[708]: info: CoreStateMachine::pushState May 06 10:14:49 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::volumioPushState May 06 10:14:49 piaudio volumio[708]: info: Discovery: adding f160da9d-aa4a-43fa-a32c-458f90af5c21 May 06 10:14:49 piaudio volumio[708]: info: Discovery: Found device PIAUDIO May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::volumioGetState May 06 10:14:49 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:14:49 piaudio volumio[708]: info: VolumeController:: Volume=28 Mute =false May 06 10:14:49 piaudio volumio[708]: info: CoreStateMachine::pushState May 06 10:14:49 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:14:49 piaudio volumio[708]: info: CoreCommandRouter::volumioPushState May 06 10:14:51 piaudio sudo[818]: pam_unix(sudo:session): session closed for user root May 06 10:14:51 piaudio volumio[708]: info: Cannot mount NAS Erudita at system boot, trial number 1 ,retrying in 5 seconds May 06 10:14:51 piaudio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 06 10:14:51 piaudio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 06 10:14:51 piaudio kernel: CIFS: Attempting to mount \\192.168.178.68\Public May 06 10:14:51 piaudio sudo[841]: pam_unix(sudo:session): session closed for user root May 06 10:14:51 piaudio kernel: CIFS: Attempting to mount \\192.168.178.13\Public May 06 10:14:53 piaudio volumio[708]: verbose: New Socket.io Connection to 192.168.178.56 from 192.168.178.126 UA: okhttp/4.9.2 Total Clients: 4 May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::volumioGetVisibleSources May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::volumioGetState May 06 10:14:53 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 06 10:14:53 piaudio volumio[708]: info: Received Get System Info May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 10:14:53 piaudio volumio[708]: info: Discovery: Getting this device information May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::volumioGetState May 06 10:14:53 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 10:14:53 piaudio volumio[708]: info: CoreCommandRouter::volumioGetState May 06 10:14:53 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:14:53 piaudio volumio[708]: info: Listing playlists May 06 10:14:54 piaudio volumio[708]: verbose: New Socket.io Connection to 192.168.178.56 from 192.168.178.126 UA: okhttp/4.9.2 Total Clients: 5 May 06 10:14:54 piaudio volumio[708]: info: CoreCommandRouter::volumioGetState May 06 10:14:54 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:14:54 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 06 10:14:54 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 06 10:14:54 piaudio sudo[943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 10:14:54 piaudio sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:54 piaudio sudo[943]: pam_unix(sudo:session): session closed for user root May 06 10:14:54 piaudio sudo[945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 10:14:54 piaudio sudo[945]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:54 piaudio sudo[945]: pam_unix(sudo:session): session closed for user root May 06 10:14:54 piaudio sudo[949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 06 10:14:54 piaudio sudo[949]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:54 piaudio systemd[1]: Started UPnP Renderer front-end to MPD. May 06 10:14:54 piaudio sudo[949]: pam_unix(sudo:session): session closed for user root May 06 10:14:54 piaudio volumio[708]: info: Upmpdcli Daemon Started May 06 10:14:55 piaudio volumio[708]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 06 10:14:56 piaudio sudo[953]: 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.178.13/Public/ERUDITA /mnt/NAS/Erudita May 06 10:14:56 piaudio sudo[953]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:14:57 piaudio sudo[822]: pam_unix(sudo:session): session closed for user root May 06 10:14:57 piaudio volumio[708]: info: Cannot mount NAS HiResA at system boot, trial number 1 ,retrying in 5 seconds May 06 10:14:57 piaudio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 06 10:14:57 piaudio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 06 10:14:57 piaudio kernel: CIFS: Attempting to mount \\192.168.178.13\Public May 06 10:14:57 piaudio systemd[1]: systemd-fsckd.service: Succeeded. May 06 10:14:57 piaudio volumio[708]: info: CoreCommandRouter::volumioGetQueue May 06 10:14:57 piaudio volumio[708]: info: CoreStateMachine::getQueue May 06 10:14:57 piaudio volumio[708]: info: CorePlayQueue::getQueue May 06 10:14:57 piaudio volumio-remote-updater[497]: [2024-05-06 10:14:57] [connect] Successful connection May 06 10:14:57 piaudio volumio-remote-updater[497]: [2024-05-06 10:14:57] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714983297 101 May 06 10:14:57 piaudio volumio[708]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 6 May 06 10:14:59 piaudio volumio[708]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 06 10:15:02 piaudio systemd[1]: systemd-hostnamed.service: Succeeded. May 06 10:15:02 piaudio sudo[960]: 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.178.13/Public\\Hi-Res Audio /mnt/NAS/HiResA May 06 10:15:02 piaudio sudo[960]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:15:03 piaudio volumio[708]: info: CoreCommandRouter::volumioPlay May 06 10:15:03 piaudio volumio[708]: info: CoreStateMachine::play index undefined May 06 10:15:03 piaudio volumio[708]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 10:15:03 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:15:03 piaudio volumio[708]: info: CoreStateMachine::startPlaybackTimer May 06 10:15:03 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:15:03 piaudio volumio[708]: verbose: ControllerMpd::clearAddPlayTracks NAS/Public/ALBUMS/Brian Eno/Brian Eno-Textures-1996/01 - Soft Dawn.mp3 May 06 10:15:03 piaudio volumio[708]: verbose: ControllerMpd::sendMpdCommand stop May 06 10:15:03 piaudio sudo[816]: pam_unix(sudo:session): session closed for user root May 06 10:15:03 piaudio volumio[708]: info: Cannot mount NAS albums at system boot, trial number 1 ,retrying in 5 seconds May 06 10:15:03 piaudio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 06 10:15:03 piaudio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 06 10:15:03 piaudio kernel: CIFS: Attempting to mount \\192.168.178.103\Seagate USB drive May 06 10:15:03 piaudio sudo[838]: pam_unix(sudo:session): session closed for user root May 06 10:15:03 piaudio kernel: CIFS: Attempting to mount \\192.168.178.13\Public May 06 10:15:05 piaudio volumio[708]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 06 10:15:08 piaudio sudo[967]: 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.178.13/Public\\ALBUMS /mnt/NAS/albums May 06 10:15:08 piaudio sudo[967]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:15:09 piaudio sudo[831]: pam_unix(sudo:session): session closed for user root May 06 10:15:09 piaudio volumio[708]: info: Cannot mount NAS Jazz at system boot, trial number 1 ,retrying in 5 seconds May 06 10:15:09 piaudio volumio[708]: info: Completed loading Core Plugins May 06 10:15:09 piaudio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 06 10:15:09 piaudio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 06 10:15:09 piaudio kernel: CIFS: Attempting to mount \\192.168.178.13\Public May 06 10:15:09 piaudio volumio[708]: info: Preparing to generate the ALSA configuration file May 06 10:15:09 piaudio volumio[708]: info: Asound.conf file unchanged, so no further update is needed May 06 10:15:09 piaudio volumio[708]: info: Output device has changed, restarting MPD May 06 10:15:09 piaudio volumio[708]: info: Output device has changed, restarting Shairport Sync May 06 10:15:09 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 10:15:09 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 06 10:15:09 piaudio sudo[972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 06 10:15:09 piaudio sudo[972]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:15:09 piaudio sudo[972]: pam_unix(sudo:session): session closed for user root May 06 10:15:09 piaudio sudo[974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 06 10:15:09 piaudio sudo[974]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:15:09 piaudio volumio[708]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 06 10:15:10 piaudio volumio[708]: info: ___________ START PLUGINS ___________ May 06 10:15:10 piaudio volumio[708]: info: ControllerMpd::onStart: Initializing MPD May 06 10:15:10 piaudio volumio[708]: info: Creating MPD Configuration file May 06 10:15:10 piaudio systemd[1]: Listening on mpd.socket. May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 06 10:15:10 piaudio volumio[708]: info: [1714983310043] CoreMusicLibrary::Adding element Media Servers May 06 10:15:10 piaudio systemd[1]: Starting Music Player Daemon... May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 10:15:10 piaudio sudo[982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 06 10:15:10 piaudio sudo[982]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:15:10 piaudio sudo[982]: pam_unix(sudo:session): session closed for user root May 06 10:15:10 piaudio sudo[984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 06 10:15:10 piaudio sudo[984]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 06 10:15:10 piaudio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 06 10:15:10 piaudio systemd[1]: mpd.service: Succeeded. May 06 10:15:10 piaudio systemd[1]: Stopped Music Player Daemon. May 06 10:15:10 piaudio systemd[1]: Starting Music Player Daemon... May 06 10:15:10 piaudio volumio[708]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 06 10:15:10 piaudio volumio[708]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 06 10:15:10 piaudio volumio[708]: info: [1714983310188] CoreMusicLibrary::Adding element Last_100 May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 06 10:15:10 piaudio volumio[708]: info: [1714983310193] CoreMusicLibrary::Adding element Webradio May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 06 10:15:10 piaudio volumio[708]: info: Volumio Calling Home May 06 10:15:10 piaudio volumio[708]: info: CorePlayQueue::getTrack 0 May 06 10:15:10 piaudio volumio[708]: info: CoreCommandRouter::executeOnPlugin: mpd , goto May 06 10:15:10 piaudio volumio[708]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 10:15:10 piaudio volumio[708]: TypeError: Cannot read property 'then' of undefined May 06 10:15:10 piaudio volumio[708]: at ControllerMpd.listArtist (/volumio/app/plugins/music_service/mpd/index.js:3320:6) May 06 10:15:10 piaudio volumio[708]: at ControllerMpd.goto (/volumio/app/plugins/music_service/mpd/index.js:3745:17) May 06 10:15:10 piaudio volumio[708]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) May 06 10:15:10 piaudio volumio[708]: at CoreMusicLibrary.goto (/volumio/app/musiclibrary.js:574:35) May 06 10:15:10 piaudio volumio[708]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:479:44) May 06 10:15:10 piaudio volumio[708]: at Socket.emit (events.js:315:20) May 06 10:15:10 piaudio volumio[708]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 06 10:15:10 piaudio volumio[708]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 06 10:15:10 piaudio volumio[708]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 10:15:11 piaudio sudo[1007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-06 10:14 May 06 10:15:11 piaudio sudo[1007]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"