-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2024-06-29 11:14:36 UTC. -- Jun 29 11:14:10 lounge kernel: usb usb2: Product: xHCI Host Controller Jun 29 11:14:10 lounge kernel: usb usb2: Manufacturer: Linux 6.1.69-v7l+ xhci-hcd Jun 29 11:14:10 lounge kernel: usb usb2: SerialNumber: 0000:01:00.0 Jun 29 11:14:10 lounge kernel: hub 2-0:1.0: USB hub found Jun 29 11:14:10 lounge kernel: hub 2-0:1.0: 4 ports detected Jun 29 11:14:10 lounge kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Jun 29 11:14:10 lounge kernel: dwc_otg: FIQ enabled Jun 29 11:14:10 lounge kernel: dwc_otg: NAK holdoff enabled Jun 29 11:14:10 lounge kernel: dwc_otg: FIQ split-transaction FSM enabled Jun 29 11:14:10 lounge kernel: Module dwc_common_port init Jun 29 11:14:10 lounge kernel: usbcore: registered new interface driver uas Jun 29 11:14:10 lounge kernel: usbcore: registered new interface driver usb-storage Jun 29 11:14:10 lounge kernel: mousedev: PS/2 mouse device common for all mice Jun 29 11:14:10 lounge kernel: sdhci: Secure Digital Host Controller Interface driver Jun 29 11:14:10 lounge kernel: sdhci: Copyright(c) Pierre Ossman Jun 29 11:14:10 lounge kernel: sdhci-pltfm: SDHCI platform and OF driver helper Jun 29 11:14:10 lounge kernel: ledtrig-cpu: registered to indicate activity on CPUs Jun 29 11:14:10 lounge kernel: hid: raw HID events driver (C) Jiri Kosina Jun 29 11:14:10 lounge kernel: usbcore: registered new interface driver usbhid Jun 29 11:14:10 lounge kernel: usbhid: USB HID core driver Jun 29 11:14:10 lounge kernel: Initializing XFRM netlink socket Jun 29 11:14:10 lounge kernel: NET: Registered PF_PACKET protocol family Jun 29 11:14:10 lounge kernel: Key type dns_resolver registered Jun 29 11:14:10 lounge kernel: Registering SWP/SWPB emulation handler Jun 29 11:14:10 lounge kernel: registered taskstats version 1 Jun 29 11:14:10 lounge kernel: Loading compiled-in X.509 certificates Jun 29 11:14:10 lounge kernel: Key type .fscrypt registered Jun 29 11:14:10 lounge kernel: Key type fscrypt-provisioning registered Jun 29 11:14:10 lounge kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Jun 29 11:14:10 lounge kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Jun 29 11:14:10 lounge kernel: fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 51, base_baud = 0) is a PL011 rev2 Jun 29 11:14:10 lounge kernel: serial serial0: tty port ttyAMA1 registered Jun 29 11:14:10 lounge kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Jun 29 11:14:10 lounge kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Jun 29 11:14:10 lounge kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Jun 29 11:14:10 lounge kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Jun 29 11:14:10 lounge kernel: of_cfs_init Jun 29 11:14:10 lounge kernel: of_cfs_init: OK Jun 29 11:14:10 lounge kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Jun 29 11:14:10 lounge kernel: Freeing unused kernel image (initmem) memory: 2048K Jun 29 11:14:10 lounge kernel: Run /init as init process Jun 29 11:14:10 lounge kernel: with arguments: Jun 29 11:14:10 lounge kernel: /init Jun 29 11:14:10 lounge kernel: splash Jun 29 11:14:10 lounge kernel: with environment: Jun 29 11:14:10 lounge kernel: HOME=/ Jun 29 11:14:10 lounge kernel: TERM=linux Jun 29 11:14:10 lounge kernel: imgpart=/dev/mmcblk0p2 Jun 29 11:14:10 lounge kernel: imgfile=/volumio_current.sqsh Jun 29 11:14:10 lounge kernel: bootdelay=5 Jun 29 11:14:10 lounge kernel: mmc1: new high speed SDIO card at address 0001 Jun 29 11:14:10 lounge kernel: mmc0: new ultra high speed DDR50 SDHC card at address 0001 Jun 29 11:14:10 lounge kernel: mmcblk0: mmc0:0001 SD32G 29.1 GiB Jun 29 11:14:10 lounge kernel: mmcblk0: p1 p2 p3 Jun 29 11:14:10 lounge kernel: mmcblk0: mmc0:0001 SD32G 29.1 GiB Jun 29 11:14:10 lounge kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Jun 29 11:14:10 lounge initramfs: Booting Volumio for BCM2711 Jun 29 11:14:10 lounge initramfs: This script mounts rootfs RO with an overlay RW layer. Jun 29 11:14:10 lounge kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jun 29 11:14:10 lounge initramfs: IMGPART=/dev/mmcblk0p2 Jun 29 11:14:10 lounge initramfs: IMGFILE=/volumio_current.sqsh Jun 29 11:14:10 lounge initramfs: Boot delay (except first time) will be 5 seconds Jun 29 11:14:10 lounge initramfs: /dev/mmcblk0p2: Jun 29 11:14:10 lounge kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Jun 29 11:14:10 lounge kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Jun 29 11:14:10 lounge kernel: usb 1-1: Product: USB2.0 Hub Jun 29 11:14:10 lounge kernel: hub 1-1:1.0: USB hub found Jun 29 11:14:10 lounge kernel: hub 1-1:1.0: 4 ports detected Jun 29 11:14:10 lounge kernel: EXT4-fs (mmcblk0p2): recovery complete Jun 29 11:14:10 lounge kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. Jun 29 11:14:10 lounge initramfs: Doing a 5 second delay here to give kernel load a headstart Jun 29 11:14:10 lounge initramfs: Checking for USB updates Jun 29 11:14:10 lounge initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Jun 29 11:14:10 lounge kernel: loop0: detected capacity change from 0 to 967536 Jun 29 11:14:10 lounge kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jun 29 11:14:10 lounge kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jun 29 11:14:10 lounge kernel: EXT4-fs (mmcblk0p3): recovery complete Jun 29 11:14:10 lounge kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. Jun 29 11:14:10 lounge initramfs: With Option: Jun 29 11:14:10 lounge initramfs: VOLUMIO_VERSION="3.631" Jun 29 11:14:10 lounge initramfs: Finish initramfs, continue booting Volumio Jun 29 11:14:10 lounge systemd[1]: System time before build time, advancing clock. Jun 29 11:14:10 lounge kernel: NET: Registered PF_INET6 protocol family Jun 29 11:14:10 lounge kernel: Segment Routing with IPv6 Jun 29 11:14:10 lounge kernel: In-situ OAM (IOAM) with IPv6 Jun 29 11:14:10 lounge 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) Jun 29 11:14:10 lounge systemd[1]: Detected architecture arm. Jun 29 11:14:10 lounge systemd[1]: Set hostname to . Jun 29 11:14:10 lounge 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. Jun 29 11:14:10 lounge systemd[1]: Listening on Journal Audit Socket. Jun 29 11:14:10 lounge systemd[1]: Listening on Journal Socket (/dev/log). Jun 29 11:14:10 lounge systemd[1]: Listening on initctl Compatibility Named Pipe. Jun 29 11:14:10 lounge systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Jun 29 11:14:10 lounge systemd[1]: Started Forward Password Requests to Wall Directory Watch. Jun 29 11:14:10 lounge systemd[1]: Created slice system-systemd\x2dfsck.slice. Jun 29 11:14:10 lounge kernel: i2c_dev: i2c /dev entries driver Jun 29 11:14:10 lounge systemd-journald[201]: Journal started Jun 29 11:14:10 lounge systemd-journald[201]: Runtime journal (/run/log/journal/f19fe563bf7dcaf9ed2201976245a35f) is 7.5M, max 30.0M, 22.5M free. Feb 14 10:11:59 lounge systemd-modules-load[207]: Inserted module 'i2c_dev' Jun 29 11:14:10 lounge fake-hwclock[204]: Sat Jun 29 11:14:10 UTC 2024 Jun 29 11:14:10 lounge systemd[1]: Started Restore / save the current clock. Jun 29 11:14:10 lounge systemd[1]: Started Remount Root and Kernel File Systems. Jun 29 11:14:10 lounge systemd[1]: Mounted Kernel Configuration File System. Jun 29 11:14:10 lounge systemd[1]: Starting Load/Save Random Seed... Jun 29 11:14:10 lounge systemd[1]: Starting Create System Users... Jun 29 11:14:10 lounge systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jun 29 11:14:10 lounge systemd[1]: dynamicswap.service: Succeeded. Jun 29 11:14:10 lounge systemd[1]: Started Load/Save Random Seed. Jun 29 11:14:10 lounge systemd[1]: Started Apply Kernel Variables. Jun 29 11:14:10 lounge systemd[1]: Started Create System Users. Jun 29 11:14:10 lounge systemd[1]: Starting Create Static Device Nodes in /dev... Jun 29 11:14:10 lounge systemd[1]: Started Create Static Device Nodes in /dev. Jun 29 11:14:10 lounge systemd[1]: Starting udev Kernel Device Manager... Jun 29 11:14:10 lounge systemd[1]: Reached target Local File Systems (Pre). Jun 29 11:14:10 lounge systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jun 29 11:14:10 lounge systemd[1]: Mounting /var/log... Jun 29 11:14:10 lounge systemd[1]: Mounting /var/spool/cups... Jun 29 11:14:10 lounge systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jun 29 11:14:10 lounge systemd[1]: Mounting /tmp... Jun 29 11:14:10 lounge systemd[1]: Started udev Coldplug all Devices. Jun 29 11:14:10 lounge systemd[1]: Mounted /var/log. Jun 29 11:14:10 lounge systemd[1]: Mounted /var/spool/cups. Jun 29 11:14:10 lounge systemd[1]: Mounting /var/spool/cups/tmp... Jun 29 11:14:10 lounge systemd[1]: Starting Flush Journal to Persistent Storage... Jun 29 11:14:10 lounge systemd[1]: Starting Helper to synchronize boot up for ifupdown... Jun 29 11:14:10 lounge systemd[1]: Mounted /tmp. Jun 29 11:14:10 lounge systemd-udevd[233]: Network interface NamePolicy= disabled on kernel command line, ignoring. Jun 29 11:14:10 lounge systemd[1]: Mounted /var/spool/cups/tmp. Jun 29 11:14:10 lounge systemd[1]: Started Helper to synchronize boot up for ifupdown. Jun 29 11:14:10 lounge systemd-journald[201]: Runtime journal (/run/log/journal/f19fe563bf7dcaf9ed2201976245a35f) is 7.5M, max 30.0M, 22.5M free. Jun 29 11:14:10 lounge systemd[1]: Started Flush Journal to Persistent Storage. Jun 29 11:14:10 lounge systemd[1]: Started udev Kernel Device Manager. Jun 29 11:14:10 lounge systemd[1]: Starting Show Plymouth Boot Screen... Jun 29 11:14:10 lounge systemd[1]: Received SIGRTMIN+20 from PID 267 (plymouthd). Jun 29 11:14:10 lounge systemd[1]: Started Show Plymouth Boot Screen. Jun 29 11:14:10 lounge systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jun 29 11:14:10 lounge systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jun 29 11:14:10 lounge systemd[1]: Reached target Local Encrypted Volumes. Jun 29 11:14:10 lounge systemd[1]: Reached target Paths. Jun 29 11:14:10 lounge systemd-udevd[249]: Using default interface naming scheme 'v240'. Jun 29 11:14:10 lounge systemd-udevd[249]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jun 29 11:14:10 lounge kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Jun 29 11:14:10 lounge kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Jun 29 11:14:10 lounge kernel: [vc_sm_connected_init]: start Jun 29 11:14:10 lounge kernel: [vc_sm_connected_init]: installed successfully Jun 29 11:14:10 lounge kernel: mc: Linux media interface: v0.10 Jun 29 11:14:10 lounge kernel: rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000 Jun 29 11:14:10 lounge kernel: rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem Jun 29 11:14:11 lounge systemd-udevd[263]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jun 29 11:14:11 lounge kernel: videodev: Linux video capture interface: v2.00 Jun 29 11:14:11 lounge kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Jun 29 11:14:11 lounge systemd[1]: Found device /dev/mmcblk0p1. Jun 29 11:14:11 lounge kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Jun 29 11:14:11 lounge kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Jun 29 11:14:11 lounge kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Jun 29 11:14:11 lounge kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Jun 29 11:14:11 lounge kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Jun 29 11:14:11 lounge kernel: Bluetooth: Core ver 2.22 Jun 29 11:14:11 lounge kernel: NET: Registered PF_BLUETOOTH protocol family Jun 29 11:14:11 lounge kernel: Bluetooth: HCI device and connection manager initialized Jun 29 11:14:11 lounge kernel: Bluetooth: HCI socket layer initialized Jun 29 11:14:11 lounge kernel: Bluetooth: L2CAP socket layer initialized Jun 29 11:14:11 lounge kernel: Bluetooth: SCO socket layer initialized Jun 29 11:14:11 lounge kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Jun 29 11:14:11 lounge kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Jun 29 11:14:11 lounge kernel: Bluetooth: HCI UART driver ver 2.3 Jun 29 11:14:11 lounge kernel: Bluetooth: HCI UART protocol H4 registered Jun 29 11:14:11 lounge kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Jun 29 11:14:11 lounge kernel: Bluetooth: HCI UART protocol Broadcom registered Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Jun 29 11:14:11 lounge kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Jun 29 11:14:11 lounge kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Jun 29 11:14:11 lounge kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Jun 29 11:14:11 lounge kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Jun 29 11:14:11 lounge kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Jun 29 11:14:11 lounge kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Jun 29 11:14:12 lounge kernel: rpivid feb10000.codec: Device registered as /dev/video19 Jun 29 11:14:12 lounge kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Jun 29 11:14:12 lounge kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Jun 29 11:14:12 lounge kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Jun 29 11:14:12 lounge kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Jun 29 11:14:12 lounge kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Jun 29 11:14:12 lounge kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Jun 29 11:14:12 lounge kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Jun 29 11:14:12 lounge kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Jun 29 11:14:12 lounge kernel: uart-pl011 fe201000.serial: no DMA platform data Jun 29 11:14:12 lounge kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Jun 29 11:14:12 lounge kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Jun 29 11:14:12 lounge kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Jun 29 11:14:12 lounge kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Jun 29 11:14:12 lounge kernel: Bluetooth: hci0: BCM: chip id 107 Jun 29 11:14:12 lounge kernel: Bluetooth: hci0: BCM: features 0x2f Jun 29 11:14:12 lounge kernel: Bluetooth: hci0: BCM4345C0 Jun 29 11:14:12 lounge kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Jun 29 11:14:12 lounge kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Jun 29 11:14:12 lounge kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Jun 29 11:14:12 lounge kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Jun 29 11:14:12 lounge kernel: usbcore: registered new interface driver brcmfmac Jun 29 11:14:12 lounge kernel: wm8804 1-003b: revision E Jun 29 11:14:12 lounge kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 Jun 29 11:14:12 lounge systemd-udevd[246]: Using default interface naming scheme 'v240'. Jun 29 11:14:12 lounge systemd-udevd[246]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jun 29 11:14:13 lounge kernel: Bluetooth: hci0: BCM: features 0x2f Jun 29 11:14:13 lounge kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Jun 29 11:14:13 lounge kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Jun 29 11:14:13 lounge systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Jun 29 11:14:13 lounge systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. Jun 29 11:14:13 lounge systemd[1]: Created slice system-bthelper.slice. Jun 29 11:14:13 lounge systemd[1]: Condition check resulted in FUSE Control File System being skipped. Jun 29 11:14:13 lounge systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jun 29 11:14:13 lounge systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jun 29 11:14:13 lounge systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jun 29 11:14:13 lounge systemd[1]: Condition check resulted in Huge Pages File System being skipped. Jun 29 11:14:13 lounge systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Jun 29 11:14:13 lounge systemd[1]: Starting File System Check on /dev/mmcblk0p1... Jun 29 11:14:13 lounge systemd[1]: Starting Load/Save RF Kill Switch Status... Jun 29 11:14:13 lounge systemd[1]: Started File System Check Daemon to report status. Jun 29 11:14:13 lounge systemd[1]: Started Load/Save RF Kill Switch Status. Jun 29 11:14:13 lounge systemd-fsck[417]: fsck.fat 4.1 (2017-01-24) Jun 29 11:14:13 lounge systemd-fsck[417]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Jun 29 11:14:13 lounge systemd-fsck[417]: Automatically removing dirty bit. Jun 29 11:14:13 lounge systemd-fsck[417]: Performing changes. Jun 29 11:14:13 lounge systemd-fsck[417]: /dev/mmcblk0p1: 371 files, 33358/46774 clusters Jun 29 11:14:13 lounge systemd[1]: Started File System Check on /dev/mmcblk0p1. Jun 29 11:14:13 lounge systemd[1]: Mounting /boot... Jun 29 11:14:14 lounge systemd[1]: Mounted /boot. Jun 29 11:14:14 lounge systemd[1]: Reached target Local File Systems. Jun 29 11:14:14 lounge systemd[1]: Starting Create Volatile Files and Directories... Jun 29 11:14:14 lounge systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jun 29 11:14:14 lounge systemd[1]: Starting Preprocess NFS configuration... Jun 29 11:14:14 lounge systemd[1]: Starting Raise network interfaces... Jun 29 11:14:14 lounge systemd[1]: Started ifup for eth0. Jun 29 11:14:14 lounge systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Jun 29 11:14:14 lounge systemd[1]: Started ifup for wlan0. Jun 29 11:14:14 lounge systemd[1]: plymouth-read-write.service: Succeeded. Jun 29 11:14:14 lounge systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jun 29 11:14:14 lounge systemd[1]: Received SIGRTMIN+20 from PID 267 (plymouthd). Jun 29 11:14:14 lounge systemd[1]: nfs-config.service: Succeeded. Jun 29 11:14:14 lounge systemd[1]: Started Preprocess NFS configuration. Jun 29 11:14:14 lounge systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jun 29 11:14:14 lounge systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jun 29 11:14:14 lounge systemd[1]: Reached target NFS client services. Jun 29 11:14:14 lounge systemd[1]: Started Create Volatile Files and Directories. Jun 29 11:14:14 lounge systemd[1]: Starting RPC bind portmap service... Jun 29 11:14:14 lounge systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Jun 29 11:14:14 lounge systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jun 29 11:14:14 lounge systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Jun 29 11:14:14 lounge kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 29 11:14:14 lounge systemd[1]: Started Update UTMP about System Boot/Shutdown. Jun 29 11:14:14 lounge systemd[1]: Reached target System Initialization. Jun 29 11:14:14 lounge kernel: 8021q: 802.1Q VLAN Support v1.8 Jun 29 11:14:14 lounge systemd[1]: Started Volumio Splash. Jun 29 11:14:14 lounge systemd[1]: apt-daily.timer: Not using persistent file timestamp Thu 2024-08-29 00:43:56 UTC as it is in the future. Jun 29 11:14:14 lounge systemd[1]: Started Daily apt download activities. Jun 29 11:14:14 lounge systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Thu 2024-08-29 06:54:44 UTC as it is in the future. Jun 29 11:14:14 lounge systemd[1]: Started Daily apt upgrade and clean activities. Jun 29 11:14:14 lounge systemd[500]: volumiosplash.service: Failed to execute command: No such file or directory Jun 29 11:14:14 lounge systemd[500]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory Jun 29 11:14:14 lounge systemd[1]: Listening on D-Bus System Message Bus Socket. Jun 29 11:14:14 lounge systemd[1]: Listening on triggerhappy.socket. Jun 29 11:14:14 lounge systemd[1]: Started Daily Cleanup of Temporary Directories. Jun 29 11:14:14 lounge systemd[1]: Reached target Timers. Jun 29 11:14:14 lounge systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jun 29 11:14:14 lounge systemd[1]: Reached target Sockets. Jun 29 11:14:14 lounge systemd[1]: Reached target Basic System. Jun 29 11:14:14 lounge systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Jun 29 11:14:14 lounge systemd[1]: Started D-Bus System Message Bus. Jun 29 11:14:14 lounge systemd[1]: Starting WPA supplicant... Jun 29 11:14:14 lounge systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jun 29 11:14:14 lounge systemd[1]: Started volumio-remote-updater.service. Jun 29 11:14:14 lounge systemd[1]: Starting Login Service... Jun 29 11:14:14 lounge systemd[1]: Started Manage Sound Card State (restore and store). Jun 29 11:14:14 lounge systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Jun 29 11:14:14 lounge systemd[1]: Starting dhcpcd on all interfaces... Jun 29 11:14:14 lounge systemd[1]: Started UPnP Renderer front-end to MPD. Jun 29 11:14:14 lounge systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Jun 29 11:14:14 lounge systemd[1]: Started Volumio Log Rotation Service. Jun 29 11:14:14 lounge alsactl[528]: alsactl 1.1.8 daemon started Jun 29 11:14:14 lounge dhcpcd[529]: Not running dhcpcd because /etc/network/interfaces Jun 29 11:14:14 lounge dhcpcd[529]: defines some interfaces that will use a Jun 29 11:14:14 lounge dhcpcd[529]: DHCP client or static address Jun 29 11:14:14 lounge systemd[1]: Started Volumio Iptables Module. Jun 29 11:14:14 lounge systemd[1]: Starting Wireless Services... Jun 29 11:14:14 lounge systemd[1]: Starting triggerhappy global hotkey daemon... Jun 29 11:14:14 lounge systemd[1]: Starting Save/Restore Sound Card State... Jun 29 11:14:15 lounge systemd[1]: Starting Configure Bluetooth Modems connected by UART... Jun 29 11:14:15 lounge systemd[1]: Started RPC bind portmap service. Jun 29 11:14:15 lounge systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC Jun 29 11:14:15 lounge systemd[1]: volumiosplash.service: Failed with result 'exit-code'. Jun 29 11:14:15 lounge systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Jun 29 11:14:15 lounge systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Jun 29 11:14:15 lounge systemd[1]: Failed to start dhcpcd on all interfaces. Jun 29 11:14:15 lounge thd[539]: Unable to parse trigger line: Jun 29 11:14:15 lounge thd[539]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Jun 29 11:14:15 lounge thd[539]: Unable to parse trigger line: Jun 29 11:14:15 lounge thd[539]: Unable to parse trigger line: Jun 29 11:14:15 lounge thd[539]: Unable to parse trigger line: Jun 29 11:14:15 lounge thd[539]: Unable to parse trigger line: Jun 29 11:14:15 lounge thd[539]: Unable to parse trigger line: Jun 29 11:14:15 lounge thd[539]: Unable to parse trigger line: Jun 29 11:14:15 lounge thd[539]: Found socket passed from systemd Jun 29 11:14:15 lounge systemd[1]: Started triggerhappy global hotkey daemon. Jun 29 11:14:15 lounge systemd[1]: Reached target Remote File Systems (Pre). Jun 29 11:14:15 lounge systemd[1]: Reached target Remote File Systems. Jun 29 11:14:15 lounge systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Jun 29 11:14:15 lounge systemd[1]: Reached target RPC Port Mapper. Jun 29 11:14:15 lounge avahi-daemon[525]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Jun 29 11:14:15 lounge avahi-daemon[525]: Successfully dropped root privileges. Jun 29 11:14:15 lounge systemd[1]: Started Save/Restore Sound Card State. Jun 29 11:14:15 lounge avahi-daemon[525]: avahi-daemon 0.7 starting up. Jun 29 11:14:15 lounge sh[431]: wlan0=wlan0 Jun 29 11:14:15 lounge systemd[1]: Reached target Sound Card. Jun 29 11:14:15 lounge systemd-logind[527]: New seat seat0. Jun 29 11:14:15 lounge kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Jun 29 11:14:15 lounge sh[427]: eth0: waiting for carrier Jun 29 11:14:15 lounge dhcpcd[476]: eth0: waiting for carrier Jun 29 11:14:15 lounge kernel: bcmgenet fd580000.ethernet eth0: Link is Down Jun 29 11:14:15 lounge systemd[1]: hciuart.service: Succeeded. Jun 29 11:14:15 lounge systemd[1]: Started Configure Bluetooth Modems connected by UART. Jun 29 11:14:15 lounge wpa_supplicant[524]: Successfully initialized wpa_supplicant Jun 29 11:14:15 lounge avahi-daemon[525]: Successfully called chroot(). Jun 29 11:14:15 lounge avahi-daemon[525]: Successfully dropped remaining capabilities. Jun 29 11:14:15 lounge avahi-daemon[525]: Loading service file /services/volumio.service. Jun 29 11:14:15 lounge avahi-daemon[525]: Network interface enumeration completed. Jun 29 11:14:15 lounge avahi-daemon[525]: Server startup complete. Host name is lounge.local. Local service cookie is 2790364935. Jun 29 11:14:15 lounge avahi-daemon[525]: Service "Lounge" (/services/volumio.service) successfully established. Jun 29 11:14:16 lounge systemd[1]: Started Login Service. Jun 29 11:14:16 lounge systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jun 29 11:14:16 lounge systemd[1]: Started Raise network interfaces. Jun 29 11:14:16 lounge systemd[1]: Started WPA supplicant. Jun 29 11:14:16 lounge systemd[1]: Reached target Network. Jun 29 11:14:16 lounge volumio-remote-updater[526]: Error: No active session Jun 29 11:14:16 lounge systemd[1]: Starting Permit User Sessions... Jun 29 11:14:16 lounge volumio-remote-updater[526]: [2024-06-29 11:14:16] [info] asio async_connect error: system:111 (Connection refused) Jun 29 11:14:16 lounge volumio-remote-updater[526]: [2024-06-29 11:14:16] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 29 11:14:16 lounge volumio-remote-updater[526]: [2024-06-29 11:14:16] [error] handle_connect error: Underlying Transport Error Jun 29 11:14:16 lounge systemd[1]: Starting Network Time Service... Jun 29 11:14:16 lounge systemd[1]: Starting OpenBSD Secure Shell server... Jun 29 11:14:16 lounge systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Jun 29 11:14:16 lounge systemd[1]: Reached target Network is Online. Jun 29 11:14:16 lounge systemd[1]: Starting /etc/rc.local Compatibility... Jun 29 11:14:16 lounge systemd[1]: Starting Samba NMB Daemon... Jun 29 11:14:16 lounge systemd[1]: Starting LSB: Brings up/down network automatically... Jun 29 11:14:16 lounge volumio[531]: Could not open config: /tmp/upmpdcli.conf Jun 29 11:14:16 lounge systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 29 11:14:16 lounge systemd[1]: Starting Raspberry Pi bluetooth helper... Jun 29 11:14:16 lounge systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jun 29 11:14:16 lounge systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jun 29 11:14:16 lounge systemd[1]: Started Permit User Sessions. Jun 29 11:14:16 lounge systemd[1]: Started /etc/rc.local Compatibility. Jun 29 11:14:16 lounge systemd[1]: Starting Terminate Plymouth Boot Screen... Jun 29 11:14:16 lounge systemd[1]: Starting Hold until boot process finishes up... Jun 29 11:14:16 lounge systemd[1]: Received SIGRTMIN+21 from PID 267 (plymouthd). Jun 29 11:14:16 lounge systemd[1]: plymouth-start.service: Succeeded. Jun 29 11:14:16 lounge systemd[1]: plymouth-quit.service: Succeeded. Jun 29 11:14:16 lounge systemd[1]: Started Terminate Plymouth Boot Screen. Jun 29 11:14:16 lounge systemd[1]: plymouth-quit-wait.service: Succeeded. Jun 29 11:14:16 lounge systemd[1]: Started Hold until boot process finishes up. Jun 29 11:14:16 lounge systemd[1]: Received SIGRTMIN+21 from PID 267 (n/a). Jun 29 11:14:16 lounge systemd[1]: Started Getty on tty1. Jun 29 11:14:16 lounge systemd[1]: Reached target Login Prompts. Jun 29 11:14:16 lounge bthelper[625]: Raspberry Pi BDADDR already set Jun 29 11:14:16 lounge loadcpufreq[548]: Loading cpufreq kernel modules...done (none). Jun 29 11:14:16 lounge systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Jun 29 11:14:16 lounge systemd[1]: Started Raspberry Pi bluetooth helper. Jun 29 11:14:16 lounge systemd[1]: iptables.service: Succeeded. Jun 29 11:14:16 lounge ntpd[608]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 29 11:14:16 lounge ifplugd(eth0)[670]: ifplugd 0.28 initializing. Jun 29 11:14:16 lounge ifplugd(eth0)[670]: Using interface eth0/DC:A6:32:04:26:2D with driver (version: 6.1.69-v7l+) Jun 29 11:14:16 lounge systemd[1]: Starting Bluetooth service... Jun 29 11:14:16 lounge ifplugd(eth0)[670]: Using detection mode: SIOCETHTOOL Jun 29 11:14:16 lounge ifplugd(eth0)[670]: Initialization complete, link beat not detected. Jun 29 11:14:16 lounge ntpd[608]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Jun 29 11:14:16 lounge systemd[1]: Starting LSB: set CPUFreq kernel parameters... Jun 29 11:14:16 lounge systemd[1]: Started Network Time Service. Jun 29 11:14:16 lounge ifplugd[622]: Network Interface Plugging Daemon...start eth0...done. Jun 29 11:14:16 lounge systemd[1]: Started LSB: Brings up/down network automatically. Jun 29 11:14:16 lounge ntpd[672]: proto: precision = 2.129 usec (-19) Jun 29 11:14:16 lounge ntpd[672]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 29 11:14:16 lounge ntpd[672]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 29 11:14:16 lounge ntpd[672]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 2 days ago Jun 29 11:14:16 lounge ntpd[672]: Listen and drop on 0 v6wildcard [::]:123 Jun 29 11:14:16 lounge ntpd[672]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 29 11:14:16 lounge ntpd[672]: Listen normally on 2 lo 127.0.0.1:123 Jun 29 11:14:16 lounge ntpd[672]: Listening on routing socket on fd #19 for interface updates Jun 29 11:14:16 lounge ntpd[672]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 29 11:14:16 lounge ntpd[672]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 29 11:14:17 lounge sshd[685]: Server listening on 0.0.0.0 port 22. Jun 29 11:14:17 lounge sshd[685]: Server listening on :: port 22. Jun 29 11:14:17 lounge systemd[1]: Started OpenBSD Secure Shell server. Jun 29 11:14:17 lounge bluetoothd[671]: Bluetooth daemon 5.50 Jun 29 11:14:17 lounge bluetoothd[671]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Jun 29 11:14:17 lounge systemd[1]: Started Bluetooth service. Jun 29 11:14:17 lounge systemd[1]: Reached target Bluetooth. Jun 29 11:14:17 lounge bluetoothd[671]: Starting SDP server Jun 29 11:14:17 lounge bluetoothd[671]: Excluding (cli) sap Jun 29 11:14:17 lounge cpufrequtils[673]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Jun 29 11:14:17 lounge systemd[1]: Started LSB: set CPUFreq kernel parameters. Jun 29 11:14:17 lounge bluetoothd[671]: Bluetooth management interface 1.22 initialized Jun 29 11:14:17 lounge dbus-daemon[521]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=671 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Jun 29 11:14:17 lounge kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Jun 29 11:14:17 lounge kernel: Bluetooth: BNEP filters: protocol multicast Jun 29 11:14:17 lounge kernel: Bluetooth: BNEP socket layer initialized Jun 29 11:14:17 lounge kernel: Bluetooth: MGMT ver 1.22 Jun 29 11:14:17 lounge bluetoothd[671]: Failed to set privacy: Rejected (0x0b) Jun 29 11:14:17 lounge systemd[1]: Starting Hostname Service... Jun 29 11:14:17 lounge dbus-daemon[521]: [system] Successfully activated service 'org.freedesktop.hostname1' Jun 29 11:14:17 lounge systemd[1]: Started Hostname Service. Jun 29 11:14:17 lounge nmbd[630]: [2024/06/29 11:14:17.627847, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jun 29 11:14:17 lounge nmbd[630]: started asyncdns process 697 Jun 29 11:14:17 lounge nmbd[630]: [2024/06/29 11:14:17.629459, 0] ../lib/util/become_daemon.c:149(daemon_status) Jun 29 11:14:17 lounge nmbd[630]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jun 29 11:14:17 lounge nmbd[630]: [2024/06/29 11:14:17.629575, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jun 29 11:14:17 lounge nmbd[630]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jun 29 11:14:17 lounge haveged[480]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Jun 29 11:14:17 lounge haveged[480]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Jun 29 11:14:17 lounge haveged[480]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99931 Jun 29 11:14:17 lounge haveged[480]: haveged: fills: 0, generated: 0 Jun 29 11:14:17 lounge wireless.js[538]: Cleaning previous... Jun 29 11:14:17 lounge ntpd[672]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jun 29 11:14:17 lounge sudo[705]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 29 11:14:17 lounge sudo[705]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:17 lounge sudo[705]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:18 lounge sudo[707]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 29 11:14:18 lounge sudo[707]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:18 lounge sudo[707]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:18 lounge wireless.js[538]: Stopped aP Jun 29 11:14:18 lounge sudo[714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 29 11:14:18 lounge sudo[714]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:18 lounge sudo[714]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:18 lounge kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 29 11:14:18 lounge sudo[716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jun 29 11:14:18 lounge sudo[716]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:18 lounge sudo[716]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:18 lounge sudo[723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 29 11:14:18 lounge sudo[723]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:18 lounge sudo[723]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:18 lounge sudo[725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jun 29 11:14:18 lounge sudo[725]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:18 lounge systemd[1]: systemd-rfkill.service: Succeeded. Jun 29 11:14:18 lounge ntpd[672]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jun 29 11:14:19 lounge sh[427]: eth0: carrier acquired Jun 29 11:14:19 lounge dhcpcd[476]: eth0: carrier acquired Jun 29 11:14:19 lounge kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Jun 29 11:14:19 lounge sh[427]: DUID 00:01:00:01:29:d8:61:9f:dc:a6:32:04:26:2d Jun 29 11:14:19 lounge sh[427]: eth0: IAID 32:04:26:2d Jun 29 11:14:19 lounge dhcpcd[476]: DUID 00:01:00:01:29:d8:61:9f:dc:a6:32:04:26:2d Jun 29 11:14:19 lounge dhcpcd[476]: eth0: IAID 32:04:26:2d Jun 29 11:14:19 lounge dhcpcd[476]: eth0: adding address fe80::cdd6:8173:fe68:ba75 Jun 29 11:14:19 lounge sh[427]: eth0: adding address fe80::cdd6:8173:fe68:ba75 Jun 29 11:14:19 lounge sh[427]: ipv6_addaddr1: Permission denied Jun 29 11:14:19 lounge dhcpcd[476]: ipv6_addaddr1: Permission denied Jun 29 11:14:19 lounge sh[427]: eth0: soliciting an IPv6 router Jun 29 11:14:19 lounge dhcpcd[476]: eth0: soliciting an IPv6 router Jun 29 11:14:19 lounge ntpd[672]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jun 29 11:14:19 lounge ifplugd(eth0)[670]: Link beat detected. Jun 29 11:14:20 lounge ifplugd(eth0)[670]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jun 29 11:14:20 lounge ifplugd(eth0)[670]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Jun 29 11:14:20 lounge sh[427]: eth0: rebinding lease of 192.168.1.119 Jun 29 11:14:20 lounge dhcpcd[476]: eth0: rebinding lease of 192.168.1.119 Jun 29 11:14:20 lounge sh[427]: eth0: probing address 192.168.1.119/24 Jun 29 11:14:20 lounge dhcpcd[476]: eth0: probing address 192.168.1.119/24 Jun 29 11:14:20 lounge ntpd[672]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jun 29 11:14:21 lounge volumio-remote-updater[526]: [2024-06-29 11:14:21] [info] asio async_connect error: system:111 (Connection refused) Jun 29 11:14:21 lounge volumio-remote-updater[526]: [2024-06-29 11:14:21] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 29 11:14:21 lounge volumio-remote-updater[526]: [2024-06-29 11:14:21] [error] handle_connect error: Underlying Transport Error Jun 29 11:14:21 lounge sudo[725]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:21 lounge wireless.js[538]: SETTING APPROPRIATE REG DOMAIN: GB Jun 29 11:14:21 lounge sudo[736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 29 11:14:21 lounge sudo[736]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:21 lounge sudo[736]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:21 lounge sudo[738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set GB Jun 29 11:14:21 lounge sudo[738]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:21 lounge sudo[738]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:21 lounge wireless.js[538]: SUCCESSFULLY SET NEW REGDOMAIN: GB Jun 29 11:14:21 lounge sudo[745]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 29 11:14:21 lounge sudo[745]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:21 lounge sudo[745]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:21 lounge sudo[747]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 29 11:14:21 lounge sudo[747]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:21 lounge bthelper[625]: Changing power off succeeded Jun 29 11:14:21 lounge bthelper[625]: [CHG] Controller DC:A6:32:04:26:2F Class: 0x0000041c Jun 29 11:14:21 lounge bthelper[625]: Changing power on succeeded Jun 29 11:14:21 lounge sudo[747]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:21 lounge wireless.js[538]: Hotspot is disabled, not starting it Jun 29 11:14:22 lounge kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 29 11:14:22 lounge systemd[1]: wireless.service: Succeeded. Jun 29 11:14:22 lounge systemd[1]: Started Wireless Services. Jun 29 11:14:22 lounge kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 29 11:14:22 lounge systemd[1]: Started Volumio Backend Module. Jun 29 11:14:22 lounge systemd[1]: Started Volumio Cpu Tweaker. Jun 29 11:14:22 lounge volumio-cpu-tweak[761]: Setting RT Priority for mpd Jun 29 11:14:22 lounge volumio-cpu-tweak[761]: pid 35's current scheduling policy: SCHED_OTHER Jun 29 11:14:22 lounge volumio-cpu-tweak[761]: pid 35's current scheduling priority: 0 Jun 29 11:14:22 lounge volumio-cpu-tweak[761]: Setting MPD Affinity Jun 29 11:14:22 lounge volumio-cpu-tweak[761]: pid 3's current affinity mask: f Jun 29 11:14:22 lounge volumio-cpu-tweak[761]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jun 29 11:14:22 lounge volumio-cpu-tweak[761]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jun 29 11:14:22 lounge systemd[1]: volumio_cpu_tweak.service: Succeeded. Jun 29 11:14:23 lounge volumio[760]: info: ------------------------------------------- Jun 29 11:14:23 lounge volumio[760]: info: ----- Volumio3 ---- Jun 29 11:14:23 lounge volumio[760]: info: ------------------------------------------- Jun 29 11:14:23 lounge volumio[760]: info: ----- System startup ---- Jun 29 11:14:23 lounge volumio[760]: info: ------------------------------------------- Jun 29 11:14:24 lounge volumio[760]: info: MYVOLUMIO Environment detected Jun 29 11:14:24 lounge volumio[760]: info: Plugin folders cleanup Jun 29 11:14:24 lounge volumio[760]: info: Scanning into folder /volumio/app/plugins/ Jun 29 11:14:24 lounge volumio[760]: info: Scanning category audio_interface Jun 29 11:14:24 lounge volumio[760]: info: Scanning category miscellanea Jun 29 11:14:24 lounge volumio[760]: info: Scanning category music_service Jun 29 11:14:24 lounge volumio[760]: info: Scanning category plugins.json Jun 29 11:14:24 lounge volumio[760]: info: Scanning category system_controller Jun 29 11:14:24 lounge volumio[760]: info: Scanning category user_interface Jun 29 11:14:24 lounge volumio[760]: info: Scanning into folder /data/plugins/ Jun 29 11:14:24 lounge volumio[760]: info: Plugin folders cleanup completed Jun 29 11:14:24 lounge volumio[760]: info: ------------------------------------------- Jun 29 11:14:24 lounge volumio[760]: info: ----- Core plugins startup ---- Jun 29 11:14:24 lounge volumio[760]: info: ------------------------------------------- Jun 29 11:14:24 lounge volumio[760]: info: Loading plugins from folder /volumio/app/plugins/ Jun 29 11:14:24 lounge volumio[760]: info: Adding plugin upnp to MyMusic Plugins Jun 29 11:14:24 lounge volumio[760]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 29 11:14:24 lounge volumio[760]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 29 11:14:24 lounge volumio[760]: info: Loading plugins from folder /data/plugins/ Jun 29 11:14:24 lounge volumio[760]: info: Loading plugin "system"... Jun 29 11:14:24 lounge volumio[760]: info: Loading plugin "appearance"... Jun 29 11:14:25 lounge sh[427]: eth0: leased 192.168.1.119 for infinity Jun 29 11:14:25 lounge sh[427]: eth0: adding route to 192.168.1.0/24 Jun 29 11:14:25 lounge sh[427]: eth0: adding default route via 192.168.1.1 Jun 29 11:14:25 lounge dhcpcd[476]: eth0: leased 192.168.1.119 for infinity Jun 29 11:14:25 lounge dhcpcd[476]: eth0: adding route to 192.168.1.0/24 Jun 29 11:14:25 lounge dhcpcd[476]: eth0: adding default route via 192.168.1.1 Jun 29 11:14:25 lounge avahi-daemon[525]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.119. Jun 29 11:14:25 lounge avahi-daemon[525]: New relevant interface eth0.IPv4 for mDNS. Jun 29 11:14:25 lounge avahi-daemon[525]: Registering new address record for 192.168.1.119 on eth0.IPv4. Jun 29 11:14:25 lounge sh[427]: forked to background, child pid 811 Jun 29 11:14:25 lounge dhcpcd[476]: forked to background, child pid 811 Jun 29 11:14:25 lounge ifplugd(eth0)[670]: client: ifup: interface eth0 already configured Jun 29 11:14:25 lounge sh[427]: eth0=eth0 Jun 29 11:14:25 lounge ifplugd(eth0)[670]: Program executed successfully. Jun 29 11:14:25 lounge volumio[760]: info: Loading plugin "network"... Jun 29 11:14:25 lounge volumio[760]: info: Refreshing Cached IP Addresses Jun 29 11:14:25 lounge sudo[838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 29 11:14:25 lounge sudo[838]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:25 lounge volumio[760]: info: Loading plugin "services"... Jun 29 11:14:25 lounge sudo[840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 29 11:14:25 lounge sudo[838]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:25 lounge sudo[840]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:25 lounge volumio[760]: info: Loading plugin "alsa_controller"... Jun 29 11:14:25 lounge sudo[843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 29 11:14:25 lounge sudo[843]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:25 lounge sudo[840]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:25 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 29 11:14:25 lounge volumio[760]: info: Loading plugin "wizard"... Jun 29 11:14:25 lounge volumio[760]: info: Loading plugin "networkfs"... Jun 29 11:14:25 lounge volumio[760]: info: Starting Udev Watcher for removable devices Jun 29 11:14:25 lounge sudo[849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Jeffr,password=Athena01,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.111/Music/SACD /mnt/NAS/Super_Audio Jun 29 11:14:25 lounge sudo[849]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:25 lounge volumio[760]: info: Ignoring mount for partition: boot Jun 29 11:14:25 lounge volumio[760]: info: Ignoring mount for partition: volumio Jun 29 11:14:25 lounge volumio[760]: info: Ignoring mount for partition: volumio_data Jun 29 11:14:25 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 29 11:14:25 lounge volumio[760]: info: Loading plugin "volumio_command_line_client"... Jun 29 11:14:25 lounge volumio[760]: info: Loading plugin "upnp"... Jun 29 11:14:25 lounge volumio[760]: info: [1719659665811] Starting Upmpd Daemon Jun 29 11:14:25 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 29 11:14:25 lounge volumio[760]: info: Loading plugin "my_music"... Jun 29 11:14:25 lounge volumio[760]: info: Loading plugin "mpd"... Jun 29 11:14:25 lounge sudo[849]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:25 lounge kernel: Key type cifs.spnego registered Jun 29 11:14:25 lounge kernel: Key type cifs.idmap registered Jun 29 11:14:25 lounge 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. Jun 29 11:14:25 lounge kernel: CIFS: Attempting to mount \\192.168.1.111\Music Jun 29 11:14:25 lounge kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 29 11:14:25 lounge kernel: CIFS: VFS: cifs_mount failed w/return code = -111 Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "upnp_browser"... Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "alarm-clock"... Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "airplay_emulation"... Jun 29 11:14:26 lounge volumio[760]: info: Starting Shairport Sync Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "last_100"... Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "webradio"... Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "i2s_dacs"... Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "volumiodiscovery"... Jun 29 11:14:26 lounge volumio[760]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 29 11:14:26 lounge volumio[760]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 29 11:14:26 lounge node[760]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 29 11:14:26 lounge volumio[760]: *** WARNING *** For more information see Jun 29 11:14:26 lounge volumio[760]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 29 11:14:26 lounge volumio[760]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 29 11:14:26 lounge volumio[760]: *** WARNING *** For more information see Jun 29 11:14:26 lounge node[760]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 29 11:14:26 lounge node[760]: *** WARNING *** For more information see Jun 29 11:14:26 lounge node[760]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 29 11:14:26 lounge node[760]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 29 11:14:26 lounge node[760]: *** WARNING *** For more information see Jun 29 11:14:26 lounge volumio[760]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 29 11:14:26 lounge volumio[760]: info: Discovery: Started advertising with name: Lounge Jun 29 11:14:26 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "outputs"... Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "albumart"... Jun 29 11:14:26 lounge volumio[760]: info: Plugin example_plugin is not enabled Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "inputs"... Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "updater_comm"... Jun 29 11:14:26 lounge ntpd[672]: Listen normally on 3 eth0 192.168.1.119:123 Jun 29 11:14:26 lounge ntpd[672]: new interface(s) found: waking up resolver Jun 29 11:14:26 lounge volumio[760]: info: Plugin mpdemulation is not enabled Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "rest_api"... Jun 29 11:14:26 lounge volumio[760]: info: Loading plugin "websocket"... Jun 29 11:14:26 lounge volumio[760]: info: Loading i18n strings for locale en Jun 29 11:14:26 lounge volumio[760]: Updating browse sources language Jun 29 11:14:26 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 29 11:14:26 lounge volumio[760]: Forking 3 albumart workers Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::initPlayerControls Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 11:14:27 lounge volumio[760]: Express server listening on port 3000 Jun 29 11:14:27 lounge volumio[760]: [Metrics] WebUI: 4s 9.49ms Jun 29 11:14:27 lounge volumio[760]: info: CoreStateMachine::resetVolumioState Jun 29 11:14:27 lounge volumio[760]: info: CoreStateMachine::getcurrentVolume Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::volumioRetrievevolume Jun 29 11:14:27 lounge volumio[760]: info: CoreStateMachine::pushState Jun 29 11:14:27 lounge volumio[760]: info: CorePlayQueue::getTrack 0 Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::volumioPushState Jun 29 11:14:27 lounge volumio[760]: info: Cannot mount NAS Super_Audio at system boot, trial number 1 ,retrying in 5 seconds Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 29 11:14:27 lounge volumio[760]: info: Reloading queue from file Jun 29 11:14:27 lounge volumio[760]: info: CoreStateMachine::setRepeat null single undefined Jun 29 11:14:27 lounge volumio[760]: info: CoreStateMachine::pushState Jun 29 11:14:27 lounge volumio[760]: info: CorePlayQueue::getTrack 0 Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::volumioPushState Jun 29 11:14:27 lounge volumio[760]: info: CoreStateMachine::setRandom false Jun 29 11:14:27 lounge volumio[760]: info: CoreStateMachine::pushState Jun 29 11:14:27 lounge volumio[760]: info: CorePlayQueue::getTrack 0 Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::volumioPushState Jun 29 11:14:27 lounge volumio[760]: info: Setting Device type: Raspberry PI Jun 29 11:14:27 lounge volumio[760]: info: Discovery: adding d2104474-b65b-44a0-87dd-4963ab5db356 Jun 29 11:14:27 lounge volumio[760]: info: Discovery: Found device Lounge Jun 29 11:14:27 lounge volumio[760]: info: CoreCommandRouter::volumioGetState Jun 29 11:14:27 lounge volumio[760]: info: CorePlayQueue::getTrack 0 Jun 29 11:14:27 lounge volumio[760]: Starting albumart workers Jun 29 11:14:27 lounge volumio[760]: Starting albumart workers Jun 29 11:14:27 lounge volumio[760]: Starting albumart workers Jun 29 11:14:27 lounge nmbd[630]: [2024/06/29 11:14:27.632687, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 29 11:14:27 lounge nmbd[630]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jun 29 11:14:27 lounge systemd[1]: Started Samba NMB Daemon. Jun 29 11:14:27 lounge systemd[1]: Starting Samba Winbind Daemon... Jun 29 11:14:27 lounge winbindd[899]: [2024/06/29 11:14:27.991901, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jun 29 11:14:27 lounge winbindd[899]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jun 29 11:14:28 lounge winbindd[899]: [2024/06/29 11:14:28.010867, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 29 11:14:28 lounge winbindd[899]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jun 29 11:14:28 lounge systemd[1]: Started Samba Winbind Daemon. Jun 29 11:14:28 lounge systemd[1]: Starting Samba SMB Daemon... Jun 29 11:14:28 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 11:14:28 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 11:14:28 lounge volumio[760]: info: Discovery: Getting this device information Jun 29 11:14:28 lounge volumio[760]: info: CoreCommandRouter::volumioGetState Jun 29 11:14:28 lounge volumio[760]: info: CorePlayQueue::getTrack 0 Jun 29 11:14:28 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 11:14:28 lounge sudo[843]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:28 lounge volumio[760]: verbose: New Socket.io Connection to 192.168.1.119:3000 from 192.168.1.134 UA: Dart/3.4 (dart:io) Total Clients: 1 Jun 29 11:14:28 lounge winbindd[899]: [2024/06/29 11:14:28.363444, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Jun 29 11:14:28 lounge winbindd[899]: res_names->count = 3, expected 4 Jun 29 11:14:28 lounge volumio[760]: info: CoreCommandRouter::volumioGetState Jun 29 11:14:28 lounge volumio[760]: info: CorePlayQueue::getTrack 0 Jun 29 11:14:28 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 29 11:14:28 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 29 11:14:28 lounge smbd[928]: [2024/06/29 11:14:28.384210, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 29 11:14:28 lounge smbd[928]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 29 11:14:28 lounge systemd[1]: Started Samba SMB Daemon. Jun 29 11:14:28 lounge systemd[1]: Reached target Multi-User System. Jun 29 11:14:28 lounge systemd[1]: Reached target Graphical Interface. Jun 29 11:14:28 lounge systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 29 11:14:28 lounge systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 29 11:14:28 lounge systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 29 11:14:28 lounge systemd[1]: Startup finished in 10.250s (kernel) + 20.108s (userspace) = 30.359s. Jun 29 11:14:28 lounge volumio-remote-updater[526]: [2024-06-29 11:14:28] [connect] Successful connection Jun 29 11:14:28 lounge volumio-remote-updater[526]: [2024-06-29 11:14:28] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1719659668 101 Jun 29 11:14:28 lounge volumio[760]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2 Jun 29 11:14:32 lounge sudo[938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Jeffr,password=Athena01,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.111/Music/SACD /mnt/NAS/Super_Audio Jun 29 11:14:32 lounge sudo[938]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:32 lounge sudo[938]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:32 lounge kernel: CIFS: Attempting to mount \\192.168.1.111\Music Jun 29 11:14:32 lounge kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 29 11:14:32 lounge kernel: CIFS: VFS: cifs_mount failed w/return code = -111 Jun 29 11:14:32 lounge volumio[760]: info: Cannot mount NAS Super_Audio at system boot, trial number 2 ,retrying in 5 seconds Jun 29 11:14:33 lounge sudo[943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 29 11:14:33 lounge sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:33 lounge sudo[943]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:33 lounge sudo[945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 29 11:14:33 lounge sudo[945]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:33 lounge sudo[945]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:33 lounge volumio[760]: verbose: New Socket.io Connection to 192.168.1.119 from 192.168.1.134 UA: Mozilla/5.0 (Linux; Android 13; SM-T870 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Safari/537.36 Total Clients: 3 Jun 29 11:14:33 lounge sudo[949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 29 11:14:33 lounge sudo[949]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:33 lounge sudo[949]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:33 lounge sudo[951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 29 11:14:33 lounge sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:33 lounge sudo[951]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:33 lounge volumio[760]: verbose: New Socket.io Connection to 192.168.1.119 from 192.168.1.134 UA: Mozilla/5.0 (Linux; Android 13; SM-T870 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Safari/537.36 Total Clients: 4 Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::volumioGetVisibleSources Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::volumioGetState Jun 29 11:14:34 lounge volumio[760]: info: CorePlayQueue::getTrack 0 Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::volumioGetQueue Jun 29 11:14:34 lounge volumio[760]: info: CoreStateMachine::getQueue Jun 29 11:14:34 lounge volumio[760]: info: CorePlayQueue::getQueue Jun 29 11:14:34 lounge volumio[760]: info: Listing playlists Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 29 11:14:34 lounge volumio[760]: info: Received Get System Info Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 11:14:34 lounge volumio[760]: info: Discovery: Getting this device information Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::volumioGetState Jun 29 11:14:34 lounge volumio[760]: info: CorePlayQueue::getTrack 0 Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::volumioGetState Jun 29 11:14:34 lounge volumio[760]: info: CorePlayQueue::getTrack 0 Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 29 11:14:34 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 29 11:14:35 lounge sudo[955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 29 11:14:35 lounge sudo[955]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:35 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 29 11:14:35 lounge sudo[955]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:35 lounge volumio[760]: info: Received Get System Info Jun 29 11:14:35 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 11:14:35 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 11:14:35 lounge volumio[760]: info: Discovery: Getting this device information Jun 29 11:14:35 lounge volumio[760]: info: CoreCommandRouter::volumioGetState Jun 29 11:14:35 lounge volumio[760]: info: CorePlayQueue::getTrack 0 Jun 29 11:14:35 lounge volumio[760]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 11:14:35 lounge sudo[957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 29 11:14:35 lounge sudo[957]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:35 lounge sudo[957]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:35 lounge sudo[961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 29 11:14:35 lounge sudo[961]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 11:14:35 lounge systemd[1]: Started UPnP Renderer front-end to MPD. Jun 29 11:14:35 lounge sudo[961]: pam_unix(sudo:session): session closed for user root Jun 29 11:14:35 lounge volumio[760]: info: Upmpdcli Daemon Started Jun 29 11:14:35 lounge volumio[760]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jun 29 11:14:36 lounge volumio[760]: info: Preload queue cleared Jun 29 11:14:36 lounge volumio[760]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 29 11:14:36 lounge volumio[760]: info: CoreStateMachine::ClearQueue Jun 29 11:14:36 lounge volumio[760]: info: CoreStateMachine::stop Jun 29 11:14:36 lounge volumio[760]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 29 11:14:36 lounge volumio[760]: info: CorePlayQueue::clearPlayQueue Jun 29 11:14:36 lounge volumio[760]: info: CorePlayQueue::saveQueue Jun 29 11:14:36 lounge volumio[760]: info: CoreCommandRouter::volumioPushQueue Jun 29 11:14:36 lounge volumio[760]: info: CoreStateMachine::addQueueItems Jun 29 11:14:36 lounge volumio[760]: info: CorePlayQueue::addQueueItems Jun 29 11:14:36 lounge volumio[760]: info: Preload queue cleared Jun 29 11:14:36 lounge volumio[760]: info: Adding Item to queue: artists://Fleetwood%20Mac/English%20Rose Jun 29 11:14:36 lounge volumio[760]: info: Exploding uri artists://Fleetwood%20Mac/English%20Rose in service mpd Jun 29 11:14:36 lounge volumio[760]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 29 11:14:36 lounge volumio[760]: TypeError: Cannot read property 'sendCommand' of undefined Jun 29 11:14:36 lounge volumio[760]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2120:20) Jun 29 11:14:36 lounge volumio[760]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2180:19) Jun 29 11:14:36 lounge volumio[760]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16) Jun 29 11:14:36 lounge volumio[760]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Jun 29 11:14:36 lounge volumio[760]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Jun 29 11:14:36 lounge volumio[760]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Jun 29 11:14:36 lounge volumio[760]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Jun 29 11:14:36 lounge volumio[760]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:507:23) Jun 29 11:14:36 lounge volumio[760]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:477:17) Jun 29 11:14:36 lounge volumio[760]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:118:33) Jun 29 11:14:36 lounge volumio[760]: at Socket.emit (events.js:315:20) Jun 29 11:14:36 lounge volumio[760]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jun 29 11:14:36 lounge volumio[760]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jun 29 11:14:36 lounge volumio[760]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 29 11:14:36 lounge sudo[973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-06-29 11:13 Jun 29 11:14:36 lounge sudo[973]: 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"