-- Logs begin at Sat 2025-01-11 02:58:59 UTC, end at Sat 2025-01-11 04:12:18 UTC. -- Jan 11 04:11:13 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BE%90%E4%BD%B3%E8%8E%B9/%E5%BF%83%E9%87%8C%E5%AD%A6/534908ac-4d29-4e75-be99-2ba318e79a16.jpg' Jan 11 04:11:14 volumio volumio[1055]: info: Jan 11 04:11:14 volumio volumio[1055]: ---------------------------- MPD announces system playlist update Jan 11 04:11:14 volumio volumio[1055]: info: Ignoring MPD Status Update Jan 11 04:11:14 volumio volumio[1055]: info: Jan 11 04:11:14 volumio volumio[1055]: ---------------------------- MPD announces state update: player Jan 11 04:11:14 volumio volumio[1055]: info: ControllerMpd::getState Jan 11 04:11:14 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand status Jan 11 04:11:14 volumio volumio[1055]: info: ------------------------------ 8ms Jan 11 04:11:14 volumio volumio[1055]: info: sendMpdCommand status took 4 milliseconds Jan 11 04:11:14 volumio volumio[1055]: verbose: ControllerMpd::parseState Jan 11 04:11:14 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 04:11:14 volumio volumio[1055]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 11 04:11:14 volumio volumio[1055]: verbose: ControllerMpd::parseTrackInfo Jan 11 04:11:14 volumio volumio[1055]: info: ControllerMpd::pushState Jan 11 04:11:14 volumio volumio[1055]: info: CoreCommandRouter::servicePushState Jan 11 04:11:14 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Jan 11 04:11:14 volumio volumio[1055]: verbose: STATE SERVICE {"status":"play","position":0,"seek":16988,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Robbie Williams - Angels","artist":"1.FM - America's Best Ballads Radio","album":null,"uri":"http://185.33.21.112:80/onelive_64a","trackType":""} Jan 11 04:11:14 volumio volumio[1055]: verbose: CURRENT POSITION 0 Jan 11 04:11:14 volumio volumio[1055]: info: CoreStateMachine::syncState stateService play Jan 11 04:11:14 volumio volumio[1055]: info: CoreStateMachine::syncState currentStatus play Jan 11 04:11:14 volumio volumio[1055]: info: Received an update from plugin. extracting info from payload Jan 11 04:11:14 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 11 04:11:14 volumio volumio[1055]: info: CoreStateMachine::pushState Jan 11 04:11:14 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Jan 11 04:11:14 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 04:11:14 volumio volumio[1055]: info: CoreStateMachine::pushState Jan 11 04:11:14 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Jan 11 04:11:14 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 04:11:14 volumio volumio[1055]: info: ------------------------------ 46ms Jan 11 04:11:19 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Gu%20Shuan/Melody%20Of%20The%20Land%20(made%20in%20USA)/21144dcd-3f59-4be8-b185-c8523ca74222.jpg' Jan 11 04:11:19 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Leslie%20Cheung/Dreaming/06914c1d-c8ff-4600-9f91-5eee2e6a8335.jpg' Jan 11 04:11:19 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Leslie%20Cheung/Hot%20Summer/e58e45be-06a0-4bed-91e7-2ca02c169d0a.jpg' Jan 11 04:11:19 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Leslie%20Cheung/Miss%20You%20Mix/2c165fb2-9df7-43b6-b5c8-ff3b7b27c117.jpg' Jan 11 04:11:20 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Leslie%20Cheung/Leslie/16885e21-fb66-4f4b-8c47-5d62905ec4de.jpg' Jan 11 04:11:20 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Leslie%20Cheung/Virgin%20Snow/e48dee59-ef0d-4d6b-962b-f2b1d2d55403.jpg' Jan 11 04:11:48 volumio volumio[1055]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::ClearQueue Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::stop Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 04:11:48 volumio volumio[1055]: verbose: UNSET VOLATILE Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::stPlaybackTimer Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::updateTrackBlock Jan 11 04:11:48 volumio volumio[1055]: info: CorePlayQueue::getTrackBlock Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::pushState Jan 11 04:11:48 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Jan 11 04:11:48 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Jan 11 04:11:48 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::serviceStop Jan 11 04:11:48 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Jan 11 04:11:48 volumio volumio[1055]: info: CoreCommandRouter::serviceStop Jan 11 04:11:48 volumio volumio[1055]: info: [1736568708361] ControllerWebradio::stop Jan 11 04:11:48 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 04:11:48 volumio volumio[1055]: info: CorePlayQueue::clearPlayQueue Jan 11 04:11:48 volumio volumio[1055]: info: CorePlayQueue::saveQueue Jan 11 04:11:48 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Jan 11 04:11:48 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 04:11:48 volumio volumio[1055]: info: CoreCommandRouter::volumioPushQueue Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::addQueueItems Jan 11 04:11:48 volumio volumio[1055]: info: CorePlayQueue::addQueueItems Jan 11 04:11:48 volumio volumio[1055]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1675664 Jan 11 04:11:48 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 11 04:11:48 volumio volumio[1055]: info: CorePlayQueue::saveQueue Jan 11 04:11:48 volumio volumio[1055]: info: CoreCommandRouter::volumioPushQueue Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::updateTrackBlock Jan 11 04:11:48 volumio volumio[1055]: info: CorePlayQueue::getTrackBlock Jan 11 04:11:48 volumio volumio[1055]: info: CoreCommandRouter::volumioPlay Jan 11 04:11:48 volumio volumio[1055]: verbose: UNSET VOLATILE Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::play index 0 Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::stop Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 04:11:48 volumio volumio[1055]: verbose: UNSET VOLATILE Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::play index undefined Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 04:11:48 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Jan 11 04:11:48 volumio volumio[1055]: info: CoreStateMachine::startPlaybackTimer Jan 11 04:11:48 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Jan 11 04:11:48 volumio volumio[1055]: info: [1736568708406] ControllerWebradio::clearAddPlayTrack Jan 11 04:11:48 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 04:11:48 volumio volumio[1055]: info: Jan 11 04:11:48 volumio volumio[1055]: ---------------------------- MPD announces state update: player Jan 11 04:11:48 volumio volumio[1055]: info: sendMpdCommand stop took 129 milliseconds Jan 11 04:11:48 volumio volumio[1055]: info: ControllerMpd::getState Jan 11 04:11:48 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand status Jan 11 04:11:48 volumio volumio[1055]: info: sendMpdCommand stop took 85 milliseconds Jan 11 04:11:48 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 04:11:48 volumio volumio[1055]: info: Jan 11 04:11:48 volumio volumio[1055]: ---------------------------- MPD announces system playlist update Jan 11 04:11:48 volumio volumio[1055]: info: Ignoring MPD Status Update Jan 11 04:11:48 volumio volumio[1055]: info: sendMpdCommand status took 14 milliseconds Jan 11 04:11:48 volumio volumio[1055]: info: sendMpdCommand clear took 10 milliseconds Jan 11 04:11:48 volumio volumio[1055]: verbose: ControllerMpd::parseState Jan 11 04:11:48 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 04:11:48 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1675664" Jan 11 04:11:48 volumio volumio[1055]: error: updateQueue error: null Jan 11 04:11:48 volumio volumio[1055]: info: ------------------------------ 14ms Jan 11 04:11:48 volumio volumio[1055]: info: sendMpdCommand playlistinfo took 11 milliseconds Jan 11 04:11:48 volumio volumio[1055]: verbose: ControllerMpd::parseTrackInfo Jan 11 04:11:48 volumio volumio[1055]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 04:11:48 volumio volumio[1055]: info: ------------------------------ 28ms Jan 11 04:11:48 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 11 04:11:48 volumio volumio[1055]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 11 04:11:48 volumio volumio[1055]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jan 11 04:11:48 volumio volumio[1055]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jan 11 04:11:48 volumio volumio[1055]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jan 11 04:11:48 volumio volumio[1055]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jan 11 04:11:48 volumio volumio[1055]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 11 04:11:48 volumio volumio[1055]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 11 04:11:48 volumio volumio[1055]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 11 04:11:49 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 11 04:11:49 volumio volumio[1055]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 11 04:11:49 volumio volumio[1055]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jan 11 04:11:49 volumio volumio[1055]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jan 11 04:11:49 volumio volumio[1055]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jan 11 04:11:49 volumio volumio[1055]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jan 11 04:11:49 volumio volumio[1055]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 11 04:11:49 volumio volumio[1055]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 11 04:11:49 volumio volumio[1055]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 11 04:11:49 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 11 04:11:49 volumio volumio[1055]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 11 04:11:49 volumio volumio[1055]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jan 11 04:11:49 volumio volumio[1055]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jan 11 04:11:49 volumio volumio[1055]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jan 11 04:11:49 volumio volumio[1055]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jan 11 04:11:49 volumio volumio[1055]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 11 04:11:49 volumio volumio[1055]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 11 04:11:49 volumio volumio[1055]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 11 04:11:51 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 11 04:11:51 volumio volumio[1055]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 11 04:11:51 volumio volumio[1055]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jan 11 04:11:51 volumio volumio[1055]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jan 11 04:11:51 volumio volumio[1055]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jan 11 04:11:51 volumio volumio[1055]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jan 11 04:11:51 volumio volumio[1055]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 11 04:11:51 volumio volumio[1055]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 11 04:11:51 volumio volumio[1055]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 11 04:11:51 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 11 04:11:51 volumio volumio[1055]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 11 04:11:51 volumio volumio[1055]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jan 11 04:11:51 volumio volumio[1055]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jan 11 04:11:51 volumio volumio[1055]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jan 11 04:11:51 volumio volumio[1055]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jan 11 04:11:51 volumio volumio[1055]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 11 04:11:51 volumio volumio[1055]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 11 04:11:51 volumio volumio[1055]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 11 04:11:52 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 11 04:11:52 volumio volumio[1055]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 11 04:11:52 volumio volumio[1055]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jan 11 04:11:52 volumio volumio[1055]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jan 11 04:11:52 volumio volumio[1055]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jan 11 04:11:52 volumio volumio[1055]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jan 11 04:11:52 volumio volumio[1055]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 11 04:11:52 volumio volumio[1055]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 11 04:11:52 volumio volumio[1055]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 11 04:11:52 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 11 04:11:52 volumio volumio[1055]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 11 04:11:52 volumio volumio[1055]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jan 11 04:11:52 volumio volumio[1055]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jan 11 04:11:52 volumio volumio[1055]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jan 11 04:11:52 volumio volumio[1055]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jan 11 04:11:52 volumio volumio[1055]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 11 04:11:52 volumio volumio[1055]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 11 04:11:52 volumio volumio[1055]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 11 04:11:52 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 11 04:11:52 volumio volumio[1055]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 11 04:11:52 volumio volumio[1055]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jan 11 04:11:52 volumio volumio[1055]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jan 11 04:11:52 volumio volumio[1055]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jan 11 04:11:52 volumio volumio[1055]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jan 11 04:11:52 volumio volumio[1055]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 11 04:11:52 volumio volumio[1055]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 11 04:11:52 volumio volumio[1055]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 11 04:11:52 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BD%90%E7%A7%A6/%E5%86%AC%E9%9B%A8/9bc360de-cbe7-471b-852f-10419202ae8c.jpg' Jan 11 04:11:53 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 11 04:11:53 volumio volumio[1055]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 11 04:11:53 volumio volumio[1055]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jan 11 04:11:53 volumio volumio[1055]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jan 11 04:11:53 volumio volumio[1055]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jan 11 04:11:53 volumio volumio[1055]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jan 11 04:11:53 volumio volumio[1055]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 11 04:11:53 volumio volumio[1055]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 11 04:11:53 volumio volumio[1055]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 11 04:11:53 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Priscilla%20Chan/Priscilla%20Chan/28e69e1e-cb74-4000-b1ff-4c6180009001.jpg' Jan 11 04:11:58 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand add "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1675664" Jan 11 04:11:58 volumio volumio[1055]: info: sendMpdCommand add "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1675664" took 2 milliseconds Jan 11 04:11:58 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 11 04:11:58 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand play Jan 11 04:11:58 volumio volumio[1055]: info: Jan 11 04:11:58 volumio volumio[1055]: ---------------------------- MPD announces system playlist update Jan 11 04:11:58 volumio volumio[1055]: info: Ignoring MPD Status Update Jan 11 04:11:58 volumio volumio[1055]: info: sendMpdCommand play took 4 milliseconds Jan 11 04:11:58 volumio volumio[1055]: info: ------------------------------ 5ms Jan 11 04:12:07 volumio volumio[1055]: info: Jan 11 04:12:07 volumio volumio[1055]: ---------------------------- MPD announces state update: player Jan 11 04:12:07 volumio volumio[1055]: info: ControllerMpd::getState Jan 11 04:12:07 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand status Jan 11 04:12:07 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 11 04:12:07 volumio volumio[1055]: info: sendMpdCommand status took 11 milliseconds Jan 11 04:12:07 volumio volumio[1055]: verbose: ControllerMpd::parseState Jan 11 04:12:07 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 04:12:07 volumio volumio[1055]: info: sendMpdCommand clearerror took 7 milliseconds Jan 11 04:12:07 volumio volumio[1055]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 11 04:12:07 volumio volumio[1055]: verbose: ControllerMpd::parseTrackInfo Jan 11 04:12:07 volumio volumio[1055]: info: ControllerMpd::pushState Jan 11 04:12:07 volumio volumio[1055]: info: CoreCommandRouter::servicePushState Jan 11 04:12:07 volumio volumio[1055]: info: CoreStateMachine::pushState Jan 11 04:12:07 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Jan 11 04:12:07 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 04:12:07 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Jan 11 04:12:07 volumio volumio[1055]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"tunein-station.m3u?id=1675664","artist":null,"album":null,"uri":"http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1675664","trackType":""} Jan 11 04:12:07 volumio volumio[1055]: verbose: CURRENT POSITION 0 Jan 11 04:12:07 volumio volumio[1055]: info: CoreStateMachine::syncState stateService stop Jan 11 04:12:07 volumio volumio[1055]: info: CoreStateMachine::syncState currentStatus stop Jan 11 04:12:07 volumio volumio[1055]: info: CoreStateMachine::pushState Jan 11 04:12:07 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Jan 11 04:12:07 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 04:12:07 volumio volumio[1055]: info: No code Jan 11 04:12:07 volumio volumio[1055]: info: CoreStateMachine::pushState Jan 11 04:12:07 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Jan 11 04:12:07 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 04:12:07 volumio volumio[1055]: info: ------------------------------ 65ms Jan 11 04:12:09 volumio volumio[1055]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Valen%20Hsu/Freyja/f7fbba27-93b9-4e19-ac72-080e10e90b59.png' Jan 11 04:12:10 volumio volumio[1055]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::ClearQueue Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::stop Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 04:12:10 volumio volumio[1055]: verbose: UNSET VOLATILE Jan 11 04:12:10 volumio volumio[1055]: info: CorePlayQueue::clearPlayQueue Jan 11 04:12:10 volumio volumio[1055]: info: CorePlayQueue::saveQueue Jan 11 04:12:10 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Jan 11 04:12:10 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 04:12:10 volumio volumio[1055]: info: CoreCommandRouter::volumioPushQueue Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::addQueueItems Jan 11 04:12:10 volumio volumio[1055]: info: CorePlayQueue::addQueueItems Jan 11 04:12:10 volumio volumio[1055]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1675664 Jan 11 04:12:10 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 11 04:12:10 volumio volumio[1055]: info: CorePlayQueue::saveQueue Jan 11 04:12:10 volumio volumio[1055]: info: CoreCommandRouter::volumioPushQueue Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::updateTrackBlock Jan 11 04:12:10 volumio volumio[1055]: info: CorePlayQueue::getTrackBlock Jan 11 04:12:10 volumio volumio[1055]: info: CoreCommandRouter::volumioPlay Jan 11 04:12:10 volumio volumio[1055]: verbose: UNSET VOLATILE Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::play index 0 Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::stop Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 04:12:10 volumio volumio[1055]: verbose: UNSET VOLATILE Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::play index undefined Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 04:12:10 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Jan 11 04:12:10 volumio volumio[1055]: info: CoreStateMachine::startPlaybackTimer Jan 11 04:12:10 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Jan 11 04:12:10 volumio volumio[1055]: info: [1736568730723] ControllerWebradio::clearAddPlayTrack Jan 11 04:12:10 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 04:12:10 volumio volumio[1055]: info: sendMpdCommand stop took 22 milliseconds Jan 11 04:12:10 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 04:12:10 volumio volumio[1055]: info: Jan 11 04:12:10 volumio volumio[1055]: ---------------------------- MPD announces system playlist update Jan 11 04:12:10 volumio volumio[1055]: info: Ignoring MPD Status Update Jan 11 04:12:10 volumio volumio[1055]: info: sendMpdCommand clear took 8 milliseconds Jan 11 04:12:10 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1675664" Jan 11 04:12:10 volumio volumio[1055]: error: updateQueue error: null Jan 11 04:12:10 volumio volumio[1055]: info: ------------------------------ 9ms Jan 11 04:12:11 volumio volumio[1055]: info: Jan 11 04:12:11 volumio volumio[1055]: ---------------------------- MPD announces system playlist update Jan 11 04:12:11 volumio volumio[1055]: info: Ignoring MPD Status Update Jan 11 04:12:11 volumio volumio[1055]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1675664" took 310 milliseconds Jan 11 04:12:11 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 11 04:12:11 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand play Jan 11 04:12:11 volumio volumio[1055]: info: ------------------------------ 5ms Jan 11 04:12:11 volumio volumio[1055]: info: sendMpdCommand play took 5 milliseconds Jan 11 04:12:15 volumio volumio[1055]: info: Jan 11 04:12:15 volumio volumio[1055]: ---------------------------- MPD announces state update: player Jan 11 04:12:15 volumio volumio[1055]: info: ControllerMpd::getState Jan 11 04:12:15 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand status Jan 11 04:12:15 volumio volumio[1055]: info: sendMpdCommand status took 11 milliseconds Jan 11 04:12:15 volumio volumio[1055]: verbose: ControllerMpd::parseState Jan 11 04:12:15 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 04:12:15 volumio volumio[1055]: info: Jan 11 04:12:15 volumio volumio[1055]: ---------------------------- MPD announces state update: player Jan 11 04:12:15 volumio volumio[1055]: info: ControllerMpd::getState Jan 11 04:12:15 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand status Jan 11 04:12:15 volumio volumio[1055]: info: Jan 11 04:12:15 volumio volumio[1055]: ---------------------------- MPD announces system playlist update Jan 11 04:12:15 volumio volumio[1055]: info: Ignoring MPD Status Update Jan 11 04:12:15 volumio volumio[1055]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 11 04:12:15 volumio volumio[1055]: info: sendMpdCommand status took 2 milliseconds Jan 11 04:12:15 volumio volumio[1055]: verbose: ControllerMpd::parseTrackInfo Jan 11 04:12:15 volumio volumio[1055]: verbose: ControllerMpd::parseState Jan 11 04:12:15 volumio volumio[1055]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 04:12:15 volumio volumio[1055]: info: ControllerMpd::pushState Jan 11 04:12:15 volumio volumio[1055]: info: CoreCommandRouter::servicePushState Jan 11 04:12:15 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Jan 11 04:12:15 volumio volumio[1055]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tim McGraw - One of These Days","artist":"1.FM - Country One Radio","album":null,"uri":"http://185.33.21.112:80/country_128","trackType":""} Jan 11 04:12:15 volumio volumio[1055]: verbose: CURRENT POSITION 0 Jan 11 04:12:15 volumio volumio[1055]: info: CoreStateMachine::syncState stateService play Jan 11 04:12:15 volumio volumio[1055]: info: CoreStateMachine::syncState currentStatus stop Jan 11 04:12:15 volumio volumio[1055]: info: CoreStateMachine::pushState Jan 11 04:12:15 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Jan 11 04:12:15 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 04:12:15 volumio volumio[1055]: info: ------------------------------ 100ms Jan 11 04:12:15 volumio volumio[1055]: info: ------------------------------ 95ms Jan 11 04:12:15 volumio volumio[1055]: info: sendMpdCommand playlistinfo took 92 milliseconds Jan 11 04:12:15 volumio volumio[1055]: verbose: ControllerMpd::parseTrackInfo Jan 11 04:12:15 volumio volumio[1055]: info: ControllerMpd::pushState Jan 11 04:12:15 volumio volumio[1055]: info: CoreCommandRouter::servicePushState Jan 11 04:12:15 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Jan 11 04:12:15 volumio volumio[1055]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Tim McGraw - One of These Days","artist":"1.FM - Country One Radio","album":null,"uri":"http://185.33.21.112:80/country_128","trackType":""} Jan 11 04:12:15 volumio volumio[1055]: verbose: CURRENT POSITION 0 Jan 11 04:12:15 volumio volumio[1055]: info: CoreStateMachine::syncState stateService play Jan 11 04:12:15 volumio volumio[1055]: info: CoreStateMachine::syncState currentStatus play Jan 11 04:12:15 volumio volumio[1055]: info: Received an update from plugin. extracting info from payload Jan 11 04:12:15 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 11 04:12:15 volumio volumio[1055]: info: CoreStateMachine::pushState Jan 11 04:12:15 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Jan 11 04:12:15 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 04:12:15 volumio volumio[1055]: info: CoreStateMachine::pushState Jan 11 04:12:15 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Jan 11 04:12:15 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 04:12:15 volumio volumio[1055]: info: ------------------------------ 137ms Jan 11 04:12:17 volumio volumio[1055]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 04:12:17 volumio volumio[1055]: { Error: connect ETIMEDOUT 173.252.88.133:443 Jan 11 04:12:17 volumio volumio[1055]: at Object._errnoException (util.js:1022:11) Jan 11 04:12:17 volumio volumio[1055]: at _exceptionWithHostPort (util.js:1044:20) Jan 11 04:12:17 volumio volumio[1055]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 11 04:12:17 volumio volumio[1055]: code: 'ETIMEDOUT', Jan 11 04:12:17 volumio volumio[1055]: errno: 'ETIMEDOUT', Jan 11 04:12:17 volumio volumio[1055]: syscall: 'connect', Jan 11 04:12:17 volumio volumio[1055]: address: '173.252.88.133', Jan 11 04:12:17 volumio volumio[1055]: port: 443 } Jan 11 04:12:17 volumio volumio[1055]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 04:12:18 volumio sudo[11472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-11 04:11 Jan 11 04:12:18 volumio sudo[11472]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"