-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2024-07-21 16:08:02 CEST. -- Jul 21 16:07:05 volumio-rpi5-allo fake-hwclock[408]: Sun Jul 21 14:07:05 UTC 2024 Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Starting Load/Save Random Seed... Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Starting Create System Users... Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: dynamicswap.service: Succeeded. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Started Restore / save the current clock. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Started Load/Save Random Seed. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Started Create System Users. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Starting Create Static Device Nodes in /dev... Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Started Create Static Device Nodes in /dev. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Starting udev Kernel Device Manager... Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Reached target Local File Systems (Pre). Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Mounting /var/log... Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Mounting /var/spool/cups... Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Mounting /tmp... Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Mounted /var/log. Jul 21 16:07:05 volumio-rpi5-allo systemd-udevd[437]: Network interface NamePolicy= disabled on kernel command line, ignoring. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Starting Flush Journal to Persistent Storage... Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Mounted /tmp. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Started udev Coldplug all Devices. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Mounted /var/spool/cups. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Mounting /var/spool/cups/tmp... Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Starting Helper to synchronize boot up for ifupdown... Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Mounted /var/spool/cups/tmp. Jul 21 16:07:05 volumio-rpi5-allo systemd-journald[405]: Runtime journal (/run/log/journal/dead93d75031bbe9f6f08a39667e9c29) is 7.5M, max 30.0M, 22.5M free. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Started Helper to synchronize boot up for ifupdown. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Started Flush Journal to Persistent Storage. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Started udev Kernel Device Manager. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Starting Show Plymouth Boot Screen... Jul 21 16:07:05 volumio-rpi5-allo systemd-udevd[448]: Using default interface naming scheme 'v240'. Jul 21 16:07:05 volumio-rpi5-allo systemd-udevd[448]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jul 21 16:07:05 volumio-rpi5-allo kernel: rpi-gpiomem 107d508500.gpiomem: window base 0x107d508500 size 0x00000040 Jul 21 16:07:05 volumio-rpi5-allo kernel: rpi-gpiomem 107d508500.gpiomem: initialised 1 regions as /dev/gpiomem1 Jul 21 16:07:05 volumio-rpi5-allo kernel: input: pwr_button as /devices/platform/pwr_button/input/input1 Jul 21 16:07:05 volumio-rpi5-allo kernel: rpi-gpiomem 107d517c00.gpiomem: window base 0x107d517c00 size 0x00000040 Jul 21 16:07:05 volumio-rpi5-allo kernel: rpi-gpiomem 107d517c00.gpiomem: initialised 1 regions as /dev/gpiomem2 Jul 21 16:07:05 volumio-rpi5-allo kernel: rpi-gpiomem 107d504100.gpiomem: window base 0x107d504100 size 0x00000020 Jul 21 16:07:05 volumio-rpi5-allo kernel: rpi-gpiomem 107d504100.gpiomem: initialised 1 regions as /dev/gpiomem3 Jul 21 16:07:05 volumio-rpi5-allo kernel: rpi-gpiomem 107d510700.gpiomem: window base 0x107d510700 size 0x00000020 Jul 21 16:07:05 volumio-rpi5-allo kernel: mc: Linux media interface: v0.10 Jul 21 16:07:05 volumio-rpi5-allo kernel: rpi-gpiomem 107d510700.gpiomem: initialised 1 regions as /dev/gpiomem4 Jul 21 16:07:05 volumio-rpi5-allo kernel: rpi-gpiomem 1f000d0000.gpiomem: window base 0x1f000d0000 size 0x00030000 Jul 21 16:07:05 volumio-rpi5-allo kernel: rpi-gpiomem 1f000d0000.gpiomem: initialised 1 regions as /dev/gpiomem0 Jul 21 16:07:05 volumio-rpi5-allo kernel: videodev: Linux video capture interface: v2.00 Jul 21 16:07:05 volumio-rpi5-allo kernel: brcmstb-i2c 107d508200.i2c: @200000hz registered in interrupt mode Jul 21 16:07:05 volumio-rpi5-allo kernel: brcmstb-i2c 107d508280.i2c: @200000hz registered in interrupt mode Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Found device /dev/ttyAMA10. Jul 21 16:07:05 volumio-rpi5-allo kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Jul 21 16:07:05 volumio-rpi5-allo kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: pispbe_probe: HW version: 0x02252700 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: pispbe_probe: BatchStatus: 0x00000000 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: pispbe_probe: Status: 0x00000000 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: Register nodes for group 0 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: input device node registered as /dev/video20 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: tdn_input device node registered as /dev/video21 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: stitch_input device node registered as /dev/video22 Jul 21 16:07:05 volumio-rpi5-allo kernel: rpivid 1000800000.codec: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: hog_output device node registered as /dev/video23 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: output0 device node registered as /dev/video24 Jul 21 16:07:05 volumio-rpi5-allo kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Jul 21 16:07:05 volumio-rpi5-allo kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Jul 21 16:07:05 volumio-rpi5-allo kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: output1 device node registered as /dev/video25 Jul 21 16:07:05 volumio-rpi5-allo kernel: rpivid 1000800000.codec: Device registered as /dev/video19 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: tdn_output device node registered as /dev/video26 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: stitch_output device node registered as /dev/video27 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: config device node registered as /dev/video28 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: Register nodes for group 1 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: input device node registered as /dev/video29 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: tdn_input device node registered as /dev/video30 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: stitch_input device node registered as /dev/video31 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: hog_output device node registered as /dev/video32 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: output0 device node registered as /dev/video33 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: output1 device node registered as /dev/video34 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: tdn_output device node registered as /dev/video35 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: stitch_output device node registered as /dev/video36 Jul 21 16:07:05 volumio-rpi5-allo kernel: pispbe 1000880000.pisp_be: config device node registered as /dev/video37 Jul 21 16:07:05 volumio-rpi5-allo kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Jul 21 16:07:05 volumio-rpi5-allo kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Jul 21 16:07:05 volumio-rpi5-allo kernel: usbcore: registered new interface driver brcmfmac Jul 21 16:07:05 volumio-rpi5-allo kernel: brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43455-sdio.raspberrypi,5-model-b.bin failed with error -2 Jul 21 16:07:05 volumio-rpi5-allo kernel: Bluetooth: Core ver 2.22 Jul 21 16:07:05 volumio-rpi5-allo kernel: NET: Registered PF_BLUETOOTH protocol family Jul 21 16:07:05 volumio-rpi5-allo kernel: Bluetooth: HCI device and connection manager initialized Jul 21 16:07:05 volumio-rpi5-allo kernel: Bluetooth: HCI socket layer initialized Jul 21 16:07:05 volumio-rpi5-allo kernel: Bluetooth: L2CAP socket layer initialized Jul 21 16:07:05 volumio-rpi5-allo kernel: Bluetooth: SCO socket layer initialized Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Found device /sys/subsystem/net/devices/eth0. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: plymouth-start.service: Succeeded. Jul 21 16:07:05 volumio-rpi5-allo systemd[1]: Started Show Plymouth Boot Screen. Jul 21 16:07:05 volumio-rpi5-allo kernel: Bluetooth: HCI UART driver ver 2.3 Jul 21 16:07:05 volumio-rpi5-allo kernel: Bluetooth: HCI UART protocol H4 registered Jul 21 16:07:05 volumio-rpi5-allo kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Jul 21 16:07:05 volumio-rpi5-allo kernel: Bluetooth: HCI UART protocol Broadcom registered Jul 21 16:07:05 volumio-rpi5-allo kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Jul 21 16:07:05 volumio-rpi5-allo kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Jul 21 16:07:05 volumio-rpi5-allo kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0 Jul 21 16:07:05 volumio-rpi5-allo kernel: scsi 0:0:0:0: Attached scsi generic sg1 type 5 Jul 21 16:07:05 volumio-rpi5-allo systemd-udevd[446]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jul 21 16:07:05 volumio-rpi5-allo kernel: vc4-drm axi:gpu: bcm2712_iommu_of_xlate: MMU 1000005200.iommu Jul 21 16:07:05 volumio-rpi5-allo kernel: Console: switching to colour dummy device 80x25 Jul 21 16:07:05 volumio-rpi5-allo kernel: vc4-drm axi:gpu: bound 107c580000.hvs (ops vc4_hvs_ops [vc4]) Jul 21 16:07:05 volumio-rpi5-allo kernel: input: WaveShare WaveShare as /devices/platform/axi/1000120000.pcie/1f00300000.usb/xhci-hcd.1/usb3/3-2/3-2:1.0/0003:0712:0009.0001/input/input2 Jul 21 16:07:05 volumio-rpi5-allo kernel: hid-multitouch 0003:0712:0009.0001: input,hidraw0: USB HID v1.11 Device [WaveShare WaveShare] on usb-xhci-hcd.1-2/input0 Jul 21 16:07:05 volumio-rpi5-allo 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 Jul 21 16:07:05 volumio-rpi5-allo kernel: Registered IR keymap rc-cec Jul 21 16:07:05 volumio-rpi5-allo kernel: rc rc0: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0 Jul 21 16:07:05 volumio-rpi5-allo kernel: input: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0/input3 Jul 21 16:07:05 volumio-rpi5-allo kernel: vc4-drm axi:gpu: bound 107c701400.hdmi (ops vc4_hdmi_ops [vc4]) Jul 21 16:07:05 volumio-rpi5-allo kernel: Registered IR keymap rc-cec Jul 21 16:07:05 volumio-rpi5-allo kernel: rc rc1: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1 Jul 21 16:07:05 volumio-rpi5-allo kernel: input: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1/input4 Jul 21 16:07:05 volumio-rpi5-allo kernel: vc4-drm axi:gpu: bound 107c706400.hdmi (ops vc4_hdmi_ops [vc4]) Jul 21 16:07:05 volumio-rpi5-allo kernel: vc4-drm axi:gpu: bound 107c500000.mop (ops vc4_txp_ops [vc4]) Jul 21 16:07:05 volumio-rpi5-allo kernel: vc4-drm axi:gpu: bound 107c501000.moplet (ops vc4_txp_ops [vc4]) Jul 21 16:07:05 volumio-rpi5-allo kernel: vc4-drm axi:gpu: bound 107c410000.pixelvalve (ops vc4_crtc_ops [vc4]) Jul 21 16:07:05 volumio-rpi5-allo kernel: vc4-drm axi:gpu: bound 107c411000.pixelvalve (ops vc4_crtc_ops [vc4]) Jul 21 16:07:05 volumio-rpi5-allo systemd-udevd[462]: Using default interface naming scheme 'v240'. Jul 21 16:07:05 volumio-rpi5-allo systemd-udevd[462]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jul 21 16:07:06 volumio-rpi5-allo kernel: sr 0:0:0:0: [sr0] scsi3-mmc drive: 10x/24x writer dvd-ram cd/rw xa/form2 cdda tray Jul 21 16:07:06 volumio-rpi5-allo kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jul 21 16:07:06 volumio-rpi5-allo kernel: [drm] Initialized vc4 0.0.0 20140616 for axi:gpu on minor 1 Jul 21 16:07:06 volumio-rpi5-allo kernel: Console: switching to colour frame buffer device 50x80 Jul 21 16:07:06 volumio-rpi5-allo kernel: vc4-drm axi:gpu: [drm] fb0: vc4drmfb frame buffer device Jul 21 16:07:06 volumio-rpi5-allo kernel: wm8804 1-003b: revision E Jul 21 16:07:06 volumio-rpi5-allo kernel: Bluetooth: hci0: BCM: chip id 107 Jul 21 16:07:06 volumio-rpi5-allo kernel: Bluetooth: hci0: BCM: features 0x2f Jul 21 16:07:06 volumio-rpi5-allo kernel: Bluetooth: hci0: BCM4345C0 Jul 21 16:07:06 volumio-rpi5-allo kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Jul 21 16:07:06 volumio-rpi5-allo kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Jul 21 16:07:06 volumio-rpi5-allo systemd-udevd[474]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 21 16:07:06 volumio-rpi5-allo kernel: sr 0:0:0:0: Attached scsi CD-ROM sr0 Jul 21 16:07:06 volumio-rpi5-allo systemd-udevd[455]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 21 16:07:06 volumio-rpi5-allo systemd-udevd[469]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 0' failed with exit code 99. Jul 21 16:07:06 volumio-rpi5-allo systemd-udevd[476]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 21 16:07:06 volumio-rpi5-allo systemd-udevd[463]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Found device SanDisk_3.2Gen1 boot. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Created slice system-bthelper.slice. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Starting Show Plymouth Boot Screen... Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Starting File System Check on /dev/disk/by-uuid/CB9F-1CDF... Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Condition check resulted in Huge Pages File System being skipped. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: plymouth-start.service: Succeeded. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Started Show Plymouth Boot Screen. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Started File System Check Daemon to report status. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Reached target Local Encrypted Volumes. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Reached target Paths. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Starting Load/Save RF Kill Switch Status... Jul 21 16:07:06 volumio-rpi5-allo systemd-udevd[450]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Started Load/Save RF Kill Switch Status. Jul 21 16:07:06 volumio-rpi5-allo systemd-fsck[751]: fsck.fat 4.1 (2017-01-24) Jul 21 16:07:06 volumio-rpi5-allo systemd-fsck[751]: 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Jul 21 16:07:06 volumio-rpi5-allo systemd-fsck[751]: Automatically removing dirty bit. Jul 21 16:07:06 volumio-rpi5-allo systemd-fsck[751]: Performing changes. Jul 21 16:07:06 volumio-rpi5-allo systemd-fsck[751]: /dev/sda1: 368 files, 134160/184582 clusters Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Started File System Check on /dev/disk/by-uuid/CB9F-1CDF. Jul 21 16:07:06 volumio-rpi5-allo systemd[1]: Mounting /boot... Jul 21 16:07:06 volumio-rpi5-allo kernel: Bluetooth: hci0: BCM: features 0x2f Jul 21 16:07:06 volumio-rpi5-allo kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Jul 21 16:07:06 volumio-rpi5-allo kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Jul 21 16:07:06 volumio-rpi5-allo kernel: Bluetooth: hci0: BCM: Using default device address (43:45:c0:00:1f:ac) Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Mounted /boot. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target Local File Systems. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Preprocess NFS configuration... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Raise network interfaces... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Create Volatile Files and Directories... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started ifup for eth0. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started ifup for wlan0. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: nfs-config.service: Succeeded. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Preprocess NFS configuration. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target NFS client services. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Received SIGRTMIN+20 from PID 287 (plymouthd). Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: plymouth-read-write.service: Succeeded. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Create Volatile Files and Directories. Jul 21 16:07:07 volumio-rpi5-allo kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting RPC bind portmap service... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jul 21 16:07:07 volumio-rpi5-allo kernel: 8021q: 802.1Q VLAN Support v1.8 Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Update UTMP about System Boot/Shutdown. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target System Initialization. Jul 21 16:07:07 volumio-rpi5-allo sh[786]: wlan0=wlan0 Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: apt-daily.timer: Not using persistent file timestamp Mon 2024-07-22 16:27:35 CEST as it is in the future. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Daily apt download activities. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Mon 2024-07-22 16:27:35 CEST as it is in the future. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Daily apt upgrade and clean activities. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Listening on triggerhappy.socket. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Listening on D-Bus System Message Bus Socket. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target Sockets. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Daily Cleanup of Temporary Directories. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: man-db.timer: Not using persistent file timestamp Mon 2024-07-22 16:27:35 CEST as it is in the future. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Daily man-db regeneration. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target Timers. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target Basic System. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting triggerhappy global hotkey daemon... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Login Service... Jul 21 16:07:07 volumio-rpi5-allo thd[898]: Unable to parse trigger line: Jul 21 16:07:07 volumio-rpi5-allo thd[898]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Jul 21 16:07:07 volumio-rpi5-allo thd[898]: Unable to parse trigger line: Jul 21 16:07:07 volumio-rpi5-allo thd[898]: Found socket passed from systemd Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started D-Bus System Message Bus. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started volumio-remote-updater.service. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Volumio Log Rotation Service. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting WPA supplicant... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Raspberry Pi bluetooth helper... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting dhcpcd on all interfaces... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Volumio Iptables Module. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started UPnP Renderer front-end to MPD. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Wireless Services... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Manage Sound Card State (restore and store). Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Save/Restore Sound Card State... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started RPC bind portmap service. Jul 21 16:07:07 volumio-rpi5-allo alsactl[922]: alsactl 1.1.8 daemon started Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: haveged.service: Main process exited, code=killed, status=11/SEGV Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: haveged.service: Failed with result 'signal'. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target Remote File Systems (Pre). Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target Remote File Systems. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target RPC Port Mapper. Jul 21 16:07:07 volumio-rpi5-allo dhcpcd[917]: Not running dhcpcd because /etc/network/interfaces Jul 21 16:07:07 volumio-rpi5-allo dhcpcd[917]: defines some interfaces that will use a Jul 21 16:07:07 volumio-rpi5-allo dhcpcd[917]: DHCP client or static address Jul 21 16:07:07 volumio-rpi5-allo bthelper[916]: Raspberry Pi BDADDR already set Jul 21 16:07:07 volumio-rpi5-allo systemd-logind[907]: New seat seat0. Jul 21 16:07:07 volumio-rpi5-allo sh[783]: eth0: waiting for carrier Jul 21 16:07:07 volumio-rpi5-allo kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:01] driver [Broadcom BCM54213PE] (irq=POLL) Jul 21 16:07:07 volumio-rpi5-allo kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode Jul 21 16:07:07 volumio-rpi5-allo kernel: pps pps0: new PPS source ptp0 Jul 21 16:07:07 volumio-rpi5-allo kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. Jul 21 16:07:07 volumio-rpi5-allo dhcpcd[830]: eth0: waiting for carrier Jul 21 16:07:07 volumio-rpi5-allo systemd-logind[907]: Watching system buttons on /dev/input/event1 (pwr_button) Jul 21 16:07:07 volumio-rpi5-allo systemd-logind[907]: Watching system buttons on /dev/input/event2 (vc4-hdmi-0) Jul 21 16:07:07 volumio-rpi5-allo systemd-logind[907]: Watching system buttons on /dev/input/event3 (vc4-hdmi-1) Jul 21 16:07:07 volumio-rpi5-allo avahi-daemon[919]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Jul 21 16:07:07 volumio-rpi5-allo avahi-daemon[919]: Successfully dropped root privileges. Jul 21 16:07:07 volumio-rpi5-allo avahi-daemon[919]: avahi-daemon 0.7 starting up. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Login Service. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started triggerhappy global hotkey daemon. Jul 21 16:07:07 volumio-rpi5-allo wpa_supplicant[915]: Successfully initialized wpa_supplicant Jul 21 16:07:07 volumio-rpi5-allo avahi-daemon[919]: Successfully called chroot(). Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Raise network interfaces. Jul 21 16:07:07 volumio-rpi5-allo avahi-daemon[919]: Successfully dropped remaining capabilities. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Raspberry Pi bluetooth helper. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Failed to start dhcpcd on all interfaces. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Save/Restore Sound Card State. Jul 21 16:07:07 volumio-rpi5-allo avahi-daemon[919]: Loading service file /services/volumio.service. Jul 21 16:07:07 volumio-rpi5-allo avahi-daemon[919]: Network interface enumeration completed. Jul 21 16:07:07 volumio-rpi5-allo avahi-daemon[919]: Server startup complete. Host name is volumio-rpi5-allo.local. Local service cookie is 1452643519. Jul 21 16:07:07 volumio-rpi5-allo avahi-daemon[919]: Service "Volumio-rPi5-Allo" (/services/volumio.service) successfully established. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started WPA supplicant. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target Sound Card. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Bluetooth service... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target Network. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Permit User Sessions... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Network Time Service... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting OpenBSD Secure Shell server... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target Network is Online. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Samba NMB Daemon... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting LSB: Brings up/down network automatically... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting /etc/rc.local Compatibility... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Permit User Sessions. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started /etc/rc.local Compatibility. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Hold until boot process finishes up... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting Terminate Plymouth Boot Screen... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Received SIGRTMIN+21 from PID 287 (plymouthd). Jul 21 16:07:07 volumio-rpi5-allo bluetoothd[960]: Bluetooth daemon 5.50 Jul 21 16:07:07 volumio-rpi5-allo loadcpufreq[928]: Loading cpufreq kernel modules...done (none). Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: plymouth-quit-wait.service: Succeeded. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Hold until boot process finishes up. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: plymouth-quit.service: Succeeded. Jul 21 16:07:07 volumio-rpi5-allo volumio-remote-updater[913]: Error: No active session Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Terminate Plymouth Boot Screen. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Received SIGRTMIN+21 from PID 287 (n/a). Jul 21 16:07:07 volumio-rpi5-allo volumio-remote-updater[913]: [2024-07-21 16:07:07] [info] asio async_connect error: system:111 (Connection refused) Jul 21 16:07:07 volumio-rpi5-allo volumio-remote-updater[913]: [2024-07-21 16:07:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jul 21 16:07:07 volumio-rpi5-allo volumio-remote-updater[913]: [2024-07-21 16:07:07] [error] handle_connect error: Underlying Transport Error Jul 21 16:07:07 volumio-rpi5-allo bluetoothd[960]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Jul 21 16:07:07 volumio-rpi5-allo bluetoothd[960]: Starting SDP server Jul 21 16:07:07 volumio-rpi5-allo bluetoothd[960]: Excluding (cli) sap Jul 21 16:07:07 volumio-rpi5-allo ifplugd(eth0)[1018]: ifplugd 0.28 initializing. Jul 21 16:07:07 volumio-rpi5-allo ifplugd(eth0)[1018]: Using interface eth0/D8:3A:DD:BD:67:B4 with driver (version: 6.1.69-v8+) Jul 21 16:07:07 volumio-rpi5-allo ifplugd(eth0)[1018]: Using detection mode: SIOCETHTOOL Jul 21 16:07:07 volumio-rpi5-allo ifplugd(eth0)[1018]: Initialization complete, link beat not detected. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Serial Getty on ttyAMA10. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target Login Prompts. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Starting LSB: set CPUFreq kernel parameters... Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Bluetooth service. Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Reached target Bluetooth. Jul 21 16:07:07 volumio-rpi5-allo ntpd[967]: ntpd 4.2.8p12@1.3728-o (1): Starting Jul 21 16:07:07 volumio-rpi5-allo ntpd[967]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: Started Network Time Service. Jul 21 16:07:07 volumio-rpi5-allo volumio[920]: Could not open config: /tmp/upmpdcli.conf Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jul 21 16:07:07 volumio-rpi5-allo ntpd[1029]: proto: precision = 1.277 usec (-19) Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jul 21 16:07:07 volumio-rpi5-allo ntpd[1029]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jul 21 16:07:07 volumio-rpi5-allo ntpd[1029]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jul 21 16:07:07 volumio-rpi5-allo ntpd[1029]: Listen and drop on 0 v6wildcard [::]:123 Jul 21 16:07:07 volumio-rpi5-allo ntpd[1029]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jul 21 16:07:07 volumio-rpi5-allo ntpd[1029]: Listen normally on 2 lo 127.0.0.1:123 Jul 21 16:07:07 volumio-rpi5-allo ntpd[1029]: Listening on routing socket on fd #19 for interface updates Jul 21 16:07:07 volumio-rpi5-allo ntpd[1029]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 21 16:07:07 volumio-rpi5-allo ntpd[1029]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 21 16:07:07 volumio-rpi5-allo systemd[1]: iptables.service: Succeeded. Jul 21 16:07:07 volumio-rpi5-allo kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Jul 21 16:07:07 volumio-rpi5-allo kernel: Bluetooth: BNEP filters: protocol multicast Jul 21 16:07:07 volumio-rpi5-allo kernel: Bluetooth: BNEP socket layer initialized Jul 21 16:07:07 volumio-rpi5-allo bluetoothd[960]: Bluetooth management interface 1.22 initialized Jul 21 16:07:07 volumio-rpi5-allo dbus-daemon[908]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=960 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Jul 21 16:07:07 volumio-rpi5-allo kernel: Bluetooth: MGMT ver 1.22 Jul 21 16:07:07 volumio-rpi5-allo ifplugd[979]: Network Interface Plugging Daemon...start eth0...done. Jul 21 16:07:08 volumio-rpi5-allo cpufrequtils[1026]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Jul 21 16:07:08 volumio-rpi5-allo systemd[1]: Started LSB: Brings up/down network automatically. Jul 21 16:07:08 volumio-rpi5-allo systemd[1]: Started LSB: set CPUFreq kernel parameters. Jul 21 16:07:08 volumio-rpi5-allo systemd[1]: Starting Hostname Service... Jul 21 16:07:08 volumio-rpi5-allo sshd[1050]: Server listening on 0.0.0.0 port 22. Jul 21 16:07:08 volumio-rpi5-allo sshd[1050]: Server listening on :: port 22. Jul 21 16:07:08 volumio-rpi5-allo systemd[1]: Started OpenBSD Secure Shell server. Jul 21 16:07:08 volumio-rpi5-allo bluetoothd[960]: Failed to set privacy: Rejected (0x0b) Jul 21 16:07:08 volumio-rpi5-allo dbus-daemon[908]: [system] Successfully activated service 'org.freedesktop.hostname1' Jul 21 16:07:08 volumio-rpi5-allo systemd[1]: Started Hostname Service. Jul 21 16:07:08 volumio-rpi5-allo nmbd[987]: [2024/07/21 16:07:08.237958, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jul 21 16:07:08 volumio-rpi5-allo nmbd[987]: started asyncdns process 1053 Jul 21 16:07:08 volumio-rpi5-allo nmbd[987]: [2024/07/21 16:07:08.238968, 0] ../lib/util/become_daemon.c:149(daemon_status) Jul 21 16:07:08 volumio-rpi5-allo nmbd[987]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jul 21 16:07:08 volumio-rpi5-allo nmbd[987]: [2024/07/21 16:07:08.239023, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jul 21 16:07:08 volumio-rpi5-allo nmbd[987]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jul 21 16:07:08 volumio-rpi5-allo wireless.js[921]: Cleaning previous... Jul 21 16:07:08 volumio-rpi5-allo sudo[1061]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jul 21 16:07:08 volumio-rpi5-allo sudo[1061]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:08 volumio-rpi5-allo sudo[1061]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:08 volumio-rpi5-allo sudo[1063]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jul 21 16:07:08 volumio-rpi5-allo sudo[1063]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:08 volumio-rpi5-allo ntpd[1029]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jul 21 16:07:08 volumio-rpi5-allo sudo[1063]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:08 volumio-rpi5-allo wireless.js[921]: Stopped aP Jul 21 16:07:08 volumio-rpi5-allo sudo[1070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jul 21 16:07:08 volumio-rpi5-allo sudo[1070]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:08 volumio-rpi5-allo sudo[1070]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:08 volumio-rpi5-allo kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jul 21 16:07:08 volumio-rpi5-allo sudo[1072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jul 21 16:07:08 volumio-rpi5-allo sudo[1072]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:08 volumio-rpi5-allo sudo[1072]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:08 volumio-rpi5-allo sudo[1079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jul 21 16:07:08 volumio-rpi5-allo sudo[1079]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:08 volumio-rpi5-allo sudo[1079]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:09 volumio-rpi5-allo sudo[1081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jul 21 16:07:09 volumio-rpi5-allo sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:09 volumio-rpi5-allo ntpd[1029]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jul 21 16:07:10 volumio-rpi5-allo ntpd[1029]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jul 21 16:07:11 volumio-rpi5-allo systemd[1]: systemd-rfkill.service: Succeeded. Jul 21 16:07:11 volumio-rpi5-allo sudo[1081]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:11 volumio-rpi5-allo wireless.js[921]: SETTING APPROPRIATE REG DOMAIN: GB Jul 21 16:07:11 volumio-rpi5-allo sudo[1086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jul 21 16:07:11 volumio-rpi5-allo sudo[1086]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:11 volumio-rpi5-allo sudo[1086]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:11 volumio-rpi5-allo sudo[1088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set GB Jul 21 16:07:11 volumio-rpi5-allo sudo[1088]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:11 volumio-rpi5-allo sudo[1088]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:11 volumio-rpi5-allo wireless.js[921]: SUCCESSFULLY SET NEW REGDOMAIN: GB Jul 21 16:07:11 volumio-rpi5-allo wireless.js[921]: Start wireless flow Jul 21 16:07:11 volumio-rpi5-allo wireless.js[921]: Stopped hotspot (if there).. Jul 21 16:07:11 volumio-rpi5-allo sudo[1093]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jul 21 16:07:11 volumio-rpi5-allo sudo[1093]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:11 volumio-rpi5-allo sudo[1093]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:11 volumio-rpi5-allo sudo[1095]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jul 21 16:07:11 volumio-rpi5-allo sudo[1095]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:11 volumio-rpi5-allo ntpd[1029]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jul 21 16:07:12 volumio-rpi5-allo sudo[1095]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:12 volumio-rpi5-allo wireless.js[921]: DHCP IP Jul 21 16:07:12 volumio-rpi5-allo wireless.js[921]: Start ap Jul 21 16:07:12 volumio-rpi5-allo wpa_supplicant[1097]: Successfully initialized wpa_supplicant Jul 21 16:07:12 volumio-rpi5-allo sudo[1098]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jul 21 16:07:12 volumio-rpi5-allo sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:12 volumio-rpi5-allo kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jul 21 16:07:12 volumio-rpi5-allo dhcpcd[1099]: dev: loaded udev Jul 21 16:07:12 volumio-rpi5-allo dhcpcd-run-hooks[1117]: wlan0: starting wpa_supplicant Jul 21 16:07:12 volumio-rpi5-allo dhcpcd-run-hooks[1122]: wlan0: failed to start wpa_supplicant Jul 21 16:07:12 volumio-rpi5-allo dhcpcd-run-hooks[1123]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Jul 21 16:07:12 volumio-rpi5-allo dhcpcd[1099]: wlan0: connected to Access Point `' Jul 21 16:07:12 volumio-rpi5-allo dhcpcd[1099]: no interfaces have a carrier Jul 21 16:07:12 volumio-rpi5-allo dhcpcd[1099]: forked to background, child pid 1133 Jul 21 16:07:12 volumio-rpi5-allo dhcpcd[1133]: eth0: waiting for carrier Jul 21 16:07:12 volumio-rpi5-allo dhcpcd[1133]: wlan0: waiting for carrier Jul 21 16:07:12 volumio-rpi5-allo sudo[1098]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:12 volumio-rpi5-allo bthelper[916]: Changing power off succeeded Jul 21 16:07:12 volumio-rpi5-allo bthelper[916]: [CHG] Controller D8:3A:DD:BD:67:B6 Class: 0x0000041c Jul 21 16:07:12 volumio-rpi5-allo bthelper[916]: Changing power on succeeded Jul 21 16:07:12 volumio-rpi5-allo volumio-remote-updater[913]: [2024-07-21 16:07:12] [info] asio async_connect error: system:111 (Connection refused) Jul 21 16:07:12 volumio-rpi5-allo volumio-remote-updater[913]: [2024-07-21 16:07:12] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jul 21 16:07:12 volumio-rpi5-allo volumio-remote-updater[913]: [2024-07-21 16:07:12] [error] handle_connect error: Underlying Transport Error Jul 21 16:07:13 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:13 volumio-rpi5-allo sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:13 volumio-rpi5-allo sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:13 volumio-rpi5-allo sudo[1136]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:14 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:14 volumio-rpi5-allo sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:14 volumio-rpi5-allo sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:14 volumio-rpi5-allo sudo[1139]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:14 volumio-rpi5-allo wpa_supplicant[1121]: wlan0: Trying to associate with SSID 'WieFie_5GHz' Jul 21 16:07:15 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:15 volumio-rpi5-allo sudo[1142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:15 volumio-rpi5-allo sudo[1142]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:15 volumio-rpi5-allo sudo[1142]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:16 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:16 volumio-rpi5-allo sudo[1145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:16 volumio-rpi5-allo sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:16 volumio-rpi5-allo sudo[1145]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:17 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:17 volumio-rpi5-allo sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:17 volumio-rpi5-allo sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:17 volumio-rpi5-allo sudo[1148]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:17 volumio-rpi5-allo dhcpcd[1133]: wlan0: carrier acquired Jul 21 16:07:17 volumio-rpi5-allo dhcpcd[1133]: wlan0: connected to Access Point `WieFie_5GHz' Jul 21 16:07:17 volumio-rpi5-allo wpa_supplicant[1121]: wlan0: Associated with 30:23:03:43:74:c0 Jul 21 16:07:17 volumio-rpi5-allo wpa_supplicant[1121]: wlan0: CTRL-EVENT-CONNECTED - Connection to 30:23:03:43:74:c0 completed [id=0 id_str=] Jul 21 16:07:17 volumio-rpi5-allo wpa_supplicant[1121]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jul 21 16:07:17 volumio-rpi5-allo wpa_supplicant[1121]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=GB Jul 21 16:07:17 volumio-rpi5-allo dhcpcd[1133]: DUID 00:01:00:01:2e:11:5a:7a:d8:3a:dd:bd:67:b4 Jul 21 16:07:17 volumio-rpi5-allo dhcpcd[1133]: wlan0: IAID dd:bd:67:b5 Jul 21 16:07:17 volumio-rpi5-allo dhcpcd[1133]: wlan0: adding address fe80::16f3:cc91:731b:c827 Jul 21 16:07:17 volumio-rpi5-allo dhcpcd[1133]: ipv6_addaddr1: Permission denied Jul 21 16:07:17 volumio-rpi5-allo dhcpcd[1133]: wlan0: carrier lost Jul 21 16:07:17 volumio-rpi5-allo dhcpcd[1133]: wlan0: carrier acquired Jul 21 16:07:17 volumio-rpi5-allo dhcpcd[1133]: wlan0: IAID dd:bd:67:b5 Jul 21 16:07:18 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:18 volumio-rpi5-allo sudo[1163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:18 volumio-rpi5-allo sudo[1163]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:18 volumio-rpi5-allo sudo[1163]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:18 volumio-rpi5-allo dhcpcd[1133]: wlan0: rebinding lease of 192.168.1.98 Jul 21 16:07:18 volumio-rpi5-allo dhcpcd[1133]: wlan0: probing address 192.168.1.98/24 Jul 21 16:07:18 volumio-rpi5-allo dhcpcd[1133]: wlan0: soliciting an IPv6 router Jul 21 16:07:19 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:19 volumio-rpi5-allo sudo[1166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:19 volumio-rpi5-allo sudo[1166]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:19 volumio-rpi5-allo sudo[1166]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:20 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:20 volumio-rpi5-allo sudo[1169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:20 volumio-rpi5-allo sudo[1169]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:20 volumio-rpi5-allo sudo[1169]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:20 volumio-rpi5-allo volumio-remote-updater[913]: [2024-07-21 16:07:20] [info] asio async_connect error: system:111 (Connection refused) Jul 21 16:07:20 volumio-rpi5-allo volumio-remote-updater[913]: [2024-07-21 16:07:20] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jul 21 16:07:20 volumio-rpi5-allo volumio-remote-updater[913]: [2024-07-21 16:07:20] [error] handle_connect error: Underlying Transport Error Jul 21 16:07:21 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:21 volumio-rpi5-allo sudo[1172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:21 volumio-rpi5-allo sudo[1172]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:21 volumio-rpi5-allo sudo[1172]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:22 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:22 volumio-rpi5-allo sudo[1175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:22 volumio-rpi5-allo sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:22 volumio-rpi5-allo sudo[1175]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:23 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:23 volumio-rpi5-allo sudo[1178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:23 volumio-rpi5-allo sudo[1178]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:23 volumio-rpi5-allo sudo[1178]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:23 volumio-rpi5-allo dhcpcd[1133]: wlan0: leased 192.168.1.98 for 604800 seconds Jul 21 16:07:23 volumio-rpi5-allo avahi-daemon[919]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.98. Jul 21 16:07:23 volumio-rpi5-allo avahi-daemon[919]: New relevant interface wlan0.IPv4 for mDNS. Jul 21 16:07:23 volumio-rpi5-allo dhcpcd[1133]: wlan0: adding route to 192.168.1.0/24 Jul 21 16:07:23 volumio-rpi5-allo avahi-daemon[919]: Registering new address record for 192.168.1.98 on wlan0.IPv4. Jul 21 16:07:23 volumio-rpi5-allo dhcpcd[1133]: wlan0: adding default route via 192.168.1.1 Jul 21 16:07:24 volumio-rpi5-allo wireless.js[921]: trying... Jul 21 16:07:24 volumio-rpi5-allo sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 21 16:07:24 volumio-rpi5-allo sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:24 volumio-rpi5-allo sudo[1202]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:24 volumio-rpi5-allo wireless.js[921]: Connected to: ----WieFie_5GHz Jul 21 16:07:24 volumio-rpi5-allo wireless.js[921]: ---- Jul 21 16:07:24 volumio-rpi5-allo sudo[1205]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 16:07:24 volumio-rpi5-allo sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:24 volumio-rpi5-allo sudo[1205]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:24 volumio-rpi5-allo wireless.js[921]: ... joined AP, wlan0 IPv4 is 192.168.1.98, ipV6 is undefined Jul 21 16:07:24 volumio-rpi5-allo wireless.js[921]: It's done! AP Jul 21 16:07:24 volumio-rpi5-allo systemd[1]: Started Wireless Services. Jul 21 16:07:24 volumio-rpi5-allo kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jul 21 16:07:24 volumio-rpi5-allo systemd[1]: Started Volumio Backend Module. Jul 21 16:07:24 volumio-rpi5-allo systemd[1]: Started Volumio Cpu Tweaker. Jul 21 16:07:24 volumio-rpi5-allo volumio-cpu-tweak[1211]: Setting RT Priority for mpd Jul 21 16:07:24 volumio-rpi5-allo volumio-cpu-tweak[1211]: pid 35's current scheduling policy: SCHED_OTHER Jul 21 16:07:24 volumio-rpi5-allo volumio-cpu-tweak[1211]: pid 35's current scheduling priority: 0 Jul 21 16:07:24 volumio-rpi5-allo volumio-cpu-tweak[1211]: Setting MPD Affinity Jul 21 16:07:24 volumio-rpi5-allo volumio-cpu-tweak[1211]: pid 3's current affinity mask: f Jul 21 16:07:24 volumio-rpi5-allo volumio-cpu-tweak[1211]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jul 21 16:07:24 volumio-rpi5-allo volumio-cpu-tweak[1211]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Jul 21 16:07:24 volumio-rpi5-allo systemd[1]: volumio_cpu_tweak.service: Succeeded. Jul 21 16:07:24 volumio-rpi5-allo volumio[1210]: info: ------------------------------------------- Jul 21 16:07:24 volumio-rpi5-allo volumio[1210]: info: ----- Volumio3 ---- Jul 21 16:07:24 volumio-rpi5-allo volumio[1210]: info: ------------------------------------------- Jul 21 16:07:24 volumio-rpi5-allo volumio[1210]: info: ----- System startup ---- Jul 21 16:07:24 volumio-rpi5-allo volumio[1210]: info: ------------------------------------------- Jul 21 16:07:24 volumio-rpi5-allo ntpd[1029]: Listen normally on 3 wlan0 192.168.1.98:123 Jul 21 16:07:24 volumio-rpi5-allo ntpd[1029]: new interface(s) found: waking up resolver Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: MYVOLUMIO Environment detected Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Plugin folders cleanup Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Scanning into folder /volumio/app/plugins/ Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Scanning category audio_interface Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Scanning category miscellanea Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Scanning category music_service Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Scanning category plugins.json Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Scanning category system_controller Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Scanning category user_interface Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Scanning into folder /data/plugins/ Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Scanning category music_service Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Scanning category user_interface Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Plugin folders cleanup completed Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: ------------------------------------------- Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: ----- Core plugins startup ---- Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: ------------------------------------------- Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugins from folder /volumio/app/plugins/ Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Adding plugin upnp to MyMusic Plugins Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugins from folder /data/plugins/ Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "system"... Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "appearance"... Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "network"... Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Refreshing Cached IP Addresses Jul 21 16:07:25 volumio-rpi5-allo sudo[1241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 21 16:07:25 volumio-rpi5-allo sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:25 volumio-rpi5-allo sudo[1241]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "services"... Jul 21 16:07:25 volumio-rpi5-allo sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 16:07:25 volumio-rpi5-allo sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:25 volumio-rpi5-allo sudo[1243]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "alsa_controller"... Jul 21 16:07:25 volumio-rpi5-allo sudo[1246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 21 16:07:25 volumio-rpi5-allo sudo[1246]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "wizard"... Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "networkfs"... Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Starting Udev Watcher for removable devices Jul 21 16:07:25 volumio-rpi5-allo sudo[1252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.11:/Music_LL /mnt/NAS/QNAP Jul 21 16:07:25 volumio-rpi5-allo sudo[1252]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Ignoring mount for partition: boot Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Ignoring mount for partition: volumio Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Ignoring mount for partition: volumio_data Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "volumio_command_line_client"... Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "upnp"... Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: [1721570845713] Starting Upmpd Daemon Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "my_music"... Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "mpd"... Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "upnp_browser"... Jul 21 16:07:25 volumio-rpi5-allo sudo[1252]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:25 volumio-rpi5-allo volumio[1210]: info: Loading plugin "alarm-clock"... Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: info: Loading plugin "airplay_emulation"... Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: info: Starting Shairport Sync Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: info: Loading plugin "last_100"... Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: info: Loading plugin "webradio"... Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: info: Loading plugin "i2s_dacs"... Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: info: Loading plugin "volumiodiscovery"... Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 21 16:07:26 volumio-rpi5-allo node[1210]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 16:07:26 volumio-rpi5-allo node[1210]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: *** WARNING *** For more information see Jul 21 16:07:26 volumio-rpi5-allo node[1210]: *** WARNING *** For more information see Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 21 16:07:26 volumio-rpi5-allo node[1210]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 16:07:26 volumio-rpi5-allo node[1210]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: *** WARNING *** For more information see Jul 21 16:07:26 volumio-rpi5-allo node[1210]: *** WARNING *** For more information see Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: info: Discovery: Started advertising with name: Volumio-rPi5-Allo Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: info: Loading plugin "spop"... Jul 21 16:07:26 volumio-rpi5-allo volumio[1210]: info: Loading plugin "now_playing"... Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Loading plugin "peppy_screensaver"... Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Applying required configuration parameters for plugin peppy_screensaver Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Loading plugin "outputs"... Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Loading plugin "albumart"... Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Plugin example_plugin is not enabled Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Loading plugin "inputs"... Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Loading plugin "updater_comm"... Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Plugin mpdemulation is not enabled Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Loading plugin "rest_api"... Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Loading plugin "websocket"... Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Starting Socket.io Server version 2.3.0 Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Loading plugin "80s80s"... Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: Forking 3 albumart workers Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Applying required configuration parameters for plugin 80s80s Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: [1721570847721] [80s80s] API delay: 30 Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Loading plugin "radio_paradise"... Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: Starting albumart workers Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: Starting albumart workers Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: Starting albumart workers Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Applying required configuration parameters for plugin radio_paradise Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: [1721570847890] [RadioParadise] API delay: 5 Jul 21 16:07:27 volumio-rpi5-allo volumio[1210]: info: Loading plugin "Systeminfo"... Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Loading plugin "randomizer"... Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Applying required configuration parameters for plugin randomizer Jul 21 16:07:28 volumio-rpi5-allo nmbd[987]: [2024/07/21 16:07:28.241837, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Started Samba NMB Daemon. Jul 21 16:07:28 volumio-rpi5-allo nmbd[987]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Loading plugin "touch_display"... Jul 21 16:07:28 volumio-rpi5-allo nmbd[987]: [2024/07/21 16:07:28.250337, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 21 16:07:28 volumio-rpi5-allo nmbd[987]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.98 for name WORKGROUP<1d>. Jul 21 16:07:28 volumio-rpi5-allo nmbd[987]: This response was from IP 192.168.1.200, reporting an IP address of 192.168.1.200. Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Starting Samba Winbind Daemon... Jul 21 16:07:28 volumio-rpi5-allo winbindd[1315]: [2024/07/21 16:07:28.342208, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jul 21 16:07:28 volumio-rpi5-allo winbindd[1315]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Started Samba Winbind Daemon. Jul 21 16:07:28 volumio-rpi5-allo winbindd[1315]: [2024/07/21 16:07:28.354327, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 21 16:07:28 volumio-rpi5-allo winbindd[1315]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Starting Samba SMB Daemon... Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Applying required configuration parameters for plugin touch_display Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Loading i18n strings for locale en Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: Updating browse sources language Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 16:07:28 volumio-rpi5-allo winbindd[1315]: [2024/07/21 16:07:28.502621, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Jul 21 16:07:28 volumio-rpi5-allo winbindd[1315]: res_names->count = 3, expected 4 Jul 21 16:07:28 volumio-rpi5-allo smbd[1320]: [2024/07/21 16:07:28.511859, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 21 16:07:28 volumio-rpi5-allo smbd[1320]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Started Samba SMB Daemon. Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Reached target Multi-User System. Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Reached target Graphical Interface. Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::initPlayerControls Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Starting Update UTMP about System Runlevel Changes... Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: Express server listening on port 3000 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: [Metrics] WebUI: 3s 887.87ms Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreStateMachine::resetVolumioState Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreStateMachine::getcurrentVolume Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioRetrievevolume Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Started Update UTMP about System Runlevel Changes. Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Startup finished in 11.536s (kernel) + 24.116s (userspace) = 35.653s. Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreStateMachine::pushState Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioPushState Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Reloading queue from file Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Setting Device type: Raspberry PI Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreStateMachine::setRepeat false single undefined Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreStateMachine::pushState Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioPushState Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreStateMachine::setRandom false Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreStateMachine::pushState Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioPushState Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Completed loading Core Plugins Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Preparing to generate the ALSA configuration file Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Reading ALSA contributions from plugins. Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Asound.conf file written Jul 21 16:07:28 volumio-rpi5-allo sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 21 16:07:28 volumio-rpi5-allo sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:28 volumio-rpi5-allo sudo[1344]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Output device has changed, restarting MPD Jul 21 16:07:28 volumio-rpi5-allo sudo[1349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 21 16:07:28 volumio-rpi5-allo sudo[1349]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Output device has changed, restarting Shairport Sync Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo sudo[1349]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:28 volumio-rpi5-allo sudo[1351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 21 16:07:28 volumio-rpi5-allo sudo[1351]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: ___________ START PLUGINS ___________ Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: ControllerMpd::onStart: Initializing MPD Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Creating MPD Configuration file Jul 21 16:07:28 volumio-rpi5-allo sudo[1359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 21 16:07:28 volumio-rpi5-allo sudo[1359]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: [1721570848736] CoreMusicLibrary::Adding element Media Servers Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo sudo[1359]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:28 volumio-rpi5-allo sudo[1361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 21 16:07:28 volumio-rpi5-allo sudo[1361]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Listening on mpd.socket. Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Starting Music Player Daemon... Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: mpd.service: Succeeded. Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Stopped Music Player Daemon. Jul 21 16:07:28 volumio-rpi5-allo systemd[1]: Starting Music Player Daemon... Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: [1721570848776] CoreMusicLibrary::Adding element Last_100 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: [1721570848777] CoreMusicLibrary::Adding element Webradio Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Initializing BBC Radios Jul 21 16:07:28 volumio-rpi5-allo sudo[1368]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 21 16:07:28 volumio-rpi5-allo sudo[1368]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:28 volumio-rpi5-allo sudo[1368]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jul 21 16:07:28 volumio-rpi5-allo sudo[1368]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Creating Spotify config file Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: [now-playing] ConfigUpdater: config is up to date. Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Loading i18n strings for locale en Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: /tmp/myfifo created Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: /tmp/myfifosa created Jul 21 16:07:28 volumio-rpi5-allo sudo[1389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Jul 21 16:07:28 volumio-rpi5-allo sudo[1389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:28 volumio-rpi5-allo sudo[1389]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: snd-dummy loaded Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: [1721570848945] CoreMusicLibrary::Adding element 80s80s Radio Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: Cannot find translation for source 80s80s Radio Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: [1721570848949] CoreMusicLibrary::Adding element Radio Paradise Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: Cannot find translation for source 80s80s Radio Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: Cannot find translation for source Radio Paradise Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: [1721570848956] CoreMusicLibrary::Adding element Randomizer Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: Cannot find translation for source 80s80s Radio Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: Cannot find translation for source Radio Paradise Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: Cannot find translation for source Randomizer Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Loading i18n strings for locale en Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 16:07:28 volumio-rpi5-allo volumio[1210]: info: Volumio Calling Home Jul 21 16:07:29 volumio-rpi5-allo sudo[1410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jul 21 16:07:29 volumio-rpi5-allo sudo[1410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo sudo[1415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jul 21 16:07:29 volumio-rpi5-allo sudo[1415]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo sudo[1412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jul 21 16:07:29 volumio-rpi5-allo sudo[1412]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: [now-playing] Fetching API key... Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: [now-playing] App is listening on port 4004. Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: Reloading. Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: adding e831b744-b092-48bc-8e34-123fee1036f1 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Found device Volumio-rPi5-Allo Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: adding 70b7061a-ec65-4b97-bb54-0f0f569e1ca3 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Found device Volumio-argone Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Connecting to remote: 192.168.1.110 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: adding 382baa26-21bb-4759-b9f9-0ff5b6243a8f Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Found device Motivo Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Connecting to remote: 192.168.1.145 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: adding 656f8e39-ea8c-4013-94ab-63d770127dd9 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Found device Primo Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Connecting to remote: 192.168.1.107 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: touch_display: No backlight interface detected. Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: MPD Permissions set Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: MPD Permissions set Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to 192.168.1.98:3000 from 192.168.1.111 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to 192.168.1.98:3000 from 192.168.1.111 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to 192.168.1.98:3000 from 192.168.1.99 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to 192.168.1.98:3000 from 192.168.1.99 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to 192.168.1.98:3000 from 192.168.1.107 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to 192.168.1.98:3000 from 192.168.1.164 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Spotify config file written Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jul 21 16:07:29 volumio-rpi5-allo sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: adding 75ec4b97-f6c5-4f71-834a-ec2a6227761b Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Found device Volumio-L9W Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Connecting to remote: 192.168.1.164 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Connected to remote: 192.168.1.110 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Connected to remote: 192.168.1.145 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jul 21 16:07:29 volumio-rpi5-allo 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. Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Jul 21 16:07:29 volumio-rpi5-allo sudo[1448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Jul 21 16:07:29 volumio-rpi5-allo sudo[1448]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo sudo[1446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jul 21 16:07:29 volumio-rpi5-allo sudo[1446]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo sudo[1450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Starting Shairport Sync Jul 21 16:07:29 volumio-rpi5-allo sudo[1450]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Starting Shairport Sync Jul 21 16:07:29 volumio-rpi5-allo sudo[1448]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Starting Shairport Sync Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Starting Shairport Sync Jul 21 16:07:29 volumio-rpi5-allo sudo[1455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 21 16:07:29 volumio-rpi5-allo sudo[1455]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo sudo[1450]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo sudo[1458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 21 16:07:29 volumio-rpi5-allo sudo[1446]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo sudo[1458]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Connected to remote: 192.168.1.107 Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed. Jul 21 16:07:29 volumio-rpi5-allo sudo[1461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 21 16:07:29 volumio-rpi5-allo sudo[1461]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: ifup@eth0.service: Current command vanished from the unit file, execution of the command list won't be resumed. Jul 21 16:07:29 volumio-rpi5-allo sudo[1246]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jul 21 16:07:29 volumio-rpi5-allo sudo[1463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 21 16:07:29 volumio-rpi5-allo sudo[1463]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Discovery: Connected to remote: 192.168.1.164 Jul 21 16:07:29 volumio-rpi5-allo sudo[1467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 21 16:07:29 volumio-rpi5-allo sudo[1467]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo sudo[1467]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo sudo[1415]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: Reloading. Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Volumio called home Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: touch_display: systemctl daemon-reload succeeded. Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: MPD Permissions set Jul 21 16:07:29 volumio-rpi5-allo sudo[1483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jul 21 16:07:29 volumio-rpi5-allo sudo[1483]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo 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. Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:29 volumio-rpi5-allo sudo[1412]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: touch_display: systemctl disable getty@tty1.service succeeded. Jul 21 16:07:29 volumio-rpi5-allo sudo[1410]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: touch_display: systemctl stop getty@tty1.service succeeded. Jul 21 16:07:29 volumio-rpi5-allo mpd[1375]: Jul 21 16:07 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: Started Volumio Kiosk. Jul 21 16:07:29 volumio-rpi5-allo sudo[1483]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: touch_display: Volumio Kiosk started. Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: Started go-librespot Daemon. Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:29 volumio-rpi5-allo go-librespot[1492]: Librespot-go daemon starting... Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: shairport-sync.service: Succeeded. Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 21 16:07:29 volumio-rpi5-allo sudo[1430]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 21 16:07:29 volumio-rpi5-allo sudo[1458]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo sudo[1455]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo sudo[1461]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo sudo[1463]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Shairport-Sync Started Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: Error adding Membership: Error: addMembership EINVAL Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Shairport-Sync Started Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Shairport-Sync Started Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: Shairport-Sync Started Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: touch_display: X display number found: Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Jul 21 16:07:29 volumio-rpi5-allo sudo[1525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 21 16:07:29 volumio-rpi5-allo sudo[1525]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: mpd.service: Succeeded. Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: Stopped Music Player Daemon. Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: X.Org X Server 1.20.4 Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: X Protocol Version 11, Revision 0 Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: Current Operating System: Linux volumio-rpi5-allo 6.1.69-v8+ #1710 SMP PREEMPT Thu Dec 21 13:21:40 GMT 2023 aarch64 Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 smsc95xx.macaddr=D8:3A:DD:BD:67:B4 vc_mem.mem_base=0x3fc00000 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=ttyAMA10,115200 console=tty1 imgpart=UUID=bd25db3a-79a0-4347-a360-dd9983daa4a1 imgfile=/volumio_current.sqsh bootpart=UUID=CB9F-1CDF datapart=UUID=4c0a45e1-1ede-46ab-add4-24c23a168fb5 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: Build Date: 04 April 2023 07:50:56AM Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: Current version of pixman: 0.36.0 Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: Before reporting problems, check http://wiki.x.org Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: to make sure that you have the latest version. Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: Markers: (--) probed, (**) from config file, (==) default setting, Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: (++) from command line, (!!) notice, (II) informational, Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Jul 21 16:07:29 2024 Jul 21 16:07:29 volumio-rpi5-allo systemd[1]: Starting Music Player Daemon... Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: (==) Using config directory: "/etc/X11/xorg.conf.d" Jul 21 16:07:29 volumio-rpi5-allo startx[1489]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jul 21 16:07:29 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:29+02:00" level=info msg="generated new device id: 6260b327e8c4da5fad90d4f4f5d14eede72cf243" Jul 21 16:07:29 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:29+02:00" level=debug msg="stored credentials found for z4ujt0w8jsm3yt93kz6hrseoy" Jul 21 16:07:29 volumio-rpi5-allo sudo[1528]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 21 16:07:29 volumio-rpi5-allo sudo[1528]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:29 volumio-rpi5-allo sudo[1528]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:29 volumio-rpi5-allo volumio[1210]: info: touch_display: X display number found: 0 Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: touch_display: X display number found: 0 Jul 21 16:07:30 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:30+02:00" level=debug msg="obtained new client token: AAB4JJTAAI4NCHdZ1f6Wydw7Hmbkf0LAA5St9NAIitgqnZj7JFwNvNhW2m+J9//uIQxryMNxrMD3+EeN93jj/Rxl23o8/59BSYN4XlRdDkf/BjsRnDW7cvLWTygi9PqT/6bG3yPSlrZDiWGog8JsG9FLfvTOzBZKN22sP1pWcWOjEKFO13jmC5Vn7AHiCuPyj0awbL1AUFwOYWh/ETXtKG5LOYv1AF+gfPHqXHrsEie4h08LkOJbCH7BxgqoR8D5" Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: [now-playing] OpenWeatherMap API key obtained. Jul 21 16:07:30 volumio-rpi5-allo mpd[1530]: Jul 21 16:07 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 21 16:07:30 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:30+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Jul 21 16:07:30 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:30+02:00" level=debug msg="completed keyexchange" Jul 21 16:07:30 volumio-rpi5-allo volumio-remote-updater[913]: [2024-07-21 16:07:30] [connect] Successful connection Jul 21 16:07:30 volumio-rpi5-allo volumio-remote-updater[913]: [2024-07-21 16:07:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1721570850 101 Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 11 Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: Discovery: Getting this device information Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 21 16:07:30 volumio-rpi5-allo systemd[1]: Started Music Player Daemon. Jul 21 16:07:30 volumio-rpi5-allo sudo[1361]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:30 volumio-rpi5-allo sudo[1351]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:30 volumio-rpi5-allo sudo[1525]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: Completed starting Core Plugins Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: ------------------------------------------- Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: ----- MyVolumio plugins startup ---- Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: ------------------------------------------- Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: info: MPD running with PID1530 Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: ,establishing connection Jul 21 16:07:30 volumio-rpi5-allo startx[1489]: V3D 7.1 not supported by this version of Mesa. Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: error: MPD error: The expression evaluated to a falsy value: Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: assert.ok(self.idling) Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: error: The expression evaluated to a falsy value: Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: assert.ok(self.idling) Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: error: MPD error: The expression evaluated to a falsy value: Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: assert.ok(self.idling) Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: error: The expression evaluated to a falsy value: Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: assert.ok(self.idling) Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: error: MPD error: The expression evaluated to a falsy value: Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: assert.ok(self.idling) Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: error: The expression evaluated to a falsy value: Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: assert.ok(self.idling) Jul 21 16:07:30 volumio-rpi5-allo volumio[1210]: error: updateQueue error: null Jul 21 16:07:30 volumio-rpi5-allo kernel: broken atomic modeset userspace detected, disabling atomic Jul 21 16:07:30 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:30+02:00" level=debug msg="completed challenge" Jul 21 16:07:30 volumio-rpi5-allo startx[1489]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Jul 21 16:07:31 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:31 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:31 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:31+02:00" level=debug msg="authenticated as z4ujt0w8jsm3yt93kz6hrseoy" Jul 21 16:07:31 volumio-rpi5-allo volumio[1210]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 21 16:07:32 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:32+02:00" level=debug msg="authenticated as z4ujt0w8jsm3yt93kz6hrseoy" Jul 21 16:07:32 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:32+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Jul 21 16:07:32 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:32+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: SPOTIFY: BQCV9s-y7zdz_ME71VdK7fKw_1qA8KuI070cAsi6EFK08xMMKR-XHdUWxZn-Y1zxfQt-zDX6fUTA83c0S8WTyfou8kSaxyNa9NPrh2aAjaAzopxBQdG_3aU6OMlIXNSV8Uh32q4UFpH4ACHqtvM-SJnijNinjpY983UCT9Vw7zFEmPdcFDkxyDgROhZNUoWXzPRObPZedTWP99d_JYbhoZZ36fdg5IxFEVpoIqhxl0ckVP2MC_M8aJFF-fqb0CGd3-1NrH4 Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: info: New Spotify access token = BQCV9s-y7zdz_ME71VdK7fKw_1qA8KuI070cAsi6EFK08xMMKR-XHdUWxZn-Y1zxfQt-zDX6fUTA83c0S8WTyfou8kSaxyNa9NPrh2aAjaAzopxBQdG_3aU6OMlIXNSV8Uh32q4UFpH4ACHqtvM-SJnijNinjpY983UCT9Vw7zFEmPdcFDkxyDgROhZNUoWXzPRObPZedTWP99d_JYbhoZZ36fdg5IxFEVpoIqhxl0ckVP2MC_M8aJFF-fqb0CGd3-1NrH4 Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: info: Spotify credentials grant success - running version from March 24, 2019 Jul 21 16:07:32 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:32+02:00" level=debug msg="dealer connection opened" Jul 21 16:07:32 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:32+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jul 21 16:07:32 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:32+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jul 21 16:07:32 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:32+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jul 21 16:07:32 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:32+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jul 21 16:07:32 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:32+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Jul 21 16:07:32 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:32+02:00" level=debug msg="received connection id: MTY4OTcxM2UtMTg4NC00MGZkLTgxNTUtNWIwYWRjNzc0MWJkK2RlYWxlcit0Y3A6Ly9nZXc0LWRlYWxlci1hLXdwbnEuZ2V3NC5zcG90aWZ5Lm5ldDo1NzAwK0NFMEUxQTkxMjMzMDQ1QTVBRkM3RkZGNjlDRDk0QTI4ODEwRTQ0RDgxQUY1NUVGRTVDMUZFNUI2OTQxQUYyNzU=" Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: SPOTIFY: User informations: {"display_name":"Marco","external_urls":{"spotify":"https://open.spotify.com/user/z4ujt0w8jsm3yt93kz6hrseoy"},"href":"https://api.spotify.com/v1/users/z4ujt0w8jsm3yt93kz6hrseoy","id":"z4ujt0w8jsm3yt93kz6hrseoy","images":[],"type":"user","uri":"spotify:user:z4ujt0w8jsm3yt93kz6hrseoy","followers":{"href":null,"total":0},"country":"NL","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"m.botermans@home.nl"} Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: info: Spotify Successfully logged in Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: info: [1721570852397] CoreMusicLibrary::Adding element Spotify Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: Cannot find translation for source 80s80s Radio Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: Cannot find translation for source Radio Paradise Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: Cannot find translation for source Randomizer Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: Cannot find translation for source Spotify Jul 21 16:07:32 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:32+02:00" level=debug msg="put connect state because NEW_DEVICE" Jul 21 16:07:32 volumio-rpi5-allo volumio[1210]: info: go-librespot daemon successfully initialized Jul 21 16:07:34 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jul 21 16:07:34 volumio-rpi5-allo volumio[1210]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jul 21 16:07:34 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jul 21 16:07:34 volumio-rpi5-allo volumio[1210]: info: Listing playlists Jul 21 16:07:34 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetQueue Jul 21 16:07:34 volumio-rpi5-allo volumio[1210]: info: CoreStateMachine::getQueue Jul 21 16:07:34 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getQueue Jul 21 16:07:34 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetVisibleSources Jul 21 16:07:34 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 16:07:34 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:34 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:35 volumio-rpi5-allo sudo[1748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 21 16:07:35 volumio-rpi5-allo sudo[1748]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:35 volumio-rpi5-allo sudo[1748]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:35 volumio-rpi5-allo sudo[1750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 16:07:35 volumio-rpi5-allo sudo[1750]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:35 volumio-rpi5-allo sudo[1750]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:35 volumio-rpi5-allo sudo[1754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 21 16:07:35 volumio-rpi5-allo sudo[1754]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:35 volumio-rpi5-allo sudo[1754]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:35 volumio-rpi5-allo systemd[1]: Started UPnP Renderer front-end to MPD. Jul 21 16:07:35 volumio-rpi5-allo volumio[1210]: info: Upmpdcli Daemon Started Jul 21 16:07:35 volumio-rpi5-allo volumio[1210]: info: Initializing connection to go-librespot Websocket Jul 21 16:07:35 volumio-rpi5-allo go-librespot[1492]: time="2024-07-21T16:07:35+02:00" level=debug msg="new websocket client" Jul 21 16:07:35 volumio-rpi5-allo volumio[1210]: info: Connection to go-librespot Websocket established Jul 21 16:07:36 volumio-rpi5-allo volumio[1210]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 21 16:07:36 volumio-rpi5-allo systemd[1]: systemd-fsckd.service: Succeeded. Jul 21 16:07:36 volumio-rpi5-allo volumio[1756]: Generating RSA private key, 4096 bit long modulus (2 primes) Jul 21 16:07:37 volumio-rpi5-allo sh[783]: timed out Jul 21 16:07:37 volumio-rpi5-allo dhcpcd[830]: timed out Jul 21 16:07:37 volumio-rpi5-allo sh[783]: dhcpcd exited Jul 21 16:07:37 volumio-rpi5-allo dhcpcd[830]: dhcpcd exited Jul 21 16:07:37 volumio-rpi5-allo sh[783]: ifup: failed to bring up eth0 Jul 21 16:07:37 volumio-rpi5-allo systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jul 21 16:07:37 volumio-rpi5-allo systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jul 21 16:07:38 volumio-rpi5-allo systemd[1]: systemd-hostnamed.service: Succeeded. Jul 21 16:07:38 volumio-rpi5-allo volumio[1210]: info: Getting Spotify volume Jul 21 16:07:39 volumio-rpi5-allo volumio[1210]: info: Spotify volume: 100 Jul 21 16:07:39 volumio-rpi5-allo volumio[1756]: ............................................................++++ Jul 21 16:07:39 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: Adding plugin bluetooth to MyMusic Plugins Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: Adding plugin multiroom to MyMusic Plugins Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: Adding plugin metavolumio to MyMusic Plugins Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: Adding plugin cd_controller to MyMusic Plugins Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 21 16:07:41 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: Starting MyVolumio Remote Streaming Endpoints Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: MyVolumio login type: Token Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: Starting Streaming Service Transparent Proxy Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: Streaming services startup Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: Starting Streaming Daemon Jul 21 16:07:42 volumio-rpi5-allo sudo[1973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 21 16:07:42 volumio-rpi5-allo sudo[1973]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:42 volumio-rpi5-allo sudo[1973]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: STREAMING PROXY: Starting server on port 3245 Jul 21 16:07:42 volumio-rpi5-allo volumio[1210]: Node JS runtime: 14 Jul 21 16:07:42 volumio-rpi5-allo volumio[1756]: ...............................................................++++ Jul 21 16:07:42 volumio-rpi5-allo volumio[1756]: e is 65537 (0x010001) Jul 21 16:07:42 volumio-rpi5-allo volumio[1756]: writing RSA key Jul 21 16:07:43 volumio-rpi5-allo volumio[1210]: error: Cannot start Volumio Streaming Daemon Jul 21 16:07:43 volumio-rpi5-allo volumio[1210]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 21 16:07:43 volumio-rpi5-allo volumio[1210]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 21 16:07:48 volumio-rpi5-allo volumio[1210]: error: MyVolumio Custom Token format not valid, refreshing it Jul 21 16:07:50 volumio-rpi5-allo kernel: usb usb3-port1: over-current change #1 Jul 21 16:07:50 volumio-rpi5-allo kernel: usb usb2-port1: over-current change #1 Jul 21 16:07:50 volumio-rpi5-allo kernel: usb usb1-port1: over-current change #1 Jul 21 16:07:50 volumio-rpi5-allo kernel: usb usb4-port1: over-current change #1 Jul 21 16:07:50 volumio-rpi5-allo kernel: usb 3-1: USB disconnect, device number 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: usb usb1-port2: over-current change #1 Jul 21 16:07:50 volumio-rpi5-allo kernel: usb 2-1: USB disconnect, device number 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: device offline error, dev sda, sector 2 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on dev sda1, logical block 1, lost async page write Jul 21 16:07:50 volumio-rpi5-allo kernel: device offline error, dev sda, sector 188416 op 0x1:(WRITE) flags 0x3000 phys_seg 1 prio class 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on dev sda2, logical block 0, lost async page write Jul 21 16:07:50 volumio-rpi5-allo kernel: device offline error, dev sda, sector 191264 op 0x1:(WRITE) flags 0x3000 phys_seg 1 prio class 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on dev sda2, logical block 356, lost async page write Jul 21 16:07:50 volumio-rpi5-allo kernel: device offline error, dev sda, sector 0 op 0x1:(WRITE) flags 0x800 phys_seg 0 prio class 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: device offline error, dev sda, sector 51438598 op 0x9:(WRITE_ZEROES) flags 0x800 phys_seg 0 prio class 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: device offline error, dev sda, sector 51438598 op 0x1:(WRITE) flags 0x800 phys_seg 2 prio class 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: device offline error, dev sda, sector 51438596 op 0x1:(WRITE) flags 0x0 phys_seg 2 prio class 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 5354565 starting block 25719298) Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on device sda3, logical block 22985218 Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on device sda3, logical block 22985219 Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on device sda3, logical block 22985220 Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on device sda3, logical block 22985221 Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 5354565 starting block 25719302) Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on device sda3, logical block 22985222 Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on device sda3, logical block 22985223 Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on device sda3, logical block 22985224 Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on device sda3, logical block 22985225 Jul 21 16:07:50 volumio-rpi5-allo kernel: device offline error, dev sda, sector 51438654 op 0x1:(WRITE) flags 0x0 phys_seg 2 prio class 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 5354570 starting block 25719327) Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on device sda3, logical block 22985247 Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on device sda3, logical block 22985248 Jul 21 16:07:50 volumio-rpi5-allo kernel: device offline error, dev sda, sector 5486490 op 0x1:(WRITE) flags 0x0 phys_seg 5 prio class 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 5354571 starting block 2743245) Jul 21 16:07:50 volumio-rpi5-allo kernel: device offline error, dev sda, sector 5486458 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 2 Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 5354571 starting block 2743229) Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: Stopped target Local File Systems. Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 5355770 starting block 25719332) Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 5454447 starting block 25719333) Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 5354559 starting block 25593915) Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 5454455 starting block 25160187) Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 5454862 starting block 25606145) Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on dev sda3, logical block 1, lost async page write Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on dev sda3, logical block 5, lost async page write Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on dev sda3, logical block 6, lost async page write Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on dev sda3, logical block 170, lost async page write Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on dev sda3, logical block 173, lost async page write Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on dev sda3, logical block 175, lost async page write Jul 21 16:07:50 volumio-rpi5-allo kernel: Buffer I/O error on dev sda3, logical block 178, lost async page write Jul 21 16:07:50 volumio-rpi5-allo kernel: JBD2: Detected IO errors while flushing file data on sda3-8 Jul 21 16:07:50 volumio-rpi5-allo kernel: Aborting journal on device sda3-8. Jul 21 16:07:50 volumio-rpi5-allo kernel: JBD2: I/O error when updating journal superblock for sda3-8. Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354536: comm (umount): reading directory lblock 0 Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:50 volumio-rpi5-allo systemd[2003]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:50 volumio-rpi5-allo systemd[2003]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:50 volumio-rpi5-allo systemd[2004]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:50 volumio-rpi5-allo systemd[2004]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354536: comm (umount): reading directory lblock 0 Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354536: comm (umount): reading directory lblock 0 Jul 21 16:07:50 volumio-rpi5-allo systemd[2005]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:50 volumio-rpi5-allo systemd[2005]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:50 volumio-rpi5-allo kernel: sd 1:0:0:0: [sda] Synchronizing SCSI cache Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:50 volumio-rpi5-allo systemd[2006]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354536: comm (umount): reading directory lblock 0 Jul 21 16:07:50 volumio-rpi5-allo systemd[2006]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:50 volumio-rpi5-allo systemd[2007]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:50 volumio-rpi5-allo systemd[2007]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:50 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354536: comm (umount): reading directory lblock 0 Jul 21 16:07:50 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo systemd[2008]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[2008]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354536: comm (umount): reading directory lblock 0 Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo kernel: usb usb3-port2: over-current change #1 Jul 21 16:07:51 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354536: comm (umount): reading directory lblock 0 Jul 21 16:07:51 volumio-rpi5-allo systemd[2009]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[2009]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo systemd[2010]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354536: comm (umount): reading directory lblock 0 Jul 21 16:07:51 volumio-rpi5-allo systemd[2010]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo systemd[2011]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[2011]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354536: comm (umount): reading directory lblock 0 Jul 21 16:07:51 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354536: comm (umount): reading directory lblock 0 Jul 21 16:07:51 volumio-rpi5-allo systemd[2012]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[2012]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo systemd[2013]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[2013]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo systemd[2014]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[2014]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo systemd[2015]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo systemd[2015]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo systemd[2016]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[2016]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo systemd[2017]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo kernel: sd 1:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK Jul 21 16:07:51 volumio-rpi5-allo systemd[2017]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo systemd[2018]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[2018]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device. Stopping, too. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:51 volumio-rpi5-allo systemd[2019]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[2019]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device, but not stopping since we tried this too often recently. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: systemd-fsck@dev-disk-by\x2duuid-CB9F\x2d1CDF.service: Succeeded. Jul 21 16:07:51 volumio-rpi5-allo systemd[1]: Stopped File System Check on /dev/disk/by-uuid/CB9F-1CDF. Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 3-2: USB disconnect, device number 3 Jul 21 16:07:51 volumio-rpi5-allo thd[898]: Error reading device '/dev/input/event0' Jul 21 16:07:51 volumio-rpi5-allo kernel: EXT4-fs (sda3): Remounting filesystem read-only Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 2-1: new SuperSpeed USB device number 3 using xhci-hcd Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 2-1: New USB device found, idVendor=0781, idProduct=55a3, bcdDevice= 1.00 Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 2-1: Product: SanDisk 3.2Gen1 Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 2-1: Manufacturer: USB Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 2-1: SerialNumber: 00014531021924090848 Jul 21 16:07:51 volumio-rpi5-allo kernel: scsi host0: uas Jul 21 16:07:51 volumio-rpi5-allo kernel: scsi 0:0:0:0: Direct-Access USB SanDisk 3.2Gen1 1.00 PQ: 0 ANSI: 7 Jul 21 16:07:51 volumio-rpi5-allo kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Jul 21 16:07:51 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] 240328704 512-byte logical blocks: (123 GB/115 GiB) Jul 21 16:07:51 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Write Protect is off Jul 21 16:07:51 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Mode Sense: 43 00 00 00 Jul 21 16:07:51 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jul 21 16:07:51 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Preferred minimum I/O size 4096 bytes Jul 21 16:07:51 volumio-rpi5-allo kernel: sdb: sdb1 sdb2 sdb3 Jul 21 16:07:51 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Attached SCSI removable disk Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 3-2: new full-speed USB device number 4 using xhci-hcd Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 3-2: New USB device found, idVendor=0712, idProduct=0009, bcdDevice= 2.00 Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 3-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 3-2: Product: WaveShare Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 3-2: Manufacturer: WaveShare Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 3-2: SerialNumber: 000000000089 Jul 21 16:07:51 volumio-rpi5-allo kernel: input: WaveShare WaveShare as /devices/platform/axi/1000120000.pcie/1f00300000.usb/xhci-hcd.1/usb3/3-2/3-2:1.0/0003:0712:0009.0002/input/input5 Jul 21 16:07:51 volumio-rpi5-allo kernel: hid-multitouch 0003:0712:0009.0002: input,hidraw0: USB HID v1.11 Device [WaveShare WaveShare] on usb-xhci-hcd.1-2/input0 Jul 21 16:07:51 volumio-rpi5-allo systemd-udevd[2002]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 21 16:07:51 volumio-rpi5-allo kernel: usb 3-1: new high-speed USB device number 5 using xhci-hcd Jul 21 16:07:52 volumio-rpi5-allo systemd-udevd[2001]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 21 16:07:52 volumio-rpi5-allo kernel: usb 3-1: New USB device found, idVendor=413c, idProduct=9016, bcdDevice= 0.00 Jul 21 16:07:52 volumio-rpi5-allo kernel: usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jul 21 16:07:52 volumio-rpi5-allo kernel: usb 3-1: Product: Dell DVD+/-RW Drive DW316 Jul 21 16:07:52 volumio-rpi5-allo kernel: usb 3-1: Manufacturer: Dell Inc. Jul 21 16:07:52 volumio-rpi5-allo kernel: usb 3-1: SerialNumber: KO1Z8PF3520 Jul 21 16:07:52 volumio-rpi5-allo kernel: usb-storage 3-1:1.0: USB Mass Storage device detected Jul 21 16:07:52 volumio-rpi5-allo kernel: scsi host2: usb-storage 3-1:1.0 Jul 21 16:07:52 volumio-rpi5-allo volumio[1210]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_00014531021924090848-0:0-part1 /dev/disk/by-uuid/CB9F-1CDF /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-label/boot /dev/disk/by-partuuid/7c68585b-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"25","ID_BUS":"usb","ID_FS_LABEL":"boot","ID_FS_LABEL_ENC":"boot","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"CB9F-1CDF","ID_FS_UUID_ENC":"CB9F-1CDF","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"55a3","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"1","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"187500","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"7c68585b-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"7c68585b","ID_PATH":"platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_00014531021924090848-0:0","ID_SERIAL_SHORT":"00014531021924090848","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"3082","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"1657020"} Jul 21 16:07:53 volumio-rpi5-allo kernel: scsi 2:0:0:0: CD-ROM Dell DVD+/-RW DW316 A1B1 PQ: 0 ANSI: 0 Jul 21 16:07:53 volumio-rpi5-allo volumio[1210]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-label/volumio /dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_00014531021924090848-0:0-part2 /dev/disk/by-partuuid/7c68585b-02 /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part2 /dev/disk/by-uuid/bd25db3a-79a0-4347-a360-dd9983daa4a1","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"25","ID_BUS":"usb","ID_FS_LABEL":"volumio","ID_FS_LABEL_ENC":"volumio","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"bd25db3a-79a0-4347-a360-dd9983daa4a1","ID_FS_UUID_ENC":"bd25db3a-79a0-4347-a360-dd9983daa4a1","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"55a3","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"188416","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"5279744","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"7c68585b-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"7c68585b","ID_PATH":"platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_00014531021924090848-0:0","ID_SERIAL_SHORT":"00014531021924090848","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"2","PARTN":"2","SEQNUM":"3083","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"1657525"} Jul 21 16:07:53 volumio-rpi5-allo kernel: sr 2:0:0:0: Power-on or device reset occurred Jul 21 16:07:53 volumio-rpi5-allo kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray Jul 21 16:07:53 volumio-rpi5-allo kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jul 21 16:07:53 volumio-rpi5-allo kernel: sr 2:0:0:0: Attached scsi generic sg1 type 5 Jul 21 16:07:53 volumio-rpi5-allo systemd[1]: Failed to propagate reload, ignoring: No such file or directory Jul 21 16:07:54 volumio-rpi5-allo volumio[1210]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sda/sda3","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_00014531021924090848-0:0-part3 /dev/disk/by-partuuid/7c68585b-03 /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part3 /dev/disk/by-uuid/4c0a45e1-1ede-46ab-add4-24c23a168fb5 /dev/disk/by-label/volumio_data","DEVNAME":"/dev/sda3","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sda/sda3","DEVTYPE":"partition","DISKSEQ":"25","ID_BUS":"usb","ID_FS_LABEL":"volumio_data","ID_FS_LABEL_ENC":"volumio_data","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"4c0a45e1-1ede-46ab-add4-24c23a168fb5","ID_FS_UUID_ENC":"4c0a45e1-1ede-46ab-add4-24c23a168fb5","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"55a3","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"5468160","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"234859966","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"7c68585b-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"7c68585b","ID_PATH":"platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_00014531021924090848-0:0","ID_SERIAL_SHORT":"00014531021924090848","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"3","PARTN":"3","SEQNUM":"3084","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"1656766"} Jul 21 16:07:54 volumio-rpi5-allo volumio[1210]: info: Ignoring mount for partition: volumio_data Jul 21 16:07:54 volumio-rpi5-allo volumio[1210]: info: Ignoring mount for partition: boot Jul 21 16:07:54 volumio-rpi5-allo volumio[1210]: info: Ignoring mount for partition: volumio Jul 21 16:07:54 volumio-rpi5-allo volumio[1210]: info: MyVolumio login type: Token Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: error: Failed to update update history file: function createApplication() { Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: var app = function(req, res, next) { Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: app.handle(req, res, next); Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: }; Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: mixin(app, EventEmitter.prototype, false); Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: mixin(app, proto, false); Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: // expose the prototype that will get set on requests Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: app.request = Object.create(req, { Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: app: { configurable: true, enumerable: true, writable: true, value: app } Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: }) Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: // expose the prototype that will get set on responses Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: app.response = Object.create(res, { Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: app: { configurable: true, enumerable: true, writable: true, value: app } Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: }) Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: app.init(); Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: return app; Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: } Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: MyVolumio token set successfully Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: MYVOLUMIO: Adding device Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: MYVOLUMIO: Evaluating Server Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: error: Could not find ideal Myvolumio endpoint, defaulting to eu1 Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: MyVolumio Plan changed: premium Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: Removing browser output: myVolumio user plan is not superstar Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: Removing audio output: Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: MYVOLUMIO: Adding device Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: MYVOLUMIO: Evaluating Server Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: Remote config written successfully Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: Starting Tunnel 1 Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: Starting Tunnel Connection Checker Jul 21 16:07:55 volumio-rpi5-allo volumio[1210]: info: Completed starting MyVolumio Plugin Jul 21 16:07:56 volumio-rpi5-allo kernel: EXT4-fs error: 24 callbacks suppressed Jul 21 16:07:56 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354536: comm node: reading directory lblock 0 Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: error: Could not find ideal Myvolumio endpoint, defaulting to eu1 Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: MYVolumio Device enabled Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: MyVolumio status changed Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: Streaming services startup Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: Starting Streaming Daemon Jul 21 16:07:56 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354581: comm node: reading directory lblock 0 Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] Could not read cache file: EIO: i/o error, open '/data/myvolumio/cache.data' Jul 21 16:07:56 volumio-rpi5-allo sudo[2055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 21 16:07:56 volumio-rpi5-allo sudo[2055]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:56 volumio-rpi5-allo sudo[2055]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: error: Cannot start Volumio Streaming Daemon Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/system_controller/my_volumio/config.json' Jul 21 16:07:56 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354638: comm node: reading directory lblock 0 Jul 21 16:07:56 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354638: comm node: reading directory lblock 0 Jul 21 16:07:56 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354638: comm node: reading directory lblock 0 Jul 21 16:07:56 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354637: comm node: reading directory lblock 0 Jul 21 16:07:56 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354637: comm node: reading directory lblock 0 Jul 21 16:07:56 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354637: comm node: reading directory lblock 0 Jul 21 16:07:56 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354637: comm node: reading directory lblock 0 Jul 21 16:07:56 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5354637: comm node: reading directory lblock 0 Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: Successfully Added MyVolumio device Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: Updating MyVolumio device info Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:56 volumio-rpi5-allo volumio[1210]: info: Successfully Added MyVolumio device Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: Updating MyVolumio device info Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetState Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: CorePlayQueue::getTrack 0 Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: Successfully Updated MyVolumio device Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: Successfully Updated MyVolumio device Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: [1721570877863] Starting BluetoothController Jul 21 16:07:57 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] The plugin audio_interface/multiroom failed to load, setting it to stopped. Error: Error: EIO: i/o error, mkdir '/data/configuration/audio_interface/multiroom' Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo sudo[2058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jul 21 16:07:58 volumio-rpi5-allo sudo[2058]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:58 volumio-rpi5-allo sudo[2058]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:58 volumio-rpi5-allo kernel: EXT4-fs warning: 24 callbacks suppressed Jul 21 16:07:58 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #5389812: lblock 0: comm sh: error -5 reading directory block Jul 21 16:07:58 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #5389812: lblock 0: comm sh: error -5 reading directory block Jul 21 16:07:58 volumio-rpi5-allo kernel: usb usb3-port1: over-current change #2 Jul 21 16:07:58 volumio-rpi5-allo kernel: usb usb2-port1: over-current change #2 Jul 21 16:07:58 volumio-rpi5-allo kernel: usb usb1-port1: over-current change #2 Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: /bin/sh: 1: /usr/bin/setfacl: Input/output error Jul 21 16:07:58 volumio-rpi5-allo kernel: usb usb4-port1: over-current change #2 Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: MRS: MultiRoom plugin initialized Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: MRS: STOPPING SNAPCLIENT Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: MRS: Snap server stop Jul 21 16:07:58 volumio-rpi5-allo sudo[2077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jul 21 16:07:58 volumio-rpi5-allo sudo[2077]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: MRS: STOPPING volumioStreaming Jul 21 16:07:58 volumio-rpi5-allo sudo[2077]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:58 volumio-rpi5-allo sudo[2080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jul 21 16:07:58 volumio-rpi5-allo sudo[2080]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:58 volumio-rpi5-allo sudo[2083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jul 21 16:07:58 volumio-rpi5-allo sudo[2083]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:58 volumio-rpi5-allo sudo[2080]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:58 volumio-rpi5-allo sudo[2083]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jul 21 16:07:58 volumio-rpi5-allo kernel: usb 3-1: USB disconnect, device number 5 Jul 21 16:07:58 volumio-rpi5-allo kernel: usb usb1-port2: over-current change #2 Jul 21 16:07:58 volumio-rpi5-allo sudo[2086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 21 16:07:58 volumio-rpi5-allo sudo[2086]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:58 volumio-rpi5-allo sudo[2086]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] The plugin miscellanea/metavolumio failed to load, setting it to stopped. Error: Error: EIO: i/o error, mkdir '/data/configuration/miscellanea/metavolumio' Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] The plugin miscellanea/manifestui failed to load, setting it to stopped. Error: Error: EIO: i/o error, mkdir '/data/configuration/miscellanea/manifestui' Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: warn: [MyVolumio PluginManager] It looks like we're trying to load a cleartext plugin in: /myvolumio/plugins/music_service/cd_controller/index.js Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] The plugin music_service/cd_controller failed to load, setting it to stopped. Error: Error: /myvolumio/plugins/music_service/cd_controller/lib/cd_controller.node: cannot read file data: Input/output error Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jul 21 16:07:58 volumio-rpi5-allo kernel: blk_print_req_error: 91 callbacks suppressed Jul 21 16:07:58 volumio-rpi5-allo kernel: I/O error, dev loop0, sector 302010 op 0x0:(READ) flags 0x800 phys_seg 13 prio class 2 Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Failed to read block 0x9377724: -5 Jul 21 16:07:58 volumio-rpi5-allo kernel: I/O error, dev loop0, sector 302010 op 0x0:(READ) flags 0x800 phys_seg 15 prio class 2 Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Failed to read block 0x9377724: -5 Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read data cache entry [9377724] Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read page, block 9377724, size dea1 Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read data cache entry [9377724] Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read page, block 9377724, size dea1 Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: warn: [MyVolumio PluginManager] It looks like we're trying to load a cleartext plugin in: /myvolumio/plugins/music_service/smart_inputs/index.js Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] The plugin music_service/smart_inputs failed to load, setting it to stopped. Error: Error: /myvolumio/plugins/music_service/smart_inputs/lib/smart_inputs.node: cannot read file data: Input/output error Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jul 21 16:07:58 volumio-rpi5-allo kernel: I/O error, dev loop0, sector 333652 op 0x0:(READ) flags 0x800 phys_seg 14 prio class 2 Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Failed to read block 0xa2eaa23: -5 Jul 21 16:07:58 volumio-rpi5-allo kernel: I/O error, dev loop0, sector 333652 op 0x0:(READ) flags 0x800 phys_seg 15 prio class 2 Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Failed to read block 0xa2eaa23: -5 Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read data cache entry [a2eaa23] Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read page, block a2eaa23, size ddf3 Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read data cache entry [a2eaa23] Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read page, block a2eaa23, size ddf3 Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] The plugin music_service/hi_res_audio failed to load, setting it to stopped. Error: Error: EIO: i/o error, mkdir '/data/configuration/music_service/hi_res_audio' Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jul 21 16:07:58 volumio-rpi5-allo kernel: usb 2-1: USB disconnect, device number 3 Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] The plugin music_service/tidal failed to load, setting it to stopped. Error: Error: EIO: i/o error, mkdir '/data/configuration/music_service/tidal' Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: warn: [MyVolumio PluginManager] It looks like we're trying to load a cleartext plugin in: /myvolumio/plugins/music_service/qobuz/index.js Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] The plugin music_service/qobuz failed to load, setting it to stopped. Error: Error: /myvolumio/plugins/music_service/qobuz/lib/qobuz.node: cannot read file data: Input/output error Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] !!!! WARNING !!!! Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jul 21 16:07:58 volumio-rpi5-allo kernel: I/O error, dev loop0, sector 303128 op 0x0:(READ) flags 0x800 phys_seg 14 prio class 2 Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Failed to read block 0x94031f6: -5 Jul 21 16:07:58 volumio-rpi5-allo kernel: I/O error, dev loop0, sector 303128 op 0x0:(READ) flags 0x800 phys_seg 15 prio class 2 Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Failed to read block 0x94031f6: -5 Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read data cache entry [94031f6] Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read page, block 94031f6, size df2d Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read data cache entry [94031f6] Jul 21 16:07:58 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read page, block 94031f6, size df2d Jul 21 16:07:58 volumio-rpi5-allo systemd[1]: Unmounting /boot... Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Preparing to generate the ALSA configuration file Jul 21 16:07:58 volumio-rpi5-allo systemd[2089]: boot.mount: Failed to execute command: Input/output error Jul 21 16:07:58 volumio-rpi5-allo systemd[2089]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Jul 21 16:07:58 volumio-rpi5-allo systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Jul 21 16:07:58 volumio-rpi5-allo systemd[1]: Failed unmounting /boot. Jul 21 16:07:58 volumio-rpi5-allo systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-CB9F\x2d1CDF.device, but not stopping since we tried this too often recently. Jul 21 16:07:58 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #5482009: lblock 0: comm node: error -5 reading directory block Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: [MyVolumio PluginManager] Could not create cache dir /data/myvolumio/: EIO: i/o error, mkdir '/data/myvolumio/' Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: warn: Unable to scan plugin peppy_screensaver for ALSA configuration: Error: EIO: i/o error, scandir '/data/plugins//user_interface/peppy_screensaver/asound' Jul 21 16:07:58 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Synchronizing SCSI cache Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: MRS: Removed streaming files Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: MRS: Cannot Kill volumioStreaming Command failed: /usr/bin/sudo /bin/systemctl stop volumioStreaming Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: Failed to stop volumioStreaming.service: Unit volumioStreaming.service not loaded. Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: {"killed":false,"code":5,"signal":null,"cmd":"/usr/bin/sudo /bin/systemctl stop volumioStreaming","stack":"Error: Command failed: /usr/bin/sudo /bin/systemctl stop volumioStreaming\nFailed to stop volumioStreaming.service: Unit volumioStreaming.service not loaded.\n\n at ChildProcess.exithandler (child_process.js:308:12)\n at ChildProcess.emit (events.js:315:20)\n at maybeClose (internal/child_process.js:1048:16)\n at Socket. (internal/child_process.js:439:11)\n at Socket.emit (events.js:315:20)\n at Pipe. (net.js:673:12)"} Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: MRS: Cannot STOP Snap Server Command failed: /usr/bin/sudo /bin/systemctl stop volumioSnapserver Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: Failed to stop volumioSnapserver.service: Unit volumioSnapserver.service not loaded. Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: {"killed":false,"code":5,"signal":null,"cmd":"/usr/bin/sudo /bin/systemctl stop volumioSnapserver","stack":"Error: Command failed: /usr/bin/sudo /bin/systemctl stop volumioSnapserver\nFailed to stop volumioSnapserver.service: Unit volumioSnapserver.service not loaded.\n\n at ChildProcess.exithandler (child_process.js:308:12)\n at ChildProcess.emit (events.js:315:20)\n at maybeClose (internal/child_process.js:1048:16)\n at Socket. (internal/child_process.js:439:11)\n at Socket.emit (events.js:315:20)\n at Pipe. (net.js:673:12)"} Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: MRS: Cannot Kill Snapclient Command failed: /usr/bin/sudo /bin/systemctl stop volumioSnapclient Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: Failed to stop volumioSnapclient.service: Unit volumioSnapclient.service not loaded. Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: {"killed":false,"code":5,"signal":null,"cmd":"/usr/bin/sudo /bin/systemctl stop volumioSnapclient","stack":"Error: Command failed: /usr/bin/sudo /bin/systemctl stop volumioSnapclient\nFailed to stop volumioSnapclient.service: Unit volumioSnapclient.service not loaded.\n\n at ChildProcess.exithandler (child_process.js:308:12)\n at ChildProcess.emit (events.js:315:20)\n at maybeClose (internal/child_process.js:1048:16)\n at Socket. (internal/child_process.js:439:11)\n at Socket.emit (events.js:315:20)\n at Pipe. (net.js:673:12)"} Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_00014531021924090848-0:0-part1 /dev/disk/by-uuid/CB9F-1CDF /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-label/boot /dev/disk/by-partuuid/7c68585b-01","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"30","ID_BUS":"usb","ID_FS_LABEL":"boot","ID_FS_LABEL_ENC":"boot","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"CB9F-1CDF","ID_FS_UUID_ENC":"CB9F-1CDF","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"55a3","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"1","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"187500","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"7c68585b-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"7c68585b","ID_PATH":"platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_00014531021924090848-0:0","ID_SERIAL_SHORT":"00014531021924090848","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"3177","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"58631352"} Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sdb/sdb2","ACTION":"remove","DEVLINKS":"/dev/disk/by-label/volumio /dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_00014531021924090848-0:0-part2 /dev/disk/by-partuuid/7c68585b-02 /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part2 /dev/disk/by-uuid/bd25db3a-79a0-4347-a360-dd9983daa4a1","DEVNAME":"/dev/sdb2","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sdb/sdb2","DEVTYPE":"partition","DISKSEQ":"30","ID_BUS":"usb","ID_FS_LABEL":"volumio","ID_FS_LABEL_ENC":"volumio","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"bd25db3a-79a0-4347-a360-dd9983daa4a1","ID_FS_UUID_ENC":"bd25db3a-79a0-4347-a360-dd9983daa4a1","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"55a3","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"188416","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"5279744","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"7c68585b-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"7c68585b","ID_PATH":"platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_00014531021924090848-0:0","ID_SERIAL_SHORT":"00014531021924090848","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"18","PARTN":"2","SEQNUM":"3178","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"58634962"} Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sdb/sdb3","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_00014531021924090848-0:0-part3 /dev/disk/by-partuuid/7c68585b-03 /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part3 /dev/disk/by-uuid/4c0a45e1-1ede-46ab-add4-24c23a168fb5 /dev/disk/by-label/volumio_data","DEVNAME":"/dev/sdb3","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sdb/sdb3","DEVTYPE":"partition","DISKSEQ":"30","ID_BUS":"usb","ID_FS_LABEL":"volumio_data","ID_FS_LABEL_ENC":"volumio_data","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"4c0a45e1-1ede-46ab-add4-24c23a168fb5","ID_FS_UUID_ENC":"4c0a45e1-1ede-46ab-add4-24c23a168fb5","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"55a3","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"5468160","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"234859966","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"7c68585b-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"7c68585b","ID_PATH":"platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_00014531021924090848-0:0","ID_SERIAL_SHORT":"00014531021924090848","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"19","PARTN":"3","SEQNUM":"3179","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"58614202"} Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: Cannot write /etc/asound.conf: Error: EROFS: read-only file system, open '/home/volumio/.asoundrc' Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Output device has changed, restarting MPD Jul 21 16:07:58 volumio-rpi5-allo kernel: usb usb3-port2: over-current change #2 Jul 21 16:07:58 volumio-rpi5-allo sudo[2091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 21 16:07:58 volumio-rpi5-allo sudo[2091]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:58 volumio-rpi5-allo sudo[2091]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Output device has changed, restarting Shairport Sync Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:58 volumio-rpi5-allo sudo[2094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 21 16:07:58 volumio-rpi5-allo sudo[2094]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:58 volumio-rpi5-allo systemd[1]: Stopping Music Player Daemon... Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 16:07:58 volumio-rpi5-allo kernel: usb 3-2: USB disconnect, device number 4 Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: MRS: Pushing multiroomSync output for this device Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: MRS: Pushing multiroomSync output Jul 21 16:07:58 volumio-rpi5-allo sudo[2102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio-rPi5-Allo Jul 21 16:07:58 volumio-rpi5-allo sudo[2102]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Adding audio output: Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:58 volumio-rpi5-allo sudo[2102]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:58 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK Jul 21 16:07:58 volumio-rpi5-allo systemd[1]: mpd.service: Succeeded. Jul 21 16:07:58 volumio-rpi5-allo systemd[1]: Stopped Music Player Daemon. Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Adding METAVOLUMIO REST API Endpoints Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: error: Hi Res Audio Failed Login: Missing Login Data Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Adding HIGHRESAUDIO REST API Endpoints Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Jul 21 16:07:58 volumio-rpi5-allo systemd[1]: Starting Music Player Daemon... Jul 21 16:07:58 volumio-rpi5-allo sudo[2110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 21 16:07:58 volumio-rpi5-allo sudo[2110]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Stopping AccessToken refresher cron Jul 21 16:07:58 volumio-rpi5-allo sudo[2110]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:58 volumio-rpi5-allo sudo[2106]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 21 16:07:58 volumio-rpi5-allo sudo[2106]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:58 volumio-rpi5-allo sudo[2106]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: AccessToken refresher cron started Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Adding TIDAL REST API Endpoints Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: MRS: Adding multiroomSync output Jul 21 16:07:58 volumio-rpi5-allo volumio[1210]: info: Adding audio output: Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: MRS: Pushing multiroomSync output Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: Failed to stop vtcs.service: Unit vtcs.service not loaded. Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: {"killed":false,"code":5,"signal":null,"cmd":"/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3","stdout":"","stderr":"Failed to stop vtcs.service: Unit vtcs.service not loaded.\n","stack":"Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3\nFailed to stop vtcs.service: Unit vtcs.service not loaded.\n\n at ChildProcess.exithandler (child_process.js:308:12)\n at ChildProcess.emit (events.js:315:20)\n at maybeClose (internal/child_process.js:1048:16)\n at Socket. (internal/child_process.js:439:11)\n at Socket.emit (events.js:315:20)\n at Pipe. (net.js:673:12)"} Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: Bluetooth name changed to Volumio-rPi5-Allo Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: Error setting mpd conf file perms: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/mpd.conf Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: /bin/chmod: changing permissions of '/etc/mpd.conf': Read-only file system Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: Could not write mpd.conf:Error: EROFS: read-only file system, open '/etc/mpd.conf' Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: Starting Shairport Sync Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: error: Could Not Write Alsa Configuration File: Error: EIO: i/o error, mkdir '/data/configuration/audio_interface/multiroom/asound' Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: BOOT COMPLETED Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: [Metrics] CommandRouter: 34s 204.40ms Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumiosetStartupVolume Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo sudo[2121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 21 16:07:59 volumio-rpi5-allo sudo[2121]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:07:59 volumio-rpi5-allo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 21 16:07:59 volumio-rpi5-allo systemd[1]: shairport-sync.service: Succeeded. Jul 21 16:07:59 volumio-rpi5-allo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-2: new full-speed USB device number 6 using xhci-hcd Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::Close All Modals sent Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::Close All Modals sent Jul 21 16:07:59 volumio-rpi5-allo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 21 16:07:59 volumio-rpi5-allo sudo[2121]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: error: Could Not Write Alsa Configuration File: Error: EIO: i/o error, mkdir '/data/configuration/audio_interface/multiroom/asound' Jul 21 16:07:59 volumio-rpi5-allo kernel: I/O error, dev loop0, sector 904862 op 0x0:(READ) flags 0x800 phys_seg 20 prio class 2 Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Failed to read block 0x1b9d3c59: -5 Jul 21 16:07:59 volumio-rpi5-allo kernel: I/O error, dev loop0, sector 905046 op 0x0:(READ) flags 0x800 phys_seg 23 prio class 2 Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Failed to read block 0x1b9ead6d: -5 Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 2-1: new SuperSpeed USB device number 4 using xhci-hcd Jul 21 16:07:59 volumio-rpi5-allo volumio-remote-updater[913]: No test mode Jul 21 16:07:59 volumio-rpi5-allo volumio-remote-updater[913]: No alpha test mode Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: Shairport-Sync Started Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 2-1: New USB device found, idVendor=0781, idProduct=55a3, bcdDevice= 1.00 Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 2-1: Product: SanDisk 3.2Gen1 Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 2-1: Manufacturer: USB Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 2-1: SerialNumber: 00014531021924090848 Jul 21 16:07:59 volumio-rpi5-allo kernel: scsi host0: uas Jul 21 16:07:59 volumio-rpi5-allo kernel: scsi 0:0:0:0: Direct-Access USB SanDisk 3.2Gen1 1.00 PQ: 0 ANSI: 7 Jul 21 16:07:59 volumio-rpi5-allo kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Jul 21 16:07:59 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] 240328704 512-byte logical blocks: (123 GB/115 GiB) Jul 21 16:07:59 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Write Protect is off Jul 21 16:07:59 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Mode Sense: 43 00 00 00 Jul 21 16:07:59 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jul 21 16:07:59 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Preferred minimum I/O size 4096 bytes Jul 21 16:07:59 volumio-rpi5-allo kernel: sdb: sdb1 sdb2 sdb3 Jul 21 16:07:59 volumio-rpi5-allo kernel: sd 0:0:0:0: [sdb] Attached SCSI removable disk Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-2: New USB device found, idVendor=0712, idProduct=0009, bcdDevice= 2.00 Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-2: Product: WaveShare Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-2: Manufacturer: WaveShare Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-2: SerialNumber: 000000000089 Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/plugins.json' Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: Ignoring mount for partition: volumio_data Jul 21 16:07:59 volumio-rpi5-allo kernel: input: WaveShare WaveShare as /devices/platform/axi/1000120000.pcie/1f00300000.usb/xhci-hcd.1/usb3/3-2/3-2:1.0/0003:0712:0009.0003/input/input6 Jul 21 16:07:59 volumio-rpi5-allo kernel: hid-multitouch 0003:0712:0009.0003: input,hidraw0: USB HID v1.11 Device [WaveShare WaveShare] on usb-xhci-hcd.1-2/input0 Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: Ignoring mount for partition: volumio Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: Ignoring mount for partition: boot Jul 21 16:07:59 volumio-rpi5-allo mpd[2113]: Jul 21 16:07 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 21 16:07:59 volumio-rpi5-allo kernel: I/O error, dev loop0, sector 905234 op 0x0:(READ) flags 0x800 phys_seg 23 prio class 2 Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Failed to read block 0x1ba0266a: -5 Jul 21 16:07:59 volumio-rpi5-allo kernel: I/O error, dev loop0, sector 905414 op 0x0:(READ) flags 0x800 phys_seg 21 prio class 2 Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Failed to read block 0x1ba18eec: -5 Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Failed to read block 0x1b9d3c59: -5 Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read data cache entry [1b9d3c59] Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read page, block 1b9d3c59, size 17114 Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read data cache entry [1b9d3c59] Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read page, block 1b9d3c59, size 17114 Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read data cache entry [1b9d3c59] Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read page, block 1b9d3c59, size 17114 Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read data cache entry [1b9d3c59] Jul 21 16:07:59 volumio-rpi5-allo kernel: SQUASHFS error: Unable to read page, block 1b9d3c59, size 17114 Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: /volumio/app/startup.wav: Input/output error Jul 21 16:07:59 volumio-rpi5-allo systemd-udevd[2071]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-1: new high-speed USB device number 7 using xhci-hcd Jul 21 16:07:59 volumio-rpi5-allo systemd-udevd[2070]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-1: New USB device found, idVendor=413c, idProduct=9016, bcdDevice= 0.00 Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-1: Product: Dell DVD+/-RW Drive DW316 Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-1: Manufacturer: Dell Inc. Jul 21 16:07:59 volumio-rpi5-allo kernel: usb 3-1: SerialNumber: KO1Z8PF3520 Jul 21 16:07:59 volumio-rpi5-allo kernel: usb-storage 3-1:1.0: USB Mass Storage device detected Jul 21 16:07:59 volumio-rpi5-allo kernel: scsi host2: usb-storage 3-1:1.0 Jul 21 16:07:59 volumio-rpi5-allo systemd[1]: Started Music Player Daemon. Jul 21 16:07:59 volumio-rpi5-allo sudo[2094]: pam_unix(sudo:session): session closed for user root Jul 21 16:07:59 volumio-rpi5-allo volumio[1210]: error: updateQueue error: null Jul 21 16:08:00 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 21 16:08:00 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 21 16:08:00 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 21 16:08:00 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #5454494: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Jul 21 16:08:00 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #5453989: lblock 0: comm run-parts: error -5 reading directory block Jul 21 16:08:00 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #5514661: lblock 0: comm lsb_release: error -5 reading directory block Jul 21 16:08:00 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #5514661: lblock 0: comm lsb_release: error -5 reading directory block Jul 21 16:08:00 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #5389812: lblock 0: comm lsb_release: error -5 reading directory block Jul 21 16:08:00 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #5389812: lblock 0: comm lsb_release: error -5 reading directory block Jul 21 16:08:00 volumio-rpi5-allo kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #5389812: lblock 0: comm lsb_release: error -5 reading directory block Jul 21 16:08:00 volumio-rpi5-allo kernel: scsi 2:0:0:0: CD-ROM Dell DVD+/-RW DW316 A1B1 PQ: 0 ANSI: 0 Jul 21 16:08:00 volumio-rpi5-allo kernel: sr 2:0:0:0: Power-on or device reset occurred Jul 21 16:08:00 volumio-rpi5-allo kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray Jul 21 16:08:00 volumio-rpi5-allo kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jul 21 16:08:00 volumio-rpi5-allo kernel: sr 2:0:0:0: Attached scsi generic sg1 type 5 Jul 21 16:08:01 volumio-rpi5-allo systemd[1]: Failed to propagate reload, ignoring: No such file or directory Jul 21 16:08:01 volumio-rpi5-allo kernel: EXT4-fs error: 161 callbacks suppressed Jul 21 16:08:01 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #3569665: comm lsb_release: reading directory lblock 0 Jul 21 16:08:01 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5514661: comm lsb_release: reading directory lblock 0 Jul 21 16:08:01 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #3569665: comm lsb_release: reading directory lblock 0 Jul 21 16:08:01 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5514661: comm lsb_release: reading directory lblock 0 Jul 21 16:08:01 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #3569665: comm lsb_release: reading directory lblock 0 Jul 21 16:08:01 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5514661: comm lsb_release: reading directory lblock 0 Jul 21 16:08:01 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #3569665: comm lsb_release: reading directory lblock 0 Jul 21 16:08:01 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5514661: comm lsb_release: reading directory lblock 0 Jul 21 16:08:01 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #3569665: comm lsb_release: reading directory lblock 0 Jul 21 16:08:01 volumio-rpi5-allo kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #5514661: comm lsb_release: reading directory lblock 0 Jul 21 16:08:01 volumio-rpi5-allo sudo[2383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jul 21 16:08:01 volumio-rpi5-allo sudo[2383]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 16:08:01 volumio-rpi5-allo sudo[2383]: pam_unix(sudo:session): session closed for user root Jul 21 16:08:01 volumio-rpi5-allo volumio[1210]: error: Cannot start Volumio BT Module: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumiobt.service Jul 21 16:08:01 volumio-rpi5-allo volumio[1210]: Failed to start volumiobt.service: Unit volumiobt.service not found. Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::volumioGetBrowseSources Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: Error: EIO: i/o error, scandir '/data/plugins/' Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: at Object.readdirSync (fs.js:1021:3) Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1627:30) Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1521:29) Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: at myVolumio.identifyUserProperties (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:42317) Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: at Timeout._onTimeout (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:2508) Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: at listOnTimeout (internal/timers.js:554:17) Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: at processTimers (internal/timers.js:497:7) { Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: errno: -5, Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: syscall: 'scandir', Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: code: 'EIO', Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: path: '/data/plugins/' Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: } Jul 21 16:08:02 volumio-rpi5-allo volumio[1210]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 16:08:02 volumio-rpi5-allo sudo[2452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 16:07 Jul 21 16:08:02 volumio-rpi5-allo sudo[2452]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="905ee02fb5387537cfa16b84ebd7f14b7640848e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 18 Jul 2024 07:14:40 PM CEST" VOLUMIO_VERSION="3.741" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a68099d1a5f4301106a28f85f8548ae3"