-- Logs begin at Thu 2019-02-14 18:11:59 +08, end at Mon 2024-07-15 07:42:58 +08. -- Jul 15 07:41:09 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 15 07:41:09 volumio volumio[937]: info: CURURI: music-library Jul 15 07:41:09 volumio volumio[937]: info: Preload queue cleared Jul 15 07:41:30 volumio kernel: usb 1-1.2: new high-speed USB device number 5 using dwc_otg Jul 15 07:41:30 volumio kernel: usb 1-1.2: New USB device found, idVendor=0000, idProduct=7777, bcdDevice= 1.0e Jul 15 07:41:30 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jul 15 07:41:30 volumio kernel: usb 1-1.2: Product: Mass Storage Jul 15 07:41:30 volumio kernel: usb 1-1.2: Manufacturer: Generic Jul 15 07:41:30 volumio kernel: usb 1-1.2: SerialNumber: 061EEAEA Jul 15 07:41:30 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Jul 15 07:41:30 volumio kernel: scsi host0: usb-storage 1-1.2:1.0 Jul 15 07:41:31 volumio kernel: scsi 0:0:0:0: Direct-Access Generic Flash Disk 8.00 PQ: 0 ANSI: 4 Jul 15 07:41:31 volumio kernel: sd 0:0:0:0: [sda] 4096000 512-byte logical blocks: (2.10 GB/1.95 GiB) Jul 15 07:41:31 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Jul 15 07:41:31 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 23 00 00 00 Jul 15 07:41:31 volumio kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Jul 15 07:41:31 volumio kernel: sda: sda1 Jul 15 07:41:31 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Jul 15 07:41:31 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Jul 15 07:41:31 volumio volumio[937]: info: Mounting Device 0E0E-F3F2 Jul 15 07:41:31 volumio sudo[2155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/0E0E-F3F2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jul 15 07:41:31 volumio sudo[2155]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 15 07:41:31 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jul 15 07:41:31 volumio sudo[2155]: pam_unix(sudo:session): session closed for user root Jul 15 07:41:31 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jul 15 07:41:31 volumio volumio[937]: info: Scanning new location : "USB/0E0E-F3F2" Jul 15 07:41:31 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:41:31 volumio volumio[937]: info: Jul 15 07:41:31 volumio volumio[937]: ---------------------------- MPD announces state update: update Jul 15 07:41:31 volumio volumio[937]: info: ControllerMpd::getState Jul 15 07:41:31 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:41:31 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:41:31 volumio volumio[937]: info: Jul 15 07:41:31 volumio volumio[937]: ---------------------------- MPD announces state update: update Jul 15 07:41:31 volumio volumio[937]: info: ControllerMpd::getState Jul 15 07:41:31 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:41:31 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:41:31 volumio volumio[937]: info: Jul 15 07:41:31 volumio volumio[937]: ---------------------------- MPD announces state update: update Jul 15 07:41:31 volumio volumio[937]: info: ControllerMpd::getState Jul 15 07:41:31 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:41:31 volumio volumio[937]: info: sendMpdCommand status took 12 milliseconds Jul 15 07:41:31 volumio volumio[937]: info: sendMpdCommand status took 11 milliseconds Jul 15 07:41:31 volumio volumio[937]: info: sendMpdCommand status took 9 milliseconds Jul 15 07:41:31 volumio volumio[937]: info: sendMpdCommand status took 8 milliseconds Jul 15 07:41:31 volumio volumio[937]: info: sendMpdCommand status took 6 milliseconds Jul 15 07:41:31 volumio volumio[937]: info: sendMpdCommand status took 5 milliseconds Jul 15 07:41:31 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:41:32 volumio volumio[937]: info: Command Router : Notfying DB Updatetrue Jul 15 07:41:32 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:41:32 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 07:41:32 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:41:32 volumio volumio[937]: info: Command Router : Notfying DB Updatetrue Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::Close All Modals sent Jul 15 07:41:32 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:41:32 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 07:41:32 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:41:32 volumio volumio[937]: info: Command Router : Notfying DB Updatetrue Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::Close All Modals sent Jul 15 07:41:32 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:41:32 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 07:41:32 volumio volumio[937]: info: sendMpdCommand playlistinfo took 60 milliseconds Jul 15 07:41:32 volumio volumio[937]: info: sendMpdCommand playlistinfo took 38 milliseconds Jul 15 07:41:32 volumio volumio[937]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 15 07:41:32 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jul 15 07:41:32 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jul 15 07:41:32 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jul 15 07:41:32 volumio volumio[937]: info: ControllerMpd::pushState Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jul 15 07:41:32 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jul 15 07:41:32 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":48981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Robbie Williams - Feel","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Jul 15 07:41:32 volumio volumio[937]: verbose: CURRENT POSITION 0 Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jul 15 07:41:32 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:41:32 volumio volumio[937]: info: ControllerMpd::pushState Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jul 15 07:41:32 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jul 15 07:41:32 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":48981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Robbie Williams - Feel","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Jul 15 07:41:32 volumio volumio[937]: verbose: CURRENT POSITION 0 Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jul 15 07:41:32 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:41:32 volumio volumio[937]: info: ControllerMpd::pushState Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jul 15 07:41:32 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jul 15 07:41:32 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":48981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Robbie Williams - Feel","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Jul 15 07:41:32 volumio volumio[937]: verbose: CURRENT POSITION 0 Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jul 15 07:41:32 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:41:32 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:41:32 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:41:32 volumio volumio[937]: info: ------------------------------ 188ms Jul 15 07:41:32 volumio volumio[937]: info: ------------------------------ 185ms Jul 15 07:41:32 volumio volumio[937]: info: ------------------------------ 182ms Jul 15 07:42:16 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 15 07:42:16 volumio volumio[937]: info: CURURI: artists:// Jul 15 07:42:16 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Beyond/a3eb6e14-0d22-4057-903e-1b6b8462a90e.jpg' Jul 15 07:42:16 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/M2M/e272d589-aa39-4546-ae40-3b77ec96d2a5.jpg' Jul 15 07:42:16 volumio volumio[937]: info: Preload queue cleared Jul 15 07:42:16 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vivian%20Chow/2ea77c4e-9aff-478b-a43c-01b371a24629.jpg' Jul 15 07:42:16 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Twins/a5b30c04-9726-4f05-b08a-38e31d36032c.jpg' Jul 15 07:42:17 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%81%C2%BA%C3%93%C2%BD%C3%A7%C3%B7/dc8630a1-7bae-4809-9b4e-51d24f83d242.jpg' Jul 15 07:42:17 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%83%C3%8F%C3%8D%C2%A5%C3%8E%C2%AD/b4fa0c21-e9aa-4c25-88a4-8ebc5873325e.jpg' Jul 15 07:42:18 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%85%C3%AD%C3%81%C3%A7/fc909ecc-b176-4b58-9cb4-e48a31fdcb25.jpg' Jul 15 07:42:18 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%88%C2%BA%C3%90%C3%87/907525e7-63bb-45cb-8dae-fc4a88c29893.jpg' Jul 15 07:42:18 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%8D%C3%B5%C2%BD%C3%9C/3b8b91b8-9f7e-4d5e-bcaa-d42859e7a4eb.jpg' Jul 15 07:42:20 volumio kernel: FAT-fs (sda1): error, fat_get_cluster: invalid cluster chain (i_pos 0) Jul 15 07:42:20 volumio kernel: FAT-fs (sda1): Filesystem has been set read-only Jul 15 07:42:20 volumio kernel: FAT-fs (sda1): error, fat_get_cluster: invalid cluster chain (i_pos 0) Jul 15 07:42:20 volumio kernel: FAT-fs (sda1): error, fat_get_cluster: invalid cluster chain (i_pos 0) Jul 15 07:42:20 volumio volumio[937]: info: MPD Database updated - AlbumList cache refreshed Jul 15 07:42:20 volumio volumio[937]: info: Jul 15 07:42:20 volumio volumio[937]: ---------------------------- MPD announces state update: database Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:42:20 volumio volumio[937]: info: Jul 15 07:42:20 volumio volumio[937]: ---------------------------- MPD announces state update: update Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::getState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::getState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:42:20 volumio volumio[937]: info: MPD Database updated - AlbumList cache refreshed Jul 15 07:42:20 volumio volumio[937]: info: Jul 15 07:42:20 volumio volumio[937]: ---------------------------- MPD announces state update: database Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:42:20 volumio volumio[937]: info: Jul 15 07:42:20 volumio volumio[937]: ---------------------------- MPD announces state update: update Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::getState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::getState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:42:20 volumio volumio[937]: info: MPD Database updated - AlbumList cache refreshed Jul 15 07:42:20 volumio volumio[937]: info: Jul 15 07:42:20 volumio volumio[937]: ---------------------------- MPD announces state update: database Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:42:20 volumio volumio[937]: info: Jul 15 07:42:20 volumio volumio[937]: ---------------------------- MPD announces state update: update Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::getState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::getState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand status took 65 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand status took 63 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand status took 63 milliseconds Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:42:20 volumio volumio[937]: info: Command Router : Notfying DB Updatefalse Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::Close All Modals sent Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand status took 170 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand status took 170 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand status took 169 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand status took 157 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand status took 155 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand status took 155 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand playlistinfo took 47 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand playlistinfo took 48 milliseconds Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:42:20 volumio volumio[937]: info: Command Router : Notfying DB Updatefalse Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::Close All Modals sent Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:42:20 volumio volumio[937]: info: Command Router : Notfying DB Updatefalse Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::Close All Modals sent Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseState Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jul 15 07:42:20 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jul 15 07:42:20 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":97346,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Robbie Williams - Feel","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Jul 15 07:42:20 volumio volumio[937]: verbose: CURRENT POSITION 0 Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jul 15 07:42:20 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jul 15 07:42:20 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jul 15 07:42:20 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":97346,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Robbie Williams - Feel","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Jul 15 07:42:20 volumio volumio[937]: verbose: CURRENT POSITION 0 Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jul 15 07:42:20 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: ------------------------------ 277ms Jul 15 07:42:20 volumio volumio[937]: info: ------------------------------ 278ms Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand playlistinfo took 79 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand playlistinfo took 79 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand playlistinfo took 59 milliseconds Jul 15 07:42:20 volumio volumio[937]: info: sendMpdCommand playlistinfo took 59 milliseconds Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jul 15 07:42:20 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jul 15 07:42:20 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jul 15 07:42:20 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":97346,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Robbie Williams - Feel","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Jul 15 07:42:20 volumio volumio[937]: verbose: CURRENT POSITION 0 Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jul 15 07:42:20 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jul 15 07:42:20 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jul 15 07:42:20 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":97346,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Robbie Williams - Feel","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Jul 15 07:42:20 volumio volumio[937]: verbose: CURRENT POSITION 0 Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jul 15 07:42:20 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jul 15 07:42:20 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jul 15 07:42:20 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":97346,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Robbie Williams - Feel","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Jul 15 07:42:20 volumio volumio[937]: verbose: CURRENT POSITION 0 Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jul 15 07:42:20 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: ControllerMpd::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jul 15 07:42:20 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jul 15 07:42:20 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":97346,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Robbie Williams - Feel","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Jul 15 07:42:20 volumio volumio[937]: verbose: CURRENT POSITION 0 Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jul 15 07:42:20 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: CoreStateMachine::pushState Jul 15 07:42:20 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jul 15 07:42:20 volumio volumio[937]: info: ------------------------------ 358ms Jul 15 07:42:20 volumio volumio[937]: info: ------------------------------ 359ms Jul 15 07:42:20 volumio volumio[937]: info: ------------------------------ 356ms Jul 15 07:42:20 volumio volumio[937]: info: ------------------------------ 346ms Jul 15 07:42:20 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%8E%C3%A9%C2%B0%C3%9B/e6854804-3742-4c14-bb82-b29a5223ce45.jpg' Jul 15 07:42:20 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%90%C2%A1%C2%BB%C2%A2%C2%B6%C3%93/f9675322-9f65-439a-895a-1ba74faccf36.jpg' Jul 15 07:42:20 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%90%C3%AC%C3%90%C2%A1%C2%B7%C3%AF/cd6d53d0-0d7d-4966-96af-acec69250d8b.jpg' Jul 15 07:42:21 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%92%C2%B6%C3%99%C2%BB%C3%8E%C3%84/6320e683-eba0-4872-b493-2b61b5776c2c.jpg' Jul 15 07:42:21 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%95%C3%85%C2%B9%C3%BA%C3%88%C3%99/9b92fab3-2d7c-40c0-a2a6-d60eaef79eb2.jpg' Jul 15 07:42:22 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%97%C2%BF%C3%92%C3%80%C3%A6%C3%83/f778016c-051b-4713-bcd0-eed359ecee3d.jpg' Jul 15 07:42:22 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%88%80%E9%83%8E/68ffd883-b289-44bf-a175-10a8025d3000.jpg' Jul 15 07:42:23 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%88%98%E5%BE%B7%E5%8D%8E/fc82c54e-8682-4397-8fa3-3edd83bfbcd3.jpg' Jul 15 07:42:23 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%8D%93%E4%BE%9D%E5%A9%B7/61e42e28-b5a1-431e-b94c-2598d6461172.jpg' Jul 15 07:42:23 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E4%BC%A0%E9%9B%84/20b634a0-142f-4470-90f3-97d86793ab43.jpg' Jul 15 07:42:23 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%85%A7%E6%95%8F/16f39b12-539a-4bb2-84c3-c8bb9c42639b.jpg' Jul 15 07:42:24 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%A7%9C%E8%82%B2%E6%81%92/dfe72a0b-8f8e-40b8-81cf-0c9b1a665044.jpg' Jul 15 07:42:24 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%9F%E5%BA%AD%E8%8B%87/344c279b-fcbf-493a-be21-0faaf7ffb1b8.jpg' Jul 15 07:42:25 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%9B%BD%E8%8D%A3/06426825-0890-4b4e-b7c1-84bcfb5e1788.jpg' Jul 15 07:42:25 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/ca19b8b7-17b9-4a82-a70c-c7d227171236.jpg' Jul 15 07:42:26 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E6%83%A0%E5%A6%B9/9ccdb6f7-8a83-4693-84fe-e250c4e89032.jpg' Jul 15 07:42:26 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%96%B9%E5%AD%A3%E6%83%9F/0c396cc2-ac06-4ae5-bab7-981bd0339f57.jpg' Jul 15 07:42:26 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%A8%E5%8D%83%E5%AC%85/7a697732-cc34-4f9d-bbda-425d3e51e2f1.jpg' Jul 15 07:42:27 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%A8%E9%92%B0%E8%8E%B9/bd052339-0fcf-4384-818f-2378afa78c34.jpg' Jul 15 07:42:27 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%BD%98%E7%BE%8E%E8%BE%B0/44218f74-444d-495b-882d-1034d6b93d17.jpg' Jul 15 07:42:27 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E6%9D%B0/b7486cb1-de53-4bf0-9c06-48d9fd6326b0.jpg' Jul 15 07:42:27 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%82%93%E4%B8%BD%E5%90%9B/ad55df10-033e-4bf0-b2ee-0819bc278fba.jpg' Jul 15 07:42:28 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E7%99%BE%E5%BC%BA/9ce13323-8f34-43d8-99e9-41b3c5ab35be.jpg' Jul 15 07:42:28 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BB%84%E4%BC%9F%E6%96%87/3803df12-5231-4372-b9df-99297882f3f6.jpg' Jul 15 07:42:42 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 15 07:42:42 volumio volumio[937]: info: CURURI: music-library Jul 15 07:42:42 volumio volumio[937]: info: Preload queue cleared Jul 15 07:42:47 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 15 07:42:47 volumio volumio[937]: info: CURURI: albums:// Jul 15 07:42:47 volumio volumio[937]: info: listAlbums - loading Albums from cache Jul 15 07:42:47 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/*/f7d1bbee-8336-43c6-8241-97436d0d9c9b.jpg' Jul 15 07:42:47 volumio volumio[937]: info: Preload queue cleared Jul 15 07:42:51 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Zhi%20An%20Xu/ON%20HITS/930fab78-204d-4d85-84a7-ac0d0ed34501.jpg' Jul 15 07:42:51 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/M2M/The%20Day%20You%20Went%20Away%3A%20The%20Best%20Of%20M2M/1a384e16-e956-4567-8d6b-cd023ae2d52b.png' Jul 15 07:42:51 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%A8%E9%92%B0%E8%8E%B9/%E4%B8%80%E7%89%87%E8%89%B3%E9%98%B3%E5%A4%A9/8d4f4f7f-d448-49a7-8bdf-239992c47bac.jpg' Jul 15 07:42:52 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%9F%E5%BA%AD%E8%8B%87/%E4%BD%A0%E7%9C%8B%E4%BD%A0%E7%9C%8B%E6%9C%88%E4%BA%AE%E7%9A%84%E8%84%B8/5d2d7e90-23c1-4b9c-874d-e90af2a63f13.jpg' Jul 15 07:42:52 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%85%A7%E6%95%8F/%E6%83%85%E8%BF%B7%E5%BF%83%E7%AA%8D/dcce60cc-74b7-485e-8010-513dc27772c9.jpg' Jul 15 07:42:53 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%88%80%E9%83%8E/%E6%8A%AB%E7%9D%80%E7%BE%8A%E7%9A%AE%E7%9A%84%E7%8B%BC/6925d23a-a715-45f6-b87f-94f5941c8ab7.jpg' Jul 15 07:42:53 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%9B%BD%E8%8D%A3/%E9%92%9F%E6%83%85%E5%BC%A0%E5%9B%BD%E8%8D%A3/75166476-2922-49ee-b80b-62c3145436a9.jpg' Jul 15 07:42:53 volumio volumio[937]: info: CoreCommandRouter::volumioGetState Jul 15 07:42:54 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E6%9D%B0/%E4%B8%80%E5%9C%BA%E6%B8%B8%E6%88%8F%E4%B8%80%E5%9C%BA%E6%A2%A6/a1db66b9-67ea-4ab9-9c33-b9bb233c65e5.jpg' Jul 15 07:42:55 volumio volumio[937]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/%E7%9C%9F%E6%83%85%E6%B5%81%E9%9C%B2/e834d387-842a-4008-8008-9d9d3406ceef.jpg' Jul 15 07:42:58 volumio volumio[937]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 15 07:42:58 volumio volumio[937]: Error: connect ETIMEDOUT 156.233.67.243:80 Jul 15 07:42:58 volumio volumio[937]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jul 15 07:42:58 volumio volumio[937]: errno: -110, Jul 15 07:42:58 volumio volumio[937]: code: 'ETIMEDOUT', Jul 15 07:42:58 volumio volumio[937]: syscall: 'connect', Jul 15 07:42:58 volumio volumio[937]: address: '156.233.67.243', Jul 15 07:42:58 volumio volumio[937]: port: 80 Jul 15 07:42:58 volumio volumio[937]: } Jul 15 07:42:58 volumio volumio[937]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 15 07:42:58 volumio sudo[2436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-15 07:41 Jul 15 07:42:58 volumio sudo[2436]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"