-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2024-08-19 16:49:53 CEST. --
Aug 19 16:48:25 volumio ntpd[634]: receive: Unexpected origin timestamp 0xea6dd99f.028be944 does not match aorg 0000000000.00000000 from server@193.224.163.77 xmt 0xea6dd9b9.b1ac97f9
Aug 19 16:48:25 volumio ntpd[634]: receive: Unexpected origin timestamp 0xea6dd99f.028a8cc9 does not match aorg 0000000000.00000000 from server@193.227.197.2 xmt 0xea6dd9b9.b23743db
Aug 19 16:48:25 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 19 16:48:25 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 19 16:48:25 volumio volumio[663]: info: Discovery: Getting this device information
Aug 19 16:48:25 volumio volumio[663]: info: CoreCommandRouter::volumioGetState
Aug 19 16:48:25 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 19 16:48:41 volumio kernel: blk_update_request: I/O error, dev mmcblk0, sector 13271501 op 0x1:(WRITE) flags 0x103000 phys_seg 1 prio class 0
Aug 19 16:48:41 volumio kernel: Buffer I/O error on dev mmcblk0p3, logical block 1048586, lost async page write
Aug 19 16:48:41 volumio kernel: mmc0: card aaaa removed
Aug 19 16:48:41 volumio kernel: JBD2: Error while async write back metadata bh 0.
Aug 19 16:48:41 volumio kernel: Aborting journal on device mmcblk0p3-8.
Aug 19 16:48:41 volumio kernel: JBD2: Error -5 detected when updating journal superblock for mmcblk0p3-8.
Aug 19 16:48:41 volumio kernel: JBD2: Error while async write back metadata bh 1.
Aug 19 16:48:41 volumio kernel: JBD2: Error while async write back metadata bh 1048583.
Aug 19 16:48:41 volumio kernel: JBD2: Error while async write back metadata bh 1048584.
Aug 19 16:48:41 volumio kernel: JBD2: Error while async write back metadata bh 1048586.
Aug 19 16:48:41 volumio kernel: JBD2: Error while async write back metadata bh 1048609.
Aug 19 16:48:41 volumio kernel: JBD2: Error while async write back metadata bh 1048613.
Aug 19 16:48:41 volumio volumio[663]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:aaaa/block/mmcblk0/mmcblk0p3","ACTION":"remove","DEVLINKS":"/dev/disk/by-label/volumio_data /dev/disk/by-uuid/485ac937-0923-490c-bddd-166c8ea97aad /dev/disk/by-id/mmc-SC16G_0xb43322e3-part3 /dev/disk/by-partuuid/e43fbe9c-03 /dev/disk/by-path/platform-fe340000.mmc-part3","DEVNAME":"/dev/mmcblk0p3","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:aaaa/block/mmcblk0/mmcblk0p3","DEVTYPE":"partition","ID_FS_LABEL":"volumio_data","ID_FS_LABEL_ENC":"volumio_data","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"485ac937-0923-490c-bddd-166c8ea97aad","ID_FS_UUID_ENC":"485ac937-0923-490c-bddd-166c8ea97aad","ID_FS_VERSION":"1.0","ID_NAME":"SC16G","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"4882813","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"26233475","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"e43fbe9c-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"e43fbe9c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0xb43322e3","MAJOR":"179","MINOR":"3","PARTN":"3","SEQNUM":"1654","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"12715037"}
Aug 19 16:48:41 volumio volumio[663]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:aaaa/block/mmcblk0/mmcblk0p2","ACTION":"remove","DEVLINKS":"/dev/disk/by-label/volumio /dev/disk/by-partuuid/e43fbe9c-02 /dev/disk/by-uuid/e0d264c8-4fb1-49cf-86c5-7376a4451b04 /dev/disk/by-path/platform-fe340000.mmc-part2 /dev/disk/by-id/mmc-SC16G_0xb43322e3-part2","DEVNAME":"/dev/mmcblk0p2","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:aaaa/block/mmcblk0/mmcblk0p2","DEVTYPE":"partition","ID_FS_LABEL":"volumio","ID_FS_LABEL_ENC":"volumio","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"e0d264c8-4fb1-49cf-86c5-7376a4451b04","ID_FS_UUID_ENC":"e0d264c8-4fb1-49cf-86c5-7376a4451b04","ID_FS_VERSION":"1.0","ID_NAME":"SC16G","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"125001","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"4757812","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"e43fbe9c-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"e43fbe9c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0xb43322e3","MAJOR":"179","MINOR":"2","PARTN":"2","SEQNUM":"1655","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"12642961"}
Aug 19 16:48:41 volumio kernel: JBD2: Error while async write back metadata bh 1048614.
Aug 19 16:48:41 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #130049: comm node: reading directory lblock 0
Aug 19 16:48:41 volumio kernel: EXT4-fs (mmcblk0p3): previous I/O error to superblock detected
Aug 19 16:48:41 volumio kernel: EXT4-fs (mmcblk0p3): I/O error while writing superblock
Aug 19 16:48:41 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #130049: comm node: reading directory lblock 0
Aug 19 16:48:41 volumio kernel: EXT4-fs (mmcblk0p3): I/O error while writing superblock
Aug 19 16:48:41 volumio volumio[663]: info: Partition removed: {"syspath":"/sys/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:aaaa/block/mmcblk0/mmcblk0p1","ACTION":"remove","DEVLINKS":"/dev/disk/by-label/boot /dev/disk/by-uuid/BDB5-33A4 /dev/disk/by-path/platform-fe340000.mmc-part1 /dev/disk/by-partuuid/e43fbe9c-01 /dev/disk/by-id/mmc-SC16G_0xb43322e3-part1","DEVNAME":"/dev/mmcblk0p1","DEVPATH":"/devices/platform/emmc2bus/fe340000.mmc/mmc_host/mmc0/mmc0:aaaa/block/mmcblk0/mmcblk0p1","DEVTYPE":"partition","ID_FS_LABEL":"boot","ID_FS_LABEL_ENC":"boot","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"BDB5-33A4","ID_FS_UUID_ENC":"BDB5-33A4","ID_FS_VERSION":"FAT32","ID_NAME":"SC16G","ID_PART_ENTRY_DISK":"179: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":"125000","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"e43fbe9c-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"e43fbe9c","ID_PATH":"platform-fe340000.mmc","ID_PATH_TAG":"platform-fe340000_mmc","ID_SERIAL":"0xb43322e3","MAJOR":"179","MINOR":"1","PARTN":"1","SEQNUM":"1656","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"12604841"}
Aug 19 16:48:41 volumio systemd[1]: Stopped target Local File Systems.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #130049: comm node: reading directory lblock 0
Aug 19 16:48:41 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #260181: comm (umount): reading directory lblock 0
Aug 19 16:48:41 volumio systemd[1182]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1182]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1183]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1183]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #260181: comm (umount): reading directory lblock 0
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1184]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1184]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #260181: comm (umount): reading directory lblock 0
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1185]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1185]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #260181: comm (umount): reading directory lblock 0
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1186]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1186]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #260181: comm (umount): reading directory lblock 0
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1187]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1187]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #260181: comm (umount): reading directory lblock 0
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1188]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1188]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #260181: comm (umount): reading directory lblock 0
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1189]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1189]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1190]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1190]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1191]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1191]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1192]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1192]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1193]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1193]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1194]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1194]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1195]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1195]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1196]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1196]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1197]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1197]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device. Stopping, too.
Aug 19 16:48:41 volumio systemd[1]: Unmounting /boot...
Aug 19 16:48:41 volumio systemd[1198]: boot.mount: Failed to execute command: Input/output error
Aug 19 16:48:41 volumio systemd[1198]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC
Aug 19 16:48:41 volumio systemd[1]: Failed unmounting /boot.
Aug 19 16:48:41 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-mmcblk0p1.device, but not stopping since we tried this too often recently.
Aug 19 16:48:41 volumio systemd[1]: systemd-fsck@dev-mmcblk0p1.service: Succeeded.
Aug 19 16:48:41 volumio systemd[1]: Stopped File System Check on /dev/mmcblk0p1.
Aug 19 16:48:49 volumio kernel: mmc0: new ultra high speed DDR50 SDHC card at address aaaa
Aug 19 16:48:49 volumio kernel: mmcblk0: mmc0:aaaa SC16G 14.8 GiB
Aug 19 16:48:49 volumio kernel: mmcblk0: p1 p2 p3
Aug 19 16:48:49 volumio kernel: debugfs: Directory 'mmcblk0' with parent 'block' already present!
Aug 19 16:48:49 volumio volumio[663]: info: Ignoring mount for partition: boot
Aug 19 16:48:49 volumio volumio[663]: info: Ignoring mount for partition: volumio
Aug 19 16:48:49 volumio volumio[663]: info: Ignoring mount for partition: volumio_data
Aug 19 16:48:55 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 19 16:48:55 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 19 16:48:55 volumio volumio[663]: info: Discovery: Getting this device information
Aug 19 16:48:55 volumio volumio[663]: info: CoreCommandRouter::volumioGetState
Aug 19 16:48:55 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 19 16:48:58 volumio volumio[663]: info:
Aug 19 16:48:58 volumio volumio[663]: ---------------------------- MPD announces system playlist update
Aug 19 16:48:58 volumio volumio[663]: info: Ignoring MPD Status Update
Aug 19 16:48:58 volumio volumio[663]: info:
Aug 19 16:48:58 volumio volumio[663]: ---------------------------- MPD announces state update: player
Aug 19 16:48:58 volumio volumio[663]: info: ControllerMpd::getState
Aug 19 16:48:58 volumio volumio[663]: verbose: ControllerMpd::sendMpdCommand status
Aug 19 16:48:58 volumio volumio[663]: info: ------------------------------ 4ms
Aug 19 16:48:58 volumio volumio[663]: info: sendMpdCommand status took 2 milliseconds
Aug 19 16:48:58 volumio volumio[663]: verbose: ControllerMpd::parseState
Aug 19 16:48:58 volumio volumio[663]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 19 16:48:58 volumio volumio[663]: info: sendMpdCommand playlistinfo took 1 milliseconds
Aug 19 16:48:58 volumio volumio[663]: verbose: ControllerMpd::parseTrackInfo
Aug 19 16:48:58 volumio volumio[663]: info: ControllerMpd::pushState
Aug 19 16:48:58 volumio volumio[663]: info: CoreCommandRouter::servicePushState
Aug 19 16:48:58 volumio volumio[663]: info: CorePlayQueue::getTrack 0
Aug 19 16:48:58 volumio volumio[663]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71240,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"16-Modern Talking - With A Little Love (12 Extended Version)","artist":"Club Music Radio - ITALO DISCO","album":null,"uri":"http://78.46.83.77:8050/stream","trackType":""}
Aug 19 16:48:58 volumio volumio[663]: verbose: CURRENT POSITION 0
Aug 19 16:48:58 volumio volumio[663]: info: CoreStateMachine::syncState stateService play
Aug 19 16:48:58 volumio volumio[663]: info: CoreStateMachine::syncState currentStatus play
Aug 19 16:48:58 volumio volumio[663]: info: Received an update from plugin. extracting info from payload
Aug 19 16:48:58 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Aug 19 16:48:58 volumio volumio[663]: info: CoreStateMachine::pushState
Aug 19 16:48:58 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 19 16:48:58 volumio volumio[663]: info: CoreCommandRouter::volumioPushState
Aug 19 16:48:58 volumio volumio[663]: info: CoreStateMachine::pushState
Aug 19 16:48:58 volumio volumio[663]: info: CoreCommandRouter::volumioPushState
Aug 19 16:48:58 volumio volumio[663]: info: ------------------------------ 27ms
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 19 16:49:07 volumio kernel: EXT4-fs error: 10 callbacks suppressed
Aug 19 16:49:07 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #261222: comm sh: reading directory lblock 0
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Aug 19 16:49:07 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Aug 19 16:49:25 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 19 16:49:25 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 19 16:49:25 volumio volumio[663]: info: Discovery: Getting this device information
Aug 19 16:49:25 volumio volumio[663]: info: CoreCommandRouter::volumioGetState
Aug 19 16:49:25 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 19 16:49:28 volumio volumio[663]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object]
Aug 19 16:49:28 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions
Aug 19 16:49:28 volumio sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 19 16:49:28 volumio sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 19 16:49:28 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:28 volumio kernel: EXT4-fs error (device mmcblk0p3): ext4_journal_check_start:83: Detected aborted journal
Aug 19 16:49:28 volumio kernel: EXT4-fs (mmcblk0p3): Remounting filesystem read-only
Aug 19 16:49:28 volumio kernel: ------------[ cut here ]------------
Aug 19 16:49:28 volumio kernel: WARNING: CPU: 1 PID: 1304 at fs/fs-writeback.c:2309 __mark_inode_dirty+0x3ac/0x42c
Aug 19 16:49:28 volumio kernel: bdi-(unknown) not registered
Aug 19 16:49:28 volumio kernel: Modules linked in: cmac bnep hci_uart btbcm bluetooth ecdh_generic ecc nft_counter nft_chain_nat xt_REDIRECT nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 xt_tcpudp nft_compat nf_tables nfnetlink 8021q garp stp llc snd_usb_audio brcmfmac snd_hwdep snd_usbmidi_lib snd_seq_midi snd_seq_midi_event snd_rawmidi brcmutil cfg80211 bcm2835_codec(C) v4l2_mem2mem snd_bcm2835(C) snd_pcm bcm2835_isp(C) bcm2835_v4l2(C) bcm2835_mmal_vchiq(C) videobuf2_vmalloc rfkill videobuf2_dma_contig videobuf2_memops videobuf2_v4l2 videobuf2_common snd_seq videodev snd_seq_device snd_timer raspberrypi_hwmon snd i2c_bcm2835 mc vc_sm_cma(C) rpivid_mem nvmem_rmem uio_pdrv_genirq uio i2c_dev ip_tables x_tables ipv6 squashfs overlay
Aug 19 16:49:28 volumio kernel: CPU: 1 PID: 1304 Comm: chmod Tainted: G C 5.10.92-v7l+ #1514
Aug 19 16:49:28 volumio kernel: Hardware name: BCM2711
Aug 19 16:49:28 volumio kernel: Backtrace:
Aug 19 16:49:28 volumio kernel: [] (dump_backtrace) from [] (show_stack+0x20/0x24)
Aug 19 16:49:28 volumio kernel: r7:ffffffff r6:00000000 r5:60000013 r4:c12e6fd8
Aug 19 16:49:28 volumio kernel: [] (show_stack) from [] (dump_stack+0xcc/0xf8)
Aug 19 16:49:28 volumio kernel: [] (dump_stack) from [] (__warn+0xfc/0x114)
Aug 19 16:49:28 volumio kernel: r10:00000041 r9:00000009 r8:c047841c r7:00000905 r6:00000009 r5:c047841c
Aug 19 16:49:28 volumio kernel: r4:c0e442a8 r3:c1205094
Aug 19 16:49:28 volumio kernel: [] (__warn) from [] (warn_slowpath_fmt+0xa4/0xd8)
Aug 19 16:49:28 volumio kernel: r7:00000905 r6:c0e442a8 r5:c1205048 r4:c0e442bc
Aug 19 16:49:28 volumio kernel: [] (warn_slowpath_fmt) from [] (__mark_inode_dirty+0x3ac/0x42c)
Aug 19 16:49:28 volumio kernel: r9:ee665700 r8:ee680dd0 r7:00000000 r6:00000000 r5:ee665700 r4:c1b77c40
Aug 19 16:49:28 volumio kernel: [] (__mark_inode_dirty) from [] (ext4_setattr+0x484/0xa00)
Aug 19 16:49:28 volumio kernel: r7:c1205048 r6:00000000 r5:c4703ec8 r4:ee665700
Aug 19 16:49:28 volumio kernel: [] (ext4_setattr) from [] (notify_change+0x36c/0x4dc)
Aug 19 16:49:28 volumio kernel: r10:ee680dd0 r9:00000000 r8:00000000 r7:c1205048 r6:c4703ec8 r5:ee665700
Aug 19 16:49:28 volumio kernel: r4:00000041
Aug 19 16:49:28 volumio kernel: [] (notify_change) from [] (ovl_setattr+0xf8/0x22c [overlay])
Aug 19 16:49:28 volumio kernel: r10:ee680d48 r9:eee28e80 r8:c4703ec8 r7:ee680dd0 r6:00000000 r5:ee680d48
Aug 19 16:49:28 volumio kernel: r4:00000000
Aug 19 16:49:28 volumio kernel: [] (ovl_setattr [overlay]) from [] (notify_change+0x36c/0x4dc)
Aug 19 16:49:28 volumio kernel: r10:ee680d48 r9:00000000 r8:00000000 r7:c1205048 r6:c4703ec8 r5:c343e1e8
Aug 19 16:49:28 volumio kernel: r4:00000041 r3:bf006ab4
Aug 19 16:49:28 volumio kernel: [] (notify_change) from [] (chmod_common+0xa8/0x164)
Aug 19 16:49:28 volumio kernel: r10:fffff000 r9:c343e1e8 r8:c1205048 r7:000001ff r6:c4703f5c r5:c343e270
Aug 19 16:49:28 volumio kernel: r4:00000000
Aug 19 16:49:28 volumio kernel: [] (chmod_common) from [] (do_fchmodat+0x68/0xb0)
Aug 19 16:49:28 volumio kernel: r10:c1205048 r9:00000002 r8:000001ff r7:ffffff9c r6:014e1650 r5:00000000
Aug 19 16:49:28 volumio kernel: r4:00000000
Aug 19 16:49:28 volumio kernel: [] (do_fchmodat) from [] (sys_fchmodat+0x1c/0x20)
Aug 19 16:49:28 volumio kernel: r10:0000014d r9:c4702000 r8:c0200204 r7:0000014d r6:00000000 r5:00000001
Aug 19 16:49:28 volumio kernel: r4:014e2818
Aug 19 16:49:28 volumio kernel: [] (sys_fchmodat) from [] (ret_fast_syscall+0x0/0x28)
Aug 19 16:49:28 volumio kernel: Exception stack(0xc4703fa8 to 0xc4703ff0)
Aug 19 16:49:28 volumio kernel: 3fa0: 014e2818 00000001 ffffff9c 014e1650 000001ff 00000000
Aug 19 16:49:28 volumio kernel: 3fc0: 014e2818 00000001 00000000 0000014d 00008000 014e1650 0002b110 0002b180
Aug 19 16:49:28 volumio kernel: 3fe0: 00000000 be928b98 00011770 b6e71ebc
Aug 19 16:49:28 volumio kernel: ---[ end trace cfad47339debf8c1 ]---
Aug 19 16:49:28 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:28 volumio sudo[1302]: pam_unix(sudo:session): session closed for user root
Aug 19 16:49:28 volumio sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 19 16:49:28 volumio sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 19 16:49:28 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 19 16:49:28 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:28 volumio volumio[663]: info: Could not write mpd.conf:Error: EROFS: read-only file system, open '/etc/mpd.conf'
Aug 19 16:49:28 volumio volumio[663]: info: MPD Permissions set
Aug 19 16:49:28 volumio systemd[1]: Stopping Music Player Daemon...
Aug 19 16:49:28 volumio systemd[1]: mpd.service: Succeeded.
Aug 19 16:49:28 volumio systemd[1]: Stopped Music Player Daemon.
Aug 19 16:49:28 volumio systemd[1]: Starting Music Player Daemon...
Aug 19 16:49:28 volumio volumio[663]: error: Upnp client error: Error: This socket has been ended by the other party
Aug 19 16:49:29 volumio mpd[1313]: Aug 19 16:49 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Aug 19 16:49:29 volumio mpd[1313]: Aug 19 16:49 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Aug 19 16:49:29 volumio mpd[1313]: Aug 19 16:49 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Aug 19 16:49:29 volumio systemd[1]: Started Music Player Daemon.
Aug 19 16:49:29 volumio sudo[1305]: pam_unix(sudo:session): session closed for user root
Aug 19 16:49:29 volumio volumio[663]: error: updateQueue error: null
Aug 19 16:49:29 volumio volumio[663]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/music_service/mpd/config.json'
Aug 19 16:49:38 volumio nmbd[1332]: [2024/08/19 16:49:38.064010, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database)
Aug 19 16:49:38 volumio nmbd[1332]: wins_write_database: Can't open /var/lib/samba/wins.dat.1332: Input/output error
Aug 19 16:49:38 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #260134: comm nmbd: reading directory lblock 0
Aug 19 16:49:48 volumio volumio[663]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object]
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::volumioGetState
Aug 19 16:49:48 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #261222: comm sh: reading directory lblock 0
Aug 19 16:49:48 volumio volumio[663]: info: Disable softmixer device for audio device
Aug 19 16:49:48 volumio volumio[663]: info: Output device has changed, restarting MPD
Aug 19 16:49:48 volumio sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 19 16:49:48 volumio sudo[1356]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 19 16:49:48 volumio sudo[1356]: pam_unix(sudo:session): session closed for user root
Aug 19 16:49:48 volumio vtcs[1004]: [2024-08-19 16:49:48.484] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE
Aug 19 16:49:48 volumio vtcs[1004]: [2024-08-19 16:49:48.486] [tisoc] [error] [SpkconServer.cpp:373] recv error. client fd=8 errorno=104 error=Connection reset by peer
Aug 19 16:49:48 volumio vtcs[1004]: [2024-08-19 16:49:48.486] [tisoc] [error] [SpkconServer.cpp:368] recv error. socket disconnected
Aug 19 16:49:48 volumio sudo[1359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 19 16:49:48 volumio sudo[1359]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 19 16:49:48 volumio volumio[663]: info: Restoring Previous Volume level: 35 false false
Aug 19 16:49:48 volumio volumio[663]: info: Volume configurations have been set
Aug 19 16:49:48 volumio systemd[1]: Stopping Music Player Daemon...
Aug 19 16:49:48 volumio sudo[1362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 19 16:49:48 volumio sudo[1362]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 19 16:49:48 volumio systemd[1]: mpd.service: Succeeded.
Aug 19 16:49:48 volumio systemd[1]: Stopped Music Player Daemon.
Aug 19 16:49:48 volumio systemd[1]: Starting Music Player Daemon...
Aug 19 16:49:48 volumio sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 19 16:49:48 volumio systemd[1]: Stopping Volumio Tidal Connect Service...
Aug 19 16:49:48 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Aug 19 16:49:48 volumio systemd[1]: vtcs.service: Succeeded.
Aug 19 16:49:48 volumio systemd[1]: Stopped Volumio Tidal Connect Service.
Aug 19 16:49:48 volumio sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 19 16:49:48 volumio sudo[1362]: pam_unix(sudo:session): session closed for user root
Aug 19 16:49:48 volumio sudo[1365]: pam_unix(sudo:session): session closed for user root
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Aug 19 16:49:48 volumio volumio[663]: 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: 5
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Aug 19 16:49:48 volumio volumio[663]: info: Disabling external Volume Control
Aug 19 16:49:48 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #261222: comm node: reading directory lblock 0
Aug 19 16:49:48 volumio volumio[663]: error: Failed callmethod call: Error: spawn EIO
Aug 19 16:49:48 volumio sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 19 16:49:48 volumio sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 19 16:49:48 volumio volumio[663]: info: Cannot delete /data/configuration/audio_interface/alsa_controller/asound/softvolume-postVolume.conf: Error: EROFS: read-only file system, unlink '/data/configuration/audio_interface/alsa_controller/asound/softvolume.postVolume.conf'
Aug 19 16:49:48 volumio volumio[663]: info: Error setting mpd conf file perms: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/mpd.conf
Aug 19 16:49:48 volumio volumio[663]: /bin/chmod: changing permissions of '/etc/mpd.conf': Read-only file system
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:48 volumio sudo[1378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Aug 19 16:49:48 volumio sudo[1378]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 19 16:49:48 volumio sudo[1375]: pam_unix(sudo:session): session closed for user root
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 19 16:49:48 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 19 16:49:48 volumio volumio[663]: info: Could not write mpd.conf:Error: EROFS: read-only file system, open '/etc/mpd.conf'
Aug 19 16:49:48 volumio sudo[1378]: pam_unix(sudo:session): session closed for user root
Aug 19 16:49:48 volumio volumio[663]: error: Upnp client error: Error: This socket has been ended by the other party
Aug 19 16:49:49 volumio mpd[1379]: Aug 19 16:49 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Aug 19 16:49:49 volumio mpd[1379]: Aug 19 16:49 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Aug 19 16:49:49 volumio mpd[1379]: Aug 19 16:49 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Aug 19 16:49:49 volumio systemd[1]: Started Music Player Daemon.
Aug 19 16:49:49 volumio sudo[1359]: pam_unix(sudo:session): session closed for user root
Aug 19 16:49:49 volumio volumio[663]: error: updateQueue error: null
Aug 19 16:49:49 volumio volumio[663]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/audio_interface/alsa_controller/config.json'
Aug 19 16:49:51 volumio volumio[663]: info: TidalConnect service stoped!
Aug 19 16:49:51 volumio volumio[663]: info: TidalConnect service stoped!
Aug 19 16:49:51 volumio volumio[663]: info: TidalConnect service stoped!
Aug 19 16:49:51 volumio volumio[663]: info: TidalConnect service stoped!
Aug 19 16:49:51 volumio volumio[663]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Aug 19 16:49:51 volumio volumio[663]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Aug 19 16:49:51 volumio sudo[1404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Aug 19 16:49:51 volumio sudo[1404]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 19 16:49:51 volumio volumio[663]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Aug 19 16:49:51 volumio volumio[663]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Aug 19 16:49:51 volumio systemd[1]: Started Volumio Tidal Connect Service.
Aug 19 16:49:51 volumio sudo[1404]: pam_unix(sudo:session): session closed for user root
Aug 19 16:49:51 volumio sudo[1414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Aug 19 16:49:51 volumio sudo[1414]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 19 16:49:51 volumio sudo[1414]: pam_unix(sudo:session): session closed for user root
Aug 19 16:49:51 volumio volumio[663]: info: Executing endpoint tc_getconfig
Aug 19 16:49:51 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Aug 19 16:49:51 volumio vtcs[1410]: STARTING TidalConnect services, version: 1.1.7.5
Aug 19 16:49:51 volumio vtcs[1410]: STARTED TidalConnect services.
Aug 19 16:49:51 volumio volumio[663]: info: Executing endpoint tc_connect
Aug 19 16:49:51 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Aug 19 16:49:51 volumio volumio[663]: info: Connecting to TidalConnect
Aug 19 16:49:51 volumio volumio[663]: info: CoreCommandRouter::servicePushState
Aug 19 16:49:51 volumio volumio[663]: info: CoreStateMachine::pushState
Aug 19 16:49:51 volumio volumio[663]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 19 16:49:51 volumio volumio[663]: info: CoreCommandRouter::volumioPushState
Aug 19 16:49:52 volumio volumio[663]: info: CorePlayQueue::getTrack 0
Aug 19 16:49:52 volumio volumio[663]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect
Aug 19 16:49:52 volumio volumio[663]: info: CoreCommandRouter::servicePushState
Aug 19 16:49:52 volumio volumio[663]: info: CoreStateMachine::pushState
Aug 19 16:49:52 volumio volumio[663]: info: CoreCommandRouter::volumioPushState
Aug 19 16:49:52 volumio volumio[663]: info: CorePlayQueue::getTrack 0
Aug 19 16:49:52 volumio volumio[663]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect
Aug 19 16:49:53 volumio volumio[663]: info: VolumeController::SetAlsaVolume35
Aug 19 16:49:53 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1536: inode #261222: comm node: reading directory lblock 0
Aug 19 16:49:53 volumio volumio[663]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 19 16:49:53 volumio volumio[663]: Error: spawn EIO
Aug 19 16:49:53 volumio volumio[663]: at ChildProcess.spawn (internal/child_process.js:403:11)
Aug 19 16:49:53 volumio volumio[663]: at spawn (child_process.js:553:9)
Aug 19 16:49:53 volumio volumio[663]: at amixer (/volumio/app/volumecontrol.js:79:13)
Aug 19 16:49:53 volumio volumio[663]: at CoreVolumeController.self.setVolume (/volumio/app/volumecontrol.js:223:9)
Aug 19 16:49:53 volumio volumio[663]: at CoreVolumeController.alsavolume (/volumio/app/volumecontrol.js:460:16)
Aug 19 16:49:53 volumio volumio[663]: at CoreCommandRouter.volumiosetvolume (/volumio/app/index.js:132:35)
Aug 19 16:49:53 volumio volumio[663]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/alsa_controller/index.js:2010:24)
Aug 19 16:49:53 volumio volumio[663]: at listOnTimeout (internal/timers.js:554:17)
Aug 19 16:49:53 volumio volumio[663]: at processTimers (internal/timers.js:497:7) {
Aug 19 16:49:53 volumio volumio[663]: errno: -5,
Aug 19 16:49:53 volumio volumio[663]: code: 'EIO',
Aug 19 16:49:53 volumio volumio[663]: syscall: 'spawn'
Aug 19 16:49:53 volumio volumio[663]: }
Aug 19 16:49:53 volumio volumio[663]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 19 16:49:53 volumio sudo[1446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-19 16:48
Aug 19 16:49:53 volumio sudo[1446]: 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="cd8cf34b47ce852e70b71e6f7b6e0265f7fdb695"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="8f88153f9a18f312d56050e6613b45a852ac819a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 27 Sep 2023 11:35:49 AM CEST"
VOLUMIO_VERSION="3.546"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="6823c0d83061ff736b7e0dd4481bc496"