-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Wed 2024-09-04 22:37:02 CEST. -- Sep 04 22:36:01 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 22:36:01 rpi5-mhs35 wpa_supplicant[3236]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:36:05 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 22:36:06 rpi5-mhs35 kernel: usb usb2-port1: over-current change #1 Sep 04 22:36:06 rpi5-mhs35 kernel: usb usb1-port1: over-current change #1 Sep 04 22:36:06 rpi5-mhs35 kernel: usb usb4-port1: over-current change #1 Sep 04 22:36:07 rpi5-mhs35 kernel: usb usb3-port2: over-current change #1 Sep 04 22:36:07 rpi5-mhs35 kernel: usb usb1-port2: over-current change #1 Sep 04 22:36:07 rpi5-mhs35 kernel: usb 2-1: USB disconnect, device number 2 Sep 04 22:36:07 rpi5-mhs35 kernel: device offline error, dev sda, sector 26408064 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 2 Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 178124 starting block 3301008) Sep 04 22:36:07 rpi5-mhs35 kernel: device offline error, dev sda, sector 7889936 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 2 Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 149981 starting block 986242) Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on device sda3, logical block 302722 Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on device sda3, logical block 2617488 Sep 04 22:36:07 rpi5-mhs35 kernel: device offline error, dev sda, sector 7891984 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 2 Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 149997 starting block 986498) Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on device sda3, logical block 302978 Sep 04 22:36:07 rpi5-mhs35 kernel: device offline error, dev sda, sector 8004624 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 2 Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 150004 starting block 1000578) Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on device sda3, logical block 317058 Sep 04 22:36:07 rpi5-mhs35 kernel: device offline error, dev sda, sector 26431800 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 2 Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): ext4_end_bio:347: I/O error 17 writing to inode 150539 starting block 3303975) Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on device sda3, logical block 2620455 Sep 04 22:36:07 rpi5-mhs35 kernel: device offline error, dev sda, sector 5468160 op 0x1:(WRITE) flags 0x3000 phys_seg 2 prio class 2 Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on dev sda3, logical block 0, lost async page write Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on dev sda3, logical block 1, lost async page write Sep 04 22:36:07 rpi5-mhs35 kernel: device offline error, dev sda, sector 9662632 op 0x1:(WRITE) flags 0x3000 phys_seg 1 prio class 2 Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on dev sda3, logical block 524309, lost async page write Sep 04 22:36:07 rpi5-mhs35 kernel: device offline error, dev sda, sector 14131824 op 0x1:(WRITE) flags 0x800 phys_seg 5 prio class 2 Sep 04 22:36:07 rpi5-mhs35 kernel: device offline error, dev sda, sector 9662736 op 0x1:(WRITE) flags 0x3000 phys_seg 1 prio class 2 Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on dev sda3, logical block 524322, lost async page write Sep 04 22:36:07 rpi5-mhs35 kernel: Aborting journal on device sda3-8. Sep 04 22:36:07 rpi5-mhs35 kernel: device offline error, dev sda, sector 14118912 op 0x1:(WRITE) flags 0x800 phys_seg 1 prio class 2 Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on dev sda3, logical block 1081344, lost sync page write Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on dev sda3, logical block 525501, lost async page write Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on dev sda3, logical block 525502, lost async page write Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on dev sda3, logical block 525503, lost async page write Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on dev sda3, logical block 527259, lost async page write Sep 04 22:36:07 rpi5-mhs35 kernel: JBD2: I/O error when updating journal superblock for sda3-8. Sep 04 22:36:07 rpi5-mhs35 kernel: Buffer I/O error on dev sda3, logical block 532537, lost async page write Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Stopped target Local File Systems. Sep 04 22:36:07 rpi5-mhs35 kernel: usb usb4-port1: over-current change #2 Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: 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/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/41CA-9A8B /dev/disk/by-label/boot /dev/disk/by-partuuid/53ce6763-01 /dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_0101dec7a45f3575501143bc778e7b5655a20a6413156f80d7ffab7d738c324d680e00000000000000000000c2d7f202009d440083558107bc2e18bb-0:0-part1 /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","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/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":"41CA-9A8B","ID_FS_UUID_ENC":"41CA-9A8B","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"5583","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":"53ce6763-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"53ce6763","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_0101dec7a45f3575501143bc778e7b5655a20a6413156f80d7ffab7d738c324d680e00000000000000000000c2d7f202009d440083558107bc2e18bb-0:0","ID_SERIAL_SHORT":"0101dec7a45f3575501143bc778e7b5655a20a6413156f80d7ffab7d738c324d680e00000000000000000000c2d7f202009d440083558107bc2e18bb","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","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":"2957","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"2713318"} Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: 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/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_0101dec7a45f3575501143bc778e7b5655a20a6413156f80d7ffab7d738c324d680e00000000000000000000c2d7f202009d440083558107bc2e18bb-0:0-part2 /dev/disk/by-partuuid/53ce6763-02 /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part2 /dev/disk/by-uuid/0c3a77ec-ae84-4f1b-8028-c61cc251ffe5 /dev/disk/by-label/volumio","DEVNAME":"/dev/sda2","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/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":"0c3a77ec-ae84-4f1b-8028-c61cc251ffe5","ID_FS_UUID_ENC":"0c3a77ec-ae84-4f1b-8028-c61cc251ffe5","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"5583","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":"53ce6763-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"53ce6763","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_0101dec7a45f3575501143bc778e7b5655a20a6413156f80d7ffab7d738c324d680e00000000000000000000c2d7f202009d440083558107bc2e18bb-0:0","ID_SERIAL_SHORT":"0101dec7a45f3575501143bc778e7b5655a20a6413156f80d7ffab7d738c324d680e00000000000000000000c2d7f202009d440083558107bc2e18bb","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","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":"2958","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"2711639"} Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: 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/sda/sda3","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_0101dec7a45f3575501143bc778e7b5655a20a6413156f80d7ffab7d738c324d680e00000000000000000000c2d7f202009d440083558107bc2e18bb-0:0-part3 /dev/disk/by-label/volumio_data /dev/disk/by-uuid/9e1ef924-a4f0-4b35-83c7-11ef0e9e7a02 /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part3 /dev/disk/by-partuuid/53ce6763-03","DEVNAME":"/dev/sda3","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/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":"9e1ef924-a4f0-4b35-83c7-11ef0e9e7a02","ID_FS_UUID_ENC":"9e1ef924-a4f0-4b35-83c7-11ef0e9e7a02","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"5583","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":"24611919","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"53ce6763-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"53ce6763","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_0101dec7a45f3575501143bc778e7b5655a20a6413156f80d7ffab7d738c324d680e00000000000000000000c2d7f202009d440083558107bc2e18bb-0:0","ID_SERIAL_SHORT":"0101dec7a45f3575501143bc778e7b5655a20a6413156f80d7ffab7d738c324d680e00000000000000000000c2d7f202009d440083558107bc2e18bb","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","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":"2959","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"2710319"} Sep 04 22:36:07 rpi5-mhs35 systemd[3843]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3843]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131112: comm (umount): reading directory lblock 0 Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 systemd[3844]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3844]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131112: comm (umount): reading directory lblock 0 Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 systemd[3845]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131112: comm (umount): reading directory lblock 0 Sep 04 22:36:07 rpi5-mhs35 systemd[3845]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 systemd[3847]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3847]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 systemd[3848]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131112: comm (umount): reading directory lblock 0 Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131112: comm (umount): reading directory lblock 0 Sep 04 22:36:07 rpi5-mhs35 systemd[3848]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 kernel: usb usb1-port1: over-current change #2 Sep 04 22:36:07 rpi5-mhs35 systemd[3849]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3849]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131112: comm (umount): reading directory lblock 0 Sep 04 22:36:07 rpi5-mhs35 systemd[3850]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[3850]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131112: comm (umount): reading directory lblock 0 Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[3851]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3851]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131112: comm (umount): reading directory lblock 0 Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs error (device sda3): ext4_journal_check_start:83: comm chromium-browse: Detected aborted journal Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs (sda3): Remounting filesystem read-only Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[3853]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3853]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131112: comm (umount): reading directory lblock 0 Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[3854]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3854]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[3855]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3855]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[3856]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3856]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[3857]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3857]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[3858]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3858]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 systemd[3859]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3859]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 systemd[3860]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3860]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device. Stopping, too. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Unmounting /boot... Sep 04 22:36:07 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:07 rpi5-mhs35 systemd[3861]: boot.mount: Failed to execute command: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[3861]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Failed unmounting /boot. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-41CA\x2d9A8B.device, but not stopping since we tried this too often recently. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: systemd-fsck@dev-disk-by\x2duuid-41CA\x2d9A8B.service: Succeeded. Sep 04 22:36:07 rpi5-mhs35 systemd[1]: Stopped File System Check on /dev/disk/by-uuid/41CA-9A8B. Sep 04 22:36:07 rpi5-mhs35 kernel: usb usb3-port1: over-current change #1 Sep 04 22:36:07 rpi5-mhs35 kernel: usb usb2-port1: over-current change #2 Sep 04 22:36:07 rpi5-mhs35 wpa_supplicant[3236]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:36:07 rpi5-mhs35 kernel: usb 3-2: new high-speed USB device number 2 using xhci-hcd Sep 04 22:36:07 rpi5-mhs35 kernel: usb 2-1: new SuperSpeed USB device number 3 using xhci-hcd Sep 04 22:36:07 rpi5-mhs35 kernel: usb 2-1: New USB device found, idVendor=0781, idProduct=5583, bcdDevice= 1.00 Sep 04 22:36:07 rpi5-mhs35 kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Sep 04 22:36:07 rpi5-mhs35 kernel: usb 2-1: Product: SanDisk 3.2Gen1 Sep 04 22:36:07 rpi5-mhs35 kernel: usb 2-1: Manufacturer: USB Sep 04 22:36:07 rpi5-mhs35 kernel: usb 2-1: SerialNumber: 0101dec7a45f3575501143bc778e7b5655a20a6413156f80d7ffab7d738c324d680e00000000000000000000c2d7f202009d440083558107bc2e18bb Sep 04 22:36:07 rpi5-mhs35 kernel: usb-storage 2-1:1.0: USB Mass Storage device detected Sep 04 22:36:07 rpi5-mhs35 kernel: scsi host1: usb-storage 2-1:1.0 Sep 04 22:36:07 rpi5-mhs35 kernel: usb 3-2: New USB device found, idVendor=2772, idProduct=0230, bcdDevice= 2.12 Sep 04 22:36:07 rpi5-mhs35 kernel: usb 3-2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Sep 04 22:36:07 rpi5-mhs35 kernel: usb 3-2: Product: Pre Box S2 Digital Sep 04 22:36:07 rpi5-mhs35 kernel: usb 3-2: Manufacturer: Pro-Ject Sep 04 22:36:07 rpi5-mhs35 kernel: input: Pro-Ject Pre Box S2 Digital as /devices/platform/axi/1000120000.pcie/1f00300000.usb/xhci-hcd.1/usb3/3-2/3-2:1.3/0003:2772:0230.0001/input/input4 Sep 04 22:36:07 rpi5-mhs35 kernel: hid-generic 0003:2772:0230.0001: input,hidraw0: USB HID v1.10 Device [Pro-Ject Pre Box S2 Digital] on usb-xhci-hcd.1-2/input3 Sep 04 22:36:08 rpi5-mhs35 kernel: usb 3-2: 1:2 : unsupported format bits 0x100000000 Sep 04 22:36:08 rpi5-mhs35 kernel: usbcore: registered new interface driver snd-usb-audio Sep 04 22:36:08 rpi5-mhs35 systemd-udevd[3841]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: ---------------------------- USB Audio Device Attached Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::Close All Modals sent Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Preparing to save Alsa Options, stopping services first Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetState Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPause Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pause Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"Pre Box S2 Digital","alsacard":"Digital"},"i2s":false} Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Setting mixer Pre Box S2 Digital for card Pre Box S2 Digital Sep 04 22:36:08 rpi5-mhs35 vtcs[2867]: [2024-09-04 22:36:08.250] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Sep 04 22:36:08 rpi5-mhs35 vtcs[2867]: [2024-09-04 22:36:08.250] [tisoc] [error] [SpkconServer.cpp:473] socket write error. fd=3 errorno=32 error=Broken pipe Sep 04 22:36:08 rpi5-mhs35 vtcs[2867]: [2024-09-04 22:36:08.250] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Sep 04 22:36:08 rpi5-mhs35 sudo[3886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 22:36:08 rpi5-mhs35 sudo[3886]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:08 rpi5-mhs35 systemd[1]: Stopping Volumio Tidal Connect Service... Sep 04 22:36:08 rpi5-mhs35 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Sep 04 22:36:08 rpi5-mhs35 systemd[1]: vtcs.service: Succeeded. Sep 04 22:36:08 rpi5-mhs35 systemd[1]: Stopped Volumio Tidal Connect Service. Sep 04 22:36:08 rpi5-mhs35 sudo[3886]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Updating Volume Controller Parameters: Device: 5 Name: Pre Box S2 Digital Mixer: Pre Box S2 Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Disabling external Volume Control Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Preparing to generate the ALSA configuration file Sep 04 22:36:08 rpi5-mhs35 systemd[1]: Failed to propagate reload, ignoring: No such file or directory Sep 04 22:36:08 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #159977: lblock 0: comm node: error -5 reading directory block Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: warn: Unable to scan plugin peppy_screensaver for ALSA configuration: Error: EIO: i/o error, scandir '/data/plugins//user_interface/peppy_screensaver/asound' Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:08 rpi5-mhs35 sudo[3893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 22:36:08 rpi5-mhs35 sudo[3893]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:08 rpi5-mhs35 sudo[3893]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: VolumeController:: Volume=100 Mute =false Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: error: Cannot write /etc/asound.conf: Error: EROFS: read-only file system, open '/home/volumio/.asoundrc' Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Output device has changed, restarting MPD Sep 04 22:36:08 rpi5-mhs35 sudo[3902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 22:36:08 rpi5-mhs35 sudo[3902]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:08 rpi5-mhs35 sudo[3902]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Output device has changed, restarting Shairport Sync Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:36:08 rpi5-mhs35 sudo[3905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 22:36:08 rpi5-mhs35 sudo[3905]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:08 rpi5-mhs35 systemd[1]: Stopping Music Player Daemon... Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 sudo[3913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 22:36:08 rpi5-mhs35 sudo[3913]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:08 rpi5-mhs35 sudo[3916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 22:36:08 rpi5-mhs35 sudo[3916]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Error setting mpd conf file perms: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/mpd.conf Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: /bin/chmod: changing permissions of '/etc/mpd.conf': Read-only file system Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 sudo[3913]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:08 rpi5-mhs35 sudo[3916]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Could not write mpd.conf:Error: EROFS: read-only file system, open '/etc/mpd.conf' Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: error: Could Not Write Alsa Configuration File: Error: EROFS: read-only file system, open '/data/configuration/audio_interface/multiroom/asound/volumioMultiRoomServer.postMultiRoom.1000.conf' Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Starting Shairport Sync Sep 04 22:36:08 rpi5-mhs35 systemd[1]: mpd.service: Succeeded. Sep 04 22:36:08 rpi5-mhs35 sudo[3925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 22:36:08 rpi5-mhs35 systemd[1]: Stopped Music Player Daemon. Sep 04 22:36:08 rpi5-mhs35 sudo[3925]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 22:36:08 rpi5-mhs35 systemd[1]: Starting Music Player Daemon... Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:08 rpi5-mhs35 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 22:36:08 rpi5-mhs35 systemd[1]: shairport-sync.service: Succeeded. Sep 04 22:36:08 rpi5-mhs35 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 22:36:08 rpi5-mhs35 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 22:36:08 rpi5-mhs35 sudo[3925]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Shairport-Sync Started Sep 04 22:36:08 rpi5-mhs35 sudo[3927]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 22:36:08 rpi5-mhs35 sudo[3927]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:08 rpi5-mhs35 sudo[3927]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:08 rpi5-mhs35 mpd[3933]: Sep 04 22:36 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Sep 04 22:36:08 rpi5-mhs35 kernel: scsi 1:0:0:0: Direct-Access USB SanDisk 3.2Gen1 1.00 PQ: 0 ANSI: 6 Sep 04 22:36:08 rpi5-mhs35 kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0 Sep 04 22:36:08 rpi5-mhs35 kernel: sd 1:0:0:0: [sdb] 30081024 512-byte logical blocks: (15.4 GB/14.3 GiB) Sep 04 22:36:08 rpi5-mhs35 kernel: sd 1:0:0:0: [sdb] Write Protect is off Sep 04 22:36:08 rpi5-mhs35 kernel: sd 1:0:0:0: [sdb] Mode Sense: 43 00 00 00 Sep 04 22:36:08 rpi5-mhs35 kernel: sd 1:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Sep 04 22:36:08 rpi5-mhs35 kernel: sdb: sdb1 sdb2 sdb3 Sep 04 22:36:08 rpi5-mhs35 kernel: sd 1:0:0:0: [sdb] Attached SCSI removable disk Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Ignoring mount for partition: volumio_data Sep 04 22:36:08 rpi5-mhs35 volumio[1182]: info: Ignoring mount for partition: volumio Sep 04 22:36:09 rpi5-mhs35 volumio[1182]: info: Ignoring mount for partition: boot Sep 04 22:36:09 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 22:36:09 rpi5-mhs35 volumio[1182]: error: MPD error: Error: This socket has been ended by the other party Sep 04 22:36:09 rpi5-mhs35 volumio[1182]: error: This socket has been ended by the other party {"code":"EPIPE"} Sep 04 22:36:09 rpi5-mhs35 volumio[1182]: error: MPD error: Error: This socket has been ended by the other party Sep 04 22:36:09 rpi5-mhs35 volumio[1182]: error: This socket has been ended by the other party {"code":"EPIPE"} Sep 04 22:36:09 rpi5-mhs35 volumio[1182]: error: MPD error: Error: This socket has been ended by the other party Sep 04 22:36:09 rpi5-mhs35 volumio[1182]: error: This socket has been ended by the other party {"code":"EPIPE"} Sep 04 22:36:09 rpi5-mhs35 volumio[1182]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/audio_interface/alsa_controller/config.json' Sep 04 22:36:09 rpi5-mhs35 systemd[1]: Started Music Player Daemon. Sep 04 22:36:09 rpi5-mhs35 sudo[3905]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:09 rpi5-mhs35 volumio[1182]: error: updateQueue error: null Sep 04 22:36:10 rpi5-mhs35 nmbd[3937]: [2024/09/04 22:36:10.455293, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Sep 04 22:36:10 rpi5-mhs35 nmbd[3937]: wins_write_database: Can't open /var/lib/samba/wins.dat.3937: Read-only file system Sep 04 22:36:10 rpi5-mhs35 kernel: usb 4-1: new SuperSpeed USB device number 2 using xhci-hcd Sep 04 22:36:10 rpi5-mhs35 kernel: usb 4-1: New USB device found, idVendor=0bc2, idProduct=2344, bcdDevice= 7.12 Sep 04 22:36:10 rpi5-mhs35 kernel: usb 4-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Sep 04 22:36:10 rpi5-mhs35 kernel: usb 4-1: Product: Portable Sep 04 22:36:10 rpi5-mhs35 kernel: usb 4-1: Manufacturer: Seagate Sep 04 22:36:10 rpi5-mhs35 kernel: usb 4-1: SerialNumber: NT36K1C0 Sep 04 22:36:10 rpi5-mhs35 kernel: scsi host2: uas Sep 04 22:36:10 rpi5-mhs35 kernel: scsi 2:0:0:0: Direct-Access Seagate Portable 0712 PQ: 0 ANSI: 6 Sep 04 22:36:10 rpi5-mhs35 kernel: sd 2:0:0:0: Attached scsi generic sg1 type 0 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: TidalConnect service stoped! Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: TidalConnect service stoped! Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Sep 04 22:36:11 rpi5-mhs35 sudo[3949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Sep 04 22:36:11 rpi5-mhs35 sudo[3949]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:11 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: Started Volumio Tidal Connect Service. Sep 04 22:36:11 rpi5-mhs35 sudo[3949]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: TidalConnect service stoped! Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: Executing endpoint tc_getconfig Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: TidalConnect service stoped! Sep 04 22:36:11 rpi5-mhs35 vtcs[3951]: STARTING TidalConnect services, version: 1.4.0.34 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Sep 04 22:36:11 rpi5-mhs35 vtcs[3951]: STARTED TidalConnect services. Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: Executing endpoint tc_connect Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: Connecting to TidalConnect Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::servicePushState Sep 04 22:36:11 rpi5-mhs35 sudo[3971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Sep 04 22:36:11 rpi5-mhs35 sudo[3971]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: verbose: CURRENT POSITION 0 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState stateService stop Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState currentStatus stop Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:11 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: No code Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:11 rpi5-mhs35 sudo[3971]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::servicePushState Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: verbose: CURRENT POSITION 0 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState stateService stop Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState currentStatus stop Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: No code Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:11 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::getcurrentVolume Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioRetrievevolume Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: VolumeController:: Volume=100 Mute =false Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::updateTrackBlock Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrackBlock Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioRetrievevolume Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: VolumeController:: Volume=100 Mute =false Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:12 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:13 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 22:36:13 rpi5-mhs35 wpa_supplicant[3236]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:36:14 rpi5-mhs35 volumio[1182]: info: TidalConnect service started! Sep 04 22:36:14 rpi5-mhs35 volumio[1182]: info: TidalConnect service started! Sep 04 22:36:17 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 22:36:17 rpi5-mhs35 kernel: sd 2:0:0:0: [sdc] 9767541167 512-byte logical blocks: (5.00 TB/4.55 TiB) Sep 04 22:36:17 rpi5-mhs35 kernel: sd 2:0:0:0: [sdc] 4096-byte physical blocks Sep 04 22:36:17 rpi5-mhs35 kernel: sd 2:0:0:0: [sdc] Write Protect is off Sep 04 22:36:17 rpi5-mhs35 kernel: sd 2:0:0:0: [sdc] Mode Sense: 53 00 00 08 Sep 04 22:36:17 rpi5-mhs35 kernel: sd 2:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Sep 04 22:36:17 rpi5-mhs35 kernel: sd 2:0:0:0: [sdc] Preferred minimum I/O size 4096 bytes Sep 04 22:36:17 rpi5-mhs35 kernel: sd 2:0:0:0: [sdc] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes) Sep 04 22:36:17 rpi5-mhs35 kernel: sdc: sdc1 sdc2 Sep 04 22:36:17 rpi5-mhs35 kernel: sd 2:0:0:0: [sdc] Attached SCSI disk Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs error: 18 callbacks suppressed Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #132147: comm (spawn): reading directory lblock 0 Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131226: comm systemd: reading directory lblock 0 Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131226: comm systemd: reading directory lblock 0 Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131226: comm systemd: reading directory lblock 0 Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131226: comm systemd: reading directory lblock 0 Sep 04 22:36:17 rpi5-mhs35 volumio[1182]: error: Cannot associate FS Label, not mounting Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131226: comm systemd: reading directory lblock 0 Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131226: comm systemd: reading directory lblock 0 Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131226: comm systemd: reading directory lblock 0 Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131226: comm systemd: reading directory lblock 0 Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131226: comm systemd: reading directory lblock 0 Sep 04 22:36:17 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #132535: lblock 0: comm sh: error -5 reading directory block Sep 04 22:36:17 rpi5-mhs35 volumio[1182]: /bin/sh: 1: lsblk: Input/output error Sep 04 22:36:17 rpi5-mhs35 volumio[1182]: /bin/sh: 1: /bin/lsblk: Input/output error Sep 04 22:36:17 rpi5-mhs35 volumio[1182]: error: Failed USB identification: Error: Command failed: /bin/lsblk -rno tran "/dev/$(lsblk -rno PKNAME /dev/sdc2)" Sep 04 22:36:17 rpi5-mhs35 volumio[1182]: /bin/sh: 1: lsblk: Input/output error Sep 04 22:36:17 rpi5-mhs35 volumio[1182]: /bin/sh: 1: /bin/lsblk: Input/output error Sep 04 22:36:17 rpi5-mhs35 volumio[1182]: info: Ignoring mount for partition: Music Sep 04 22:36:19 rpi5-mhs35 wpa_supplicant[3236]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: ControllerMpd::sendMpdCommand rescan Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: ControllerMpd::sendMpdCommand status Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: ---------------------------- MPD announces state update: update Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: sendMpdCommand rescan took 7 milliseconds Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: ControllerMpd::getState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: ControllerMpd::sendMpdCommand status Sep 04 22:36:20 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #155178: lblock 0: comm update: error -5 reading directory block Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: MPD Database updated - AlbumList cache refreshed Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: ---------------------------- MPD announces state update: database Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: ControllerMpd::sendMpdCommand status Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: ---------------------------- MPD announces state update: update Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: ControllerMpd::getState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: ControllerMpd::sendMpdCommand status Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: ControllerMpd::getState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: ControllerMpd::sendMpdCommand status Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: sendMpdCommand status took 449 milliseconds Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: sendMpdCommand status took 448 milliseconds Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: ControllerMpd::parseState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: Command Router : Notfying DB Updatefalse Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::Close All Modals sent Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: ControllerMpd::parseState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: ControllerMpd::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::servicePushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: CURRENT POSITION 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState stateService stop Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState currentStatus stop Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: No code Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: ------------------------------ 476ms Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: sendMpdCommand status took 32 milliseconds Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: sendMpdCommand status took 32 milliseconds Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: sendMpdCommand status took 32 milliseconds Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: ControllerMpd::parseState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: Command Router : Notfying DB Updatefalse Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::Close All Modals sent Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: ControllerMpd::parseState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: ControllerMpd::parseState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: ControllerMpd::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::servicePushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: CURRENT POSITION 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState stateService stop Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState currentStatus stop Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: No code Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: ControllerMpd::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::servicePushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: verbose: CURRENT POSITION 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState stateService stop Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState currentStatus stop Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: No code Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: ------------------------------ 74ms Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: info: ------------------------------ 75ms Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:20 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:21 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 22:36:23 rpi5-mhs35 nmbd[4039]: [2024/09/04 22:36:23.052458, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Sep 04 22:36:23 rpi5-mhs35 nmbd[4039]: wins_write_database: Can't open /var/lib/samba/wins.dat.4039: Read-only file system Sep 04 22:36:24 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetState Sep 04 22:36:24 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 04 22:36:25 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 22:36:25 rpi5-mhs35 wpa_supplicant[3236]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Preparing to save Alsa Options, stopping services first Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetState Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPause Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pause Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Pre Box S2 Digital"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Setting mixer Pre Box S2 Digital for card Pre Box S2 Digital Sep 04 22:36:29 rpi5-mhs35 vtcs[3951]: [2024-09-04 22:36:29.461] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Sep 04 22:36:29 rpi5-mhs35 vtcs[3951]: [2024-09-04 22:36:29.462] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Sep 04 22:36:29 rpi5-mhs35 sudo[4052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 22:36:29 rpi5-mhs35 sudo[4052]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:29 rpi5-mhs35 systemd[1]: Stopping Volumio Tidal Connect Service... Sep 04 22:36:29 rpi5-mhs35 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Sep 04 22:36:29 rpi5-mhs35 systemd[1]: vtcs.service: Succeeded. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: Stopped Volumio Tidal Connect Service. Sep 04 22:36:29 rpi5-mhs35 sudo[4052]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Updating Volume Controller Parameters: Device: 5 Name: Pre Box S2 Digital Mixer: Pre Box S2 Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Disabling external Volume Control Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Preparing to generate the ALSA configuration file Sep 04 22:36:29 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #159977: lblock 0: comm node: error -5 reading directory block Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: warn: Unable to scan plugin peppy_screensaver for ALSA configuration: Error: EIO: i/o error, scandir '/data/plugins//user_interface/peppy_screensaver/asound' Sep 04 22:36:29 rpi5-mhs35 sudo[4059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 22:36:29 rpi5-mhs35 sudo[4059]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:29 rpi5-mhs35 sudo[4059]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: VolumeController:: Volume=100 Mute =false Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: error: Cannot write /etc/asound.conf: Error: EROFS: read-only file system, open '/home/volumio/.asoundrc' Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Output device has changed, restarting MPD Sep 04 22:36:29 rpi5-mhs35 sudo[4068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 22:36:29 rpi5-mhs35 sudo[4068]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:29 rpi5-mhs35 sudo[4068]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Output device has changed, restarting Shairport Sync Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:36:29 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #150011: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Sep 04 22:36:29 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #150011: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Sep 04 22:36:29 rpi5-mhs35 sudo[4071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 22:36:29 rpi5-mhs35 sudo[4071]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:29 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: Stopping Music Player Daemon... Sep 04 22:36:29 rpi5-mhs35 systemd[1]: mpd.service: Succeeded. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: Stopped Music Player Daemon. Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:29 rpi5-mhs35 systemd[1]: Starting Music Player Daemon... Sep 04 22:36:29 rpi5-mhs35 sudo[4083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 22:36:29 rpi5-mhs35 sudo[4083]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:29 rpi5-mhs35 sudo[4081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:29 rpi5-mhs35 sudo[4081]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Error setting mpd conf file perms: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/mpd.conf Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: /bin/chmod: changing permissions of '/etc/mpd.conf': Read-only file system Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:29 rpi5-mhs35 sudo[4083]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:36:29 rpi5-mhs35 sudo[4081]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:29 rpi5-mhs35 sudo[4077]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 22:36:29 rpi5-mhs35 sudo[4077]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Could not write mpd.conf:Error: EROFS: read-only file system, open '/etc/mpd.conf' Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: error: Could Not Write Alsa Configuration File: Error: EROFS: read-only file system, open '/data/configuration/audio_interface/multiroom/asound/volumioMultiRoomServer.postMultiRoom.1000.conf' Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Starting Shairport Sync Sep 04 22:36:29 rpi5-mhs35 sudo[4077]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:29 rpi5-mhs35 sudo[4095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 22:36:29 rpi5-mhs35 sudo[4095]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:29 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 22:36:29 rpi5-mhs35 systemd[1]: shairport-sync.service: Succeeded. Sep 04 22:36:29 rpi5-mhs35 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 22:36:29 rpi5-mhs35 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 22:36:29 rpi5-mhs35 sudo[4095]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: info: Shairport-Sync Started Sep 04 22:36:29 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #150011: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Sep 04 22:36:29 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #150011: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Sep 04 22:36:29 rpi5-mhs35 kernel: blk_print_req_error: 3 callbacks suppressed Sep 04 22:36:29 rpi5-mhs35 kernel: I/O error, dev loop0, sector 918522 op 0x0:(READ) flags 0x800 phys_seg 17 prio class 2 Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Failed to read block 0x1c07f44c: -5 Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read fragment cache entry [1c07f44c] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read fragment cache entry [1c07f44c] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1c07f44c, size 102de Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Sep 04 22:36:29 rpi5-mhs35 kernel: I/O error, dev loop0, sector 888026 op 0x0:(READ) flags 0x800 phys_seg 33 prio class 2 Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Failed to read block 0x1b19b75b: -5 Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: Error: EIO: i/o error, read Sep 04 22:36:29 rpi5-mhs35 kernel: I/O error, dev loop0, sector 888282 op 0x0:(READ) flags 0x800 phys_seg 33 prio class 2 Sep 04 22:36:29 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #150011: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Sep 04 22:36:29 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #150011: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Failed to read block 0x1b1bb75b: -5 Sep 04 22:36:29 rpi5-mhs35 kernel: I/O error, dev loop0, sector 888538 op 0x0:(READ) flags 0x800 phys_seg 23 prio class 2 Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Failed to read block 0x1b1db75b: -5 Sep 04 22:36:29 rpi5-mhs35 kernel: I/O error, dev loop0, sector 888026 op 0x0:(READ) flags 0x800 phys_seg 33 prio class 2 Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Failed to read block 0x1b19b75b: -5 Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Sep 04 22:36:29 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #150011: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Sep 04 22:36:29 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #150011: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Sep 04 22:36:29 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): dx_probe:822: inode #150011: lblock 0: comm ThreadPoolForeg: error -5 reading directory block Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read fragment cache entry [1c07f44c] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read fragment cache entry [1c07f44c] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1c07f44c, size 102de Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: Error: EIO: i/o error, read Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read fragment cache entry [1c07f44c] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read fragment cache entry [1c07f44c] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1c07f44c, size 102de Sep 04 22:36:29 rpi5-mhs35 volumio[1182]: Error: EIO: i/o error, read Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:29 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:30 rpi5-mhs35 mpd[4093]: Sep 04 22:36 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 04 22:36:30 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:30 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:30 rpi5-mhs35 volumio[1182]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/audio_interface/alsa_controller/config.json' Sep 04 22:36:30 rpi5-mhs35 systemd[1]: Started Music Player Daemon. Sep 04 22:36:30 rpi5-mhs35 sudo[4071]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:30 rpi5-mhs35 volumio[1182]: error: updateQueue error: null Sep 04 22:36:31 rpi5-mhs35 wpa_supplicant[3236]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: TidalConnect service stoped! Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: TidalConnect service stoped! Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Sep 04 22:36:32 rpi5-mhs35 sudo[4111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Sep 04 22:36:32 rpi5-mhs35 sudo[4111]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:32 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: Started Volumio Tidal Connect Service. Sep 04 22:36:32 rpi5-mhs35 sudo[4111]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: Executing endpoint tc_getconfig Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Sep 04 22:36:32 rpi5-mhs35 vtcs[4113]: STARTING TidalConnect services, version: 1.4.0.34 Sep 04 22:36:32 rpi5-mhs35 vtcs[4113]: STARTED TidalConnect services. Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: Executing endpoint tc_connect Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: Connecting to TidalConnect Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::servicePushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: verbose: CURRENT POSITION 0 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState stateService stop Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState currentStatus stop Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: No code Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::servicePushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: verbose: CURRENT POSITION 0 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState stateService stop Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState currentStatus stop Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: No code Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: TidalConnect service stoped! Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: TidalConnect service stoped! Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Sep 04 22:36:32 rpi5-mhs35 volumio[1182]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Sep 04 22:36:32 rpi5-mhs35 sudo[4141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Sep 04 22:36:32 rpi5-mhs35 sudo[4141]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:32 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:32 rpi5-mhs35 sudo[4141]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Sep 04 22:36:33 rpi5-mhs35 sudo[4145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 22:36:33 rpi5-mhs35 sudo[4145]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:33 rpi5-mhs35 sudo[4145]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: Error setting mpd conf file perms: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/mpd.conf Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: /bin/chmod: changing permissions of '/etc/mpd.conf': Read-only file system Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:33 rpi5-mhs35 sudo[4148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 22:36:33 rpi5-mhs35 sudo[4148]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: Could not write mpd.conf:Error: EROFS: read-only file system, open '/etc/mpd.conf' Sep 04 22:36:33 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:33 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:33 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:33 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:33 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:33 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:33 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:33 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:33 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:33 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:33 rpi5-mhs35 systemd[1]: Stopping Music Player Daemon... Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:33 rpi5-mhs35 systemd[1]: mpd.service: Succeeded. Sep 04 22:36:33 rpi5-mhs35 systemd[1]: Stopped Music Player Daemon. Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 22:36:33 rpi5-mhs35 systemd[1]: Starting Music Player Daemon... Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:33 rpi5-mhs35 sudo[4154]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 22:36:33 rpi5-mhs35 sudo[4154]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:33 rpi5-mhs35 sudo[4154]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::getcurrentVolume Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioRetrievevolume Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: VolumeController:: Volume=100 Mute =false Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::updateTrackBlock Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrackBlock Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioRetrievevolume Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: VolumeController:: Volume=100 Mute =false Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:33 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:33 rpi5-mhs35 mpd[4157]: Sep 04 22:36 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 04 22:36:34 rpi5-mhs35 systemd[1]: Started Music Player Daemon. Sep 04 22:36:34 rpi5-mhs35 sudo[4148]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:34 rpi5-mhs35 volumio[1182]: error: updateQueue error: null Sep 04 22:36:34 rpi5-mhs35 volumio[1182]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/music_service/mpd/config.json' Sep 04 22:36:35 rpi5-mhs35 volumio[1182]: info: TidalConnect service started! Sep 04 22:36:35 rpi5-mhs35 volumio[1182]: info: TidalConnect service started! Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetState Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: Restoring Previous Volume level: 100 false false Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: Volume configurations have been set Sep 04 22:36:36 rpi5-mhs35 vtcs[4113]: [2024-09-04 22:36:36.013] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Sep 04 22:36:36 rpi5-mhs35 vtcs[4113]: [2024-09-04 22:36:36.013] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Sep 04 22:36:36 rpi5-mhs35 sudo[4165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 22:36:36 rpi5-mhs35 sudo[4165]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:36 rpi5-mhs35 systemd[1]: Stopping Volumio Tidal Connect Service... Sep 04 22:36:36 rpi5-mhs35 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Sep 04 22:36:36 rpi5-mhs35 systemd[1]: vtcs.service: Succeeded. Sep 04 22:36:36 rpi5-mhs35 systemd[1]: Stopped Volumio Tidal Connect Service. Sep 04 22:36:36 rpi5-mhs35 sudo[4165]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: Updating Volume Controller Parameters: Device: 5 Name: Pre Box S2 Digital Mixer: Pre Box S2 Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: Disabling external Volume Control Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 22:36:36 rpi5-mhs35 sudo[4172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 22:36:36 rpi5-mhs35 sudo[4172]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:36 rpi5-mhs35 sudo[4172]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: VolumeController:: Volume=100 Mute =false Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:36 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:37 rpi5-mhs35 volumio[1182]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/audio_interface/alsa_controller/config.json' Sep 04 22:36:37 rpi5-mhs35 wpa_supplicant[3236]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: TidalConnect service stoped! Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: TidalConnect service stoped! Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Sep 04 22:36:39 rpi5-mhs35 sudo[4189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Sep 04 22:36:39 rpi5-mhs35 sudo[4189]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:36:39 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:39 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:39 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:39 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:39 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:39 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:39 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:39 rpi5-mhs35 systemd[1]: sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device: Cannot add dependency job, ignoring: Unit sys-devices-platform-axi-1000120000.pcie-1f00200000.usb-xhci\x2dhcd.0-usb2-2\x2d1-2\x2d1:1.0-host1-target1:0:0-1:0:0:0-block-sdb-sdb1.device not found. Sep 04 22:36:39 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:39 rpi5-mhs35 systemd[1]: dev-sdb1.device: Cannot add dependency job, ignoring: Unit dev-sdb1.device not found. Sep 04 22:36:39 rpi5-mhs35 systemd[1]: Started Volumio Tidal Connect Service. Sep 04 22:36:39 rpi5-mhs35 sudo[4189]: pam_unix(sudo:session): session closed for user root Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: Executing endpoint tc_getconfig Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Sep 04 22:36:39 rpi5-mhs35 vtcs[4191]: STARTING TidalConnect services, version: 1.4.0.34 Sep 04 22:36:39 rpi5-mhs35 vtcs[4191]: STARTED TidalConnect services. Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: Executing endpoint tc_connect Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: Connecting to TidalConnect Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::servicePushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: verbose: CURRENT POSITION 0 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState stateService stop Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState currentStatus stop Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: No code Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::servicePushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: verbose: CURRENT POSITION 0 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState stateService stop Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::syncState currentStatus stop Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: No code Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetState Sep 04 22:36:39 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: VolumeController::SetAlsaVolume100 Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::pushState Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioPushState Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: Retrieving Cloud Streaming UI Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: Getting Tidal Cloud Configuration Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: Getting Qobuz Cloud Configuration Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: Asking plugin for UI Config Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: Getting Spotify Cloud Configuration Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: Asking plugin for UI Config Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: Saving Spotify Acccount Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: Got it Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: Got Tidal Cloud Configuration Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: Got it Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetBrowseSources Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetBrowseSources Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetBrowseSources Sep 04 22:36:40 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 22:36:41 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 04 22:36:42 rpi5-mhs35 volumio[1182]: info: TidalConnect service started! Sep 04 22:36:45 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 22:36:49 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetState Sep 04 22:36:49 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:36:49 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetQueue Sep 04 22:36:49 rpi5-mhs35 volumio[1182]: info: CoreStateMachine::getQueue Sep 04 22:36:49 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getQueue Sep 04 22:36:49 rpi5-mhs35 wpa_supplicant[3236]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:36:49 rpi5-mhs35 kernel: EXT4-fs error: 842 callbacks suppressed Sep 04 22:36:49 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #154514: comm node: reading directory lblock 0 Sep 04 22:36:49 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131347: comm node: reading directory lblock 0 Sep 04 22:36:49 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #151498: comm node: reading directory lblock 0 Sep 04 22:36:49 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131347: comm node: reading directory lblock 0 Sep 04 22:36:49 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #150759: comm node: reading directory lblock 0 Sep 04 22:36:49 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131347: comm node: reading directory lblock 0 Sep 04 22:36:50 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #150014: comm ThreadPoolForeg: reading directory lblock 0 Sep 04 22:36:50 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 22:36:50 rpi5-mhs35 volumio[1182]: info: CURURI: music-library Sep 04 22:36:50 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131167: comm node: reading directory lblock 0 Sep 04 22:36:50 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131168: comm node: reading directory lblock 0 Sep 04 22:36:50 rpi5-mhs35 volumio[1182]: info: Preload queue cleared Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: info: CURURI: music-library/USB Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, scandir '/mnt/USB/Music' Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: at Object.readdirSync (fs.js:1021:3) Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: at searchInFolder (/volumio/app/plugins/miscellanea/albumart/albumart.js:250:20) Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: at processRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:386:11) Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: at processExpressRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:437:17) Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: at /volumio/node_modules/express/lib/router/index.js:281:22 Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Sep 04 22:36:52 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131167: comm node: reading directory lblock 0 Sep 04 22:36:52 rpi5-mhs35 kernel: EXT4-fs warning: 21 callbacks suppressed Sep 04 22:36:52 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #155178: lblock 0: comm node: error -5 reading directory block Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: Error: EIO: i/o error, read Sep 04 22:36:52 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:52 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:52 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:52 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:52 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:52 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:52 rpi5-mhs35 volumio[1182]: info: Preload queue cleared Sep 04 22:36:53 rpi5-mhs35 nmbd[4211]: [2024/09/04 22:36:53.082388, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Sep 04 22:36:53 rpi5-mhs35 nmbd[4211]: wins_write_database: Can't open /var/lib/samba/wins.dat.4211: Read-only file system Sep 04 22:36:53 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 22:36:53 rpi5-mhs35 volumio[1182]: info: CURURI: music-library/USB/Music Sep 04 22:36:53 rpi5-mhs35 volumio[1182]: info: Preload queue cleared Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs error: 93 callbacks suppressed Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131167: comm node: reading directory lblock 0 Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #131168: comm node: reading directory lblock 0 Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #155178: comm node: reading directory lblock 0 Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #155178: comm node: reading directory lblock 0 Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #155178: comm node: reading directory lblock 0 Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #155178: comm node: reading directory lblock 0 Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, scandir '/mnt/USB/Music' Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at Object.readdirSync (fs.js:1021:3) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at searchInFolder (/volumio/app/plugins/miscellanea/albumart/albumart.js:250:20) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at processRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:386:11) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at processExpressRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:437:17) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at /volumio/node_modules/express/lib/router/index.js:281:22 Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #155178: comm node: reading directory lblock 0 Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #155178: comm node: reading directory lblock 0 Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #155178: comm node: reading directory lblock 0 Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs error (device sda3): __ext4_find_entry:1684: inode #155178: comm node: reading directory lblock 0 Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #155178: lblock 0: comm node: error -5 reading directory block Sep 04 22:36:55 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:55 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: Error: EIO: i/o error, read Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, scandir '/mnt/USB/Music' Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at Object.readdirSync (fs.js:1021:3) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at searchInFolder (/volumio/app/plugins/miscellanea/albumart/albumart.js:250:20) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at processRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:386:11) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at processExpressRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:437:17) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at /volumio/node_modules/express/lib/router/index.js:281:22 Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Sep 04 22:36:55 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #155178: lblock 0: comm node: error -5 reading directory block Sep 04 22:36:55 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:55 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:55 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:55 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:55 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:36:55 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:36:55 rpi5-mhs35 volumio[1182]: Error: EIO: i/o error, read Sep 04 22:36:55 rpi5-mhs35 wpa_supplicant[3236]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:37:01 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetState Sep 04 22:37:01 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:37:01 rpi5-mhs35 wpa_supplicant[3236]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:37:02 rpi5-mhs35 sudo[4213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 22:37:02 rpi5-mhs35 sudo[4213]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:37:02 rpi5-mhs35 sudo[4213]: pam_unix(sudo:session): session closed for user root Sep 04 22:37:02 rpi5-mhs35 sudo[4216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 22:37:02 rpi5-mhs35 sudo[4216]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:37:02 rpi5-mhs35 sudo[4216]: pam_unix(sudo:session): session closed for user root Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: verbose: New Socket.io Connection to 192.168.1.241 from 192.168.1.146 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: Error: EIO: i/o error, read Sep 04 22:37:02 rpi5-mhs35 kernel: I/O error, dev loop0, sector 918522 op 0x0:(READ) flags 0x800 phys_seg 17 prio class 2 Sep 04 22:37:02 rpi5-mhs35 kernel: SQUASHFS error: Failed to read block 0x1c07f44c: -5 Sep 04 22:37:02 rpi5-mhs35 kernel: SQUASHFS error: Unable to read fragment cache entry [1c07f44c] Sep 04 22:37:02 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1c07f44c, size 102de Sep 04 22:37:02 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:37:02 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:37:02 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:37:02 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:37:02 rpi5-mhs35 kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Sep 04 22:37:02 rpi5-mhs35 kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetState Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: info: Received Get System Info Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: info: Discovery: Getting this device information Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetState Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: info: CoreCommandRouter::volumioGetState Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: info: CorePlayQueue::getTrack 0 Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 22:37:02 rpi5-mhs35 kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1082: inode #131174: lblock 0: comm node: error -5 reading directory block Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: Error: EIO: i/o error, scandir '/data/plugins/' Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: at Object.readdirSync (fs.js:1021:3) Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1627:30) Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1521:29) Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1328:45) Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: at Socket.emit (events.js:315:20) Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: errno: -5, Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: syscall: 'scandir', Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: code: 'EIO', Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: path: '/data/plugins/' Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: } Sep 04 22:37:02 rpi5-mhs35 volumio[1182]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 22:37:02 rpi5-mhs35 sudo[4227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 22:36 Sep 04 22:37:02 rpi5-mhs35 sudo[4227]: 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="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"