-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sat 2025-06-07 20:01:06 CST. -- Jun 07 20:00:00 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 07 20:00:00 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 07 20:00:00 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 07 20:00:01 v2 volumio[678]: info: Retrieving Cloud Streaming UI Jun 07 20:00:01 v2 volumio[678]: info: Getting Tidal Cloud Configuration Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 07 20:00:01 v2 volumio[678]: info: Getting Qobuz Cloud Configuration Jun 07 20:00:01 v2 volumio[678]: info: Asking plugin for UI Config Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 07 20:00:01 v2 volumio[678]: info: Getting Spotify Cloud Configuration Jun 07 20:00:01 v2 volumio[678]: info: Asking plugin for UI Config Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 07 20:00:01 v2 volumio[678]: info: Saving Spotify Acccount Jun 07 20:00:01 v2 volumio[678]: info: Got Tidal Cloud Configuration Jun 07 20:00:01 v2 volumio[678]: info: Got it Jun 07 20:00:01 v2 volumio[678]: info: Got it Jun 07 20:00:01 v2 volumio[678]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 07 20:00:01 v2 volumio[678]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::volumioGetBrowseSources Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::volumioGetBrowseSources Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::volumioGetBrowseSources Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 07 20:00:01 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 07 20:00:06 v2 volumio[678]: info: BOOT COMPLETED Jun 07 20:00:08 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 07 20:00:08 v2 volumio[678]: info: CURURI: albums:// Jun 07 20:00:08 v2 volumio[678]: info: listAlbums - loading Albums from cache Jun 07 20:00:08 v2 volumio[678]: info: Preload queue cleared Jun 07 20:00:09 v2 volumio[678]: 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/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89/ddfd4312-f94b-453a-9cda-ee155ca550ef.jpg' Jun 07 20:00:28 v2 ntpd[635]: Soliciting pool server 95.111.202.5 Jun 07 20:00:29 v2 ntpd[635]: Soliciting pool server 2001:470:1d:281::123 Jun 07 20:00:33 v2 volumio[678]: Searching plugin music_service/mpd Jun 07 20:00:33 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 07 20:00:33 v2 volumio[678]: info: All search sources collected, pushing search results Jun 07 20:00:46 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 07 20:00:46 v2 volumio[678]: info: CURURI: albums:// Jun 07 20:00:46 v2 volumio[678]: info: listAlbums - loading Albums from cache Jun 07 20:00:46 v2 volumio[678]: info: Preload queue cleared Jun 07 20:00:48 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 07 20:00:48 v2 volumio[678]: info: CURURI: albums://%E5%88%80%E9%83%8E/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89 Jun 07 20:00:49 v2 volumio[678]: info: Preload queue cleared Jun 07 20:00:49 v2 volumio[678]: info: Preloading song: music-library/NAS/down/02 罗刹海市.flac Jun 07 20:00:49 v2 volumio[678]: info: Preloading song: music-library/NAS/down/03 花妖.flac Jun 07 20:00:49 v2 volumio[678]: info: Exploding uri music-library/NAS/down/02 罗刹海市.flac in service mpd Jun 07 20:00:49 v2 volumio[678]: info: Exploding uri music-library/NAS/down/03 花妖.flac in service mpd Jun 07 20:00:49 v2 volumio[678]: 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/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89/ddfd4312-f94b-453a-9cda-ee155ca550ef.jpg' Jun 07 20:00:49 v2 volumio[678]: info: ALBUMART /albumart?cacheid=957&web=%E5%88%80%E9%83%8E/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89/small&path=%2Fmnt%2FNAS%2Fdown%2F02%20%E7%BD%97%E5%88%B9%E6%B5%B7%E5%B8%82.flac&metadata=false Jun 07 20:00:49 v2 volumio[678]: info: URI /mnt/NAS/down/02 罗刹海市.flac Jun 07 20:00:49 v2 volumio[678]: info: ALBUMART /albumart?cacheid=957&web=%E5%88%80%E9%83%8E/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89/small&path=%2Fmnt%2FNAS%2Fdown%2F03%20%E8%8A%B1%E5%A6%96.flac&metadata=false Jun 07 20:00:49 v2 volumio[678]: info: URI /mnt/NAS/down/03 花妖.flac Jun 07 20:00:49 v2 volumio[678]: info: No valid Plugin REST Endpoint Jun 07 20:00:49 v2 volumio[678]: info: No valid Plugin REST Endpoint Jun 07 20:00:49 v2 volumio[678]: info: No valid Plugin REST Endpoint Jun 07 20:00:49 v2 volumio[678]: info: No valid Plugin REST Endpoint Jun 07 20:00:50 v2 volumio[678]: info: Preload queue cleared Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::ClearQueue Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::stop Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::clearPlayQueue Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::saveQueue Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushQueue Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::addQueueItems Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::addQueueItems Jun 07 20:00:50 v2 volumio[678]: info: Preload queue cleared Jun 07 20:00:50 v2 volumio[678]: info: Adding Item to queue: albums://%E5%88%80%E9%83%8E/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89 Jun 07 20:00:50 v2 volumio[678]: info: Exploding uri albums://%E5%88%80%E9%83%8E/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89 in service mpd Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushQueue Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::saveQueue Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::updateTrackBlock Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrackBlock Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPlay Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::play index 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::stop Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::play index undefined Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::startPlaybackTimer Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::clearAddPlayTracks NAS/down/02 罗刹海市.flac Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand stop Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand stop took 6 milliseconds Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand clear Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand clear took 1 milliseconds Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand add "NAS/down/02 罗刹海市.flac" Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces system playlist update Jun 07 20:00:50 v2 volumio[678]: info: Ignoring MPD Status Update Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces system playlist update Jun 07 20:00:50 v2 volumio[678]: info: Ignoring MPD Status Update Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces system playlist update Jun 07 20:00:50 v2 volumio[678]: info: Ignoring MPD Status Update Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces system playlist update Jun 07 20:00:50 v2 volumio[678]: info: Ignoring MPD Status Update Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand add "NAS/down/02 罗刹海市.flac" took 23 milliseconds Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 15ms Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 11ms Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand play Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces system playlist update Jun 07 20:00:50 v2 volumio[678]: info: Ignoring MPD Status Update Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces system playlist update Jun 07 20:00:50 v2 volumio[678]: info: Ignoring MPD Status Update Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 22ms Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 22ms Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand play took 14 milliseconds Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 12ms Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 9ms Jun 07 20:00:50 v2 volumio[678]: error: Upnp client error: Error: This socket has been ended by the other party Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces state update: player Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::getState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand status Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces state update: player Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::getState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand status Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces state update: player Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::getState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand status Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand status took 30 milliseconds Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces state update: player Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::getState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand status Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand status took 35 milliseconds Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand status took 34 milliseconds Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces state update: player Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::getState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand status Jun 07 20:00:50 v2 volumio[678]: info: Jun 07 20:00:50 v2 volumio[678]: ---------------------------- MPD announces state update: player Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::getState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand status Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand playlistinfo took 22 milliseconds Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand status took 18 milliseconds Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand playlistinfo took 15 milliseconds Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand status took 11 milliseconds Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand status took 9 milliseconds Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseTrackInfo Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseTrackInfo Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseTrackInfo Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseState Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::pushState Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::servicePushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":333,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"罗刹海市","artist":"刀郎","album":"山歌寥哉","uri":"NAS/down/02 罗刹海市.flac","trackType":"flac"} Jun 07 20:00:50 v2 volumio[678]: verbose: CURRENT POSITION 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState stateService play Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState currentStatus stop Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::pushState Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::servicePushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":333,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"罗刹海市","artist":"刀郎","album":"山歌寥哉","uri":"NAS/down/02 罗刹海市.flac","trackType":"flac"} Jun 07 20:00:50 v2 volumio[678]: verbose: CURRENT POSITION 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState stateService play Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState currentStatus play Jun 07 20:00:50 v2 volumio[678]: info: Received an update from plugin. extracting info from payload Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::pushState Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::servicePushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":333,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"罗刹海市","artist":"刀郎","album":"山歌寥哉","uri":"NAS/down/02 罗刹海市.flac","trackType":"flac"} Jun 07 20:00:50 v2 volumio[678]: verbose: CURRENT POSITION 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState stateService play Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState currentStatus play Jun 07 20:00:50 v2 volumio[678]: info: Received an update from plugin. extracting info from payload Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 132ms Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 188ms Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 187ms Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand playlistinfo took 131 milliseconds Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand playlistinfo took 129 milliseconds Jun 07 20:00:50 v2 volumio[678]: info: sendMpdCommand playlistinfo took 128 milliseconds Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseTrackInfo Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseTrackInfo Jun 07 20:00:50 v2 volumio[678]: verbose: ControllerMpd::parseTrackInfo Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::pushState Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::servicePushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":333,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"罗刹海市","artist":"刀郎","album":"山歌寥哉","uri":"NAS/down/02 罗刹海市.flac","trackType":"flac"} Jun 07 20:00:50 v2 volumio[678]: verbose: CURRENT POSITION 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState stateService play Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState currentStatus play Jun 07 20:00:50 v2 volumio[678]: info: Received an update from plugin. extracting info from payload Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::pushState Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::servicePushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":333,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"罗刹海市","artist":"刀郎","album":"山歌寥哉","uri":"NAS/down/02 罗刹海市.flac","trackType":"flac"} Jun 07 20:00:50 v2 volumio[678]: verbose: CURRENT POSITION 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState stateService play Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState currentStatus play Jun 07 20:00:50 v2 volumio[678]: info: Received an update from plugin. extracting info from payload Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:00:50 v2 volumio[678]: info: ControllerMpd::pushState Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::servicePushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":333,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"罗刹海市","artist":"刀郎","album":"山歌寥哉","uri":"NAS/down/02 罗刹海市.flac","trackType":"flac"} Jun 07 20:00:50 v2 volumio[678]: verbose: CURRENT POSITION 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState stateService play Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::syncState currentStatus play Jun 07 20:00:50 v2 volumio[678]: info: Received an update from plugin. extracting info from payload Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:00:50 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:00:50 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:50 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 306ms Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 298ms Jun 07 20:00:50 v2 volumio[678]: info: ------------------------------ 297ms Jun 07 20:00:52 v2 volumio[678]: 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/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89/ddfd4312-f94b-453a-9cda-ee155ca550ef.jpg' Jun 07 20:00:52 v2 volumio[678]: 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/%E5%B1%B1%E6%AD%8C%E5%AF%A5%E5%93%89/ddfd4312-f94b-453a-9cda-ee155ca550ef.jpg' Jun 07 20:00:59 v2 volumio[678]: info: VolumeController::SetAlsaVolume74 Jun 07 20:00:59 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:00:59 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:00:59 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 20:00:59 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:01:01 v2 volumio[678]: info: VolumeController::SetAlsaVolume+ Jun 07 20:01:01 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:01:01 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:01:01 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 20:01:01 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:01:02 v2 volumio[678]: info: VolumeController::SetAlsaVolume+ Jun 07 20:01:02 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:01:02 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:01:02 v2 volumio[678]: info: VolumeController::SetAlsaVolume+ Jun 07 20:01:02 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:01:02 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:01:02 v2 volumio[678]: info: VolumeController::SetAlsaVolume+ Jun 07 20:01:02 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:01:02 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:01:02 v2 volumio[678]: info: VolumeController::SetAlsaVolume+ Jun 07 20:01:02 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:01:02 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:01:02 v2 volumio[678]: info: VolumeController::SetAlsaVolume+ Jun 07 20:01:02 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:01:02 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:01:02 v2 volumio[678]: info: VolumeController::SetAlsaVolume+ Jun 07 20:01:02 v2 volumio[678]: info: CoreStateMachine::pushState Jun 07 20:01:02 v2 volumio[678]: info: CorePlayQueue::getTrack 0 Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 20:01:02 v2 volumio[678]: info: CoreCommandRouter::volumioPushState Jun 07 20:01:05 v2 volumio[678]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 07 20:01:05 v2 volumio[678]: Error: connect ETIMEDOUT 69.171.229.11:443 Jun 07 20:01:05 v2 volumio[678]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jun 07 20:01:05 v2 volumio[678]: errno: -110, Jun 07 20:01:05 v2 volumio[678]: code: 'ETIMEDOUT', Jun 07 20:01:05 v2 volumio[678]: syscall: 'connect', Jun 07 20:01:05 v2 volumio[678]: address: '69.171.229.11', Jun 07 20:01:05 v2 volumio[678]: port: 443 Jun 07 20:01:05 v2 volumio[678]: } Jun 07 20:01:05 v2 volumio[678]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 07 20:01:06 v2 sudo[1603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-07 20:00 Jun 07 20:01:06 v2 sudo[1603]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"