-- Logs begin at Tue 2025-01-21 02:23:13 CST, end at Mon 2025-02-17 14:12:20 CST. -- Feb 17 14:11:46 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 17 14:11:46 smsl-n100 volumio[865]: info: CURURI: music-library Feb 17 14:11:47 smsl-n100 volumio[865]: info: Preload queue cleared Feb 17 14:11:48 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 17 14:11:48 smsl-n100 volumio[865]: info: CURURI: music-library/USB Feb 17 14:11:48 smsl-n100 volumio[865]: info: Preload queue cleared Feb 17 14:11:49 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 17 14:11:49 smsl-n100 volumio[865]: info: CURURI: music-library/USB/USBD Feb 17 14:11:49 smsl-n100 volumio[865]: info: Preload queue cleared Feb 17 14:11:49 smsl-n100 volumio[865]: info: Preloading song: music-library/USB/USBD/左右声道测试.mp3 Feb 17 14:11:49 smsl-n100 volumio[865]: info: Preloading song: music-library/USB/USBD/01_交響曲 第5番 ハ短調 作品67 『運命』第1楽章.flac Feb 17 14:11:49 smsl-n100 volumio[865]: info: Preloading song: music-library/USB/USBD/02_ヴァイオリン協奏曲 四季 より春 第1楽章.flac Feb 17 14:11:49 smsl-n100 volumio[865]: info: Preloading song: music-library/USB/USBD/03_白鳥.flac Feb 17 14:11:49 smsl-n100 volumio[865]: info: Preloading song: music-library/USB/USBD/04_カルメン組曲 アラゴネーズ、ハバネラ、衛兵の交代.flac Feb 17 14:11:49 smsl-n100 volumio[865]: info: Preloading song: music-library/USB/USBD/05_無伴奏チェロ組曲 第1番 ト長調 BWV1007より I． Prélude.flac Feb 17 14:11:49 smsl-n100 volumio[865]: info: Preloading song: music-library/USB/USBD/01. Bad Romance.flac Feb 17 14:11:49 smsl-n100 volumio[865]: info: Exploding uri music-library/USB/USBD/左右声道测试.mp3 in service mpd Feb 17 14:11:49 smsl-n100 volumio[865]: info: ALBUMART /albumart?cacheid=746&web=1/1/extralarge&path=%2Fmnt%2FUSB%2FUSBD%2F%E5%B7%A6%E5%8F%B3%E5%A3%B0%E9%81%93%E6%B5%8B%E8%AF%95.mp3&metadata=false Feb 17 14:11:49 smsl-n100 volumio[865]: info: URI /mnt/USB/USBD/左右声道测试.mp3 Feb 17 14:11:49 smsl-n100 volumio[865]: info: Exploding uri music-library/USB/USBD/01_交響曲 第5番 ハ短調 作品67 『運命』第1楽章.flac in service mpd Feb 17 14:11:49 smsl-n100 volumio[865]: info: ALBUMART /albumart?cacheid=746&web=%E3%83%8D%E3%83%83%E3%83%AD%E3%83%BB%E3%82%B5%E3%83%B3%E3%83%86%E3%82%A3%2FNHK%E4%BA%A4%E9%9F%BF%E6%A5%BD%E5%9B%A3/ONE%20POINT%EF%BC%8EReal%20Hi-Res/extralarge&path=%2Fmnt%2FUSB%2FUSBD%2F01_%E4%BA%A4%E9%9F%BF%E6%9B%B2%20%E7%AC%AC5%E7%95%AA%20%E3%83%8F%E7%9F%AD%E8%AA%BF%20%E4%BD%9C%E5%93%8167%20%E3%80%8E%E9%81%8B%E5%91%BD%E3%80%8F%E7%AC%AC1%E6%A5%BD%E7%AB%A0.flac&metadata=false Feb 17 14:11:49 smsl-n100 volumio[865]: info: URI /mnt/USB/USBD/01_交響曲 第5番 ハ短調 作品67 『運命』第1楽章.flac Feb 17 14:11:49 smsl-n100 volumio[865]: info: Exploding uri music-library/USB/USBD/02_ヴァイオリン協奏曲 四季 より春 第1楽章.flac in service mpd Feb 17 14:11:49 smsl-n100 volumio[865]: info: ALBUMART /albumart?cacheid=746&web=%E6%96%B0%E3%82%A4%E3%82%BF%E3%83%AA%E3%82%A2%E5%90%88%E5%A5%8F%E5%9B%A3%2F%E3%83%95%E3%82%A7%E3%83%87%E3%83%AA%E3%83%BC%E3%82%B3%E3%83%BB%E3%82%B0%E3%83%AA%E3%82%A8%E3%83%AB%E3%83%A2/ONE%20POINT%EF%BC%8EReal%20Hi-Res/extralarge&path=%2Fmnt%2FUSB%2FUSBD%2F02_%E3%83%B4%E3%82%A1%E3%82%A4%E3%82%AA%E3%83%AA%E3%83%B3%E5%8D%94%E5%A5%8F%E6%9B%B2%20%E5%9B%9B%E5%AD%A3%20%E3%82%88%E3%82%8A%E6%98%A5%20%E7%AC%AC1%E6%A5%BD%E7%AB%A0.flac&metadata=false Feb 17 14:11:49 smsl-n100 volumio[865]: info: URI /mnt/USB/USBD/02_ヴァイオリン協奏曲 四季 より春 第1楽章.flac Feb 17 14:11:49 smsl-n100 volumio[865]: info: Exploding uri music-library/USB/USBD/03_白鳥.flac in service mpd Feb 17 14:11:49 smsl-n100 volumio[865]: info: ALBUMART /albumart?cacheid=746&web=%E8%97%A4%E6%9D%91%E4%BF%8A%E4%BB%8B%2F%E6%97%A9%E5%B7%9D%E3%82%8A%E3%81%95%E3%81%93%2F%E6%9D%BE%E4%BA%95%E4%B9%85%E5%AD%90/ONE%20POINT%EF%BC%8EReal%20Hi-Res/extralarge&path=%2Fmnt%2FUSB%2FUSBD%2F03_%E7%99%BD%E9%B3%A5.flac&metadata=false Feb 17 14:11:49 smsl-n100 volumio[865]: info: URI /mnt/USB/USBD/03_白鳥.flac Feb 17 14:11:49 smsl-n100 volumio[865]: info: Exploding uri music-library/USB/USBD/04_カルメン組曲 アラゴネーズ、ハバネラ、衛兵の交代.flac in service mpd Feb 17 14:11:49 smsl-n100 volumio[865]: info: ALBUMART /albumart?cacheid=746&web=%E3%83%99%E3%83%AB%E3%82%AE%E3%83%BC%E9%87%91%E7%AE%A1%E3%82%A2%E3%83%B3%E3%82%B5%E3%83%B3%E3%83%96%E3%83%AB/ONE%20POINT%EF%BC%8EReal%20Hi-Res/extralarge&path=%2Fmnt%2FUSB%2FUSBD%2F04_%E3%82%AB%E3%83%AB%E3%83%A1%E3%83%B3%E7%B5%84%E6%9B%B2%20%E3%82%A2%E3%83%A9%E3%82%B4%E3%83%8D%E3%83%BC%E3%82%BA%E3%80%81%E3%83%8F%E3%83%90%E3%83%8D%E3%83%A9%E3%80%81%E8%A1%9B%E5%85%B5%E3%81%AE%E4%BA%A4%E4%BB%A3.flac&metadata=false Feb 17 14:11:49 smsl-n100 volumio[865]: info: URI /mnt/USB/USBD/04_カルメン組曲 アラゴネーズ、ハバネラ、衛兵の交代.flac Feb 17 14:11:49 smsl-n100 volumio[865]: info: Exploding uri music-library/USB/USBD/05_無伴奏チェロ組曲 第1番 ト長調 BWV1007より I． Prélude.flac in service mpd Feb 17 14:11:49 smsl-n100 volumio[865]: info: ALBUMART /albumart?cacheid=746&web=%E5%AE%89%E7%94%B0%E8%AC%99%E4%B8%80%E9%83%8E/ONE%20POINT%EF%BC%8EReal%20Hi-Res/extralarge&path=%2Fmnt%2FUSB%2FUSBD%2F05_%E7%84%A1%E4%BC%B4%E5%A5%8F%E3%83%81%E3%82%A7%E3%83%AD%E7%B5%84%E6%9B%B2%20%E7%AC%AC1%E7%95%AA%20%E3%83%88%E9%95%B7%E8%AA%BF%20BWV1007%E3%82%88%E3%82%8A%20I%EF%BC%8E%20Pr%C3%A9lude.flac&metadata=false Feb 17 14:11:49 smsl-n100 volumio[865]: info: URI /mnt/USB/USBD/05_無伴奏チェロ組曲 第1番 ト長調 BWV1007より I． Prélude.flac Feb 17 14:11:49 smsl-n100 volumio[865]: info: Exploding uri music-library/USB/USBD/01. Bad Romance.flac in service mpd Feb 17 14:11:49 smsl-n100 volumio[865]: info: ALBUMART /albumart?cacheid=746&web=Lady%20GaGa/The%20Fame%20Monster/extralarge&path=%2Fmnt%2FUSB%2FUSBD%2F01.%20Bad%20Romance.flac&metadata=false Feb 17 14:11:49 smsl-n100 volumio[865]: info: URI /mnt/USB/USBD/01. Bad Romance.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Preload queue cleared Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::ClearQueue Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::stop Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::clearPlayQueue Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::saveQueue Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushQueue Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::addQueueItems Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::addQueueItems Feb 17 14:11:50 smsl-n100 volumio[865]: info: Preload queue cleared Feb 17 14:11:50 smsl-n100 volumio[865]: info: Adding Item to queue: music-library/USB/USBD/左右声道测试.mp3 Feb 17 14:11:50 smsl-n100 volumio[865]: info: Using cached record of: music-library/USB/USBD/左右声道测试.mp3 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushQueue Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::saveQueue Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::updateTrackBlock Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrackBlock Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPlay Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::play index 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::addQueueItems Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::addQueueItems Feb 17 14:11:50 smsl-n100 volumio[865]: info: Preload queue cleared Feb 17 14:11:50 smsl-n100 volumio[865]: info: Adding Item to queue: music-library/USB/USBD/01_交響曲 第5番 ハ短調 作品67 『運命』第1楽章.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Using cached record of: music-library/USB/USBD/01_交響曲 第5番 ハ短調 作品67 『運命』第1楽章.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Adding Item to queue: music-library/USB/USBD/02_ヴァイオリン協奏曲 四季 より春 第1楽章.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Using cached record of: music-library/USB/USBD/02_ヴァイオリン協奏曲 四季 より春 第1楽章.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Adding Item to queue: music-library/USB/USBD/03_白鳥.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Using cached record of: music-library/USB/USBD/03_白鳥.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Adding Item to queue: music-library/USB/USBD/04_カルメン組曲 アラゴネーズ、ハバネラ、衛兵の交代.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Using cached record of: music-library/USB/USBD/04_カルメン組曲 アラゴネーズ、ハバネラ、衛兵の交代.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Adding Item to queue: music-library/USB/USBD/05_無伴奏チェロ組曲 第1番 ト長調 BWV1007より I． Prélude.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Using cached record of: music-library/USB/USBD/05_無伴奏チェロ組曲 第1番 ト長調 BWV1007より I． Prélude.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Adding Item to queue: music-library/USB/USBD/01. Bad Romance.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Using cached record of: music-library/USB/USBD/01. Bad Romance.flac Feb 17 14:11:50 smsl-n100 volumio[865]: info: Adding Item to queue: music-library/USB/USBD/24bit176.4 蔡琴_-_机遇-淡水小镇 Feb 17 14:11:50 smsl-n100 volumio[865]: info: Exploding uri music-library/USB/USBD/24bit176.4 蔡琴_-_机遇-淡水小镇 in service mpd Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::stop Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::play index undefined Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::startPlaybackTimer Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioGetVisibleSources Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::clearAddPlayTracks USB/USBD/左右声道测试.mp3 Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 14:11:50 smsl-n100 volumio[865]: info: ALBUMART /albumart?cacheid=746&web=//extralarge&path=%2Fmnt%2FUSB%2FUSBD%2F24bit176.4%20%E8%94%A1%E7%90%B4_-_%E6%9C%BA%E9%81%87-%E6%B7%A1%E6%B0%B4%E5%B0%8F%E9%95%87%2F%E5%81%B6%E7%84%B6.wav&metadata=false Feb 17 14:11:50 smsl-n100 volumio[865]: info: URI /mnt/USB/USBD/24bit176.4 蔡琴_-_机遇-淡水小镇/偶然.wav Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand stop took 21 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushQueue Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::saveQueue Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::updateTrackBlock Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrackBlock Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces system playlist update Feb 17 14:11:50 smsl-n100 volumio[865]: info: Ignoring MPD Status Update Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand clear took 38 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand add "USB/USBD/左右声道测试.mp3" Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces system playlist update Feb 17 14:11:50 smsl-n100 volumio[865]: info: Ignoring MPD Status Update Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces system playlist update Feb 17 14:11:50 smsl-n100 volumio[865]: info: Ignoring MPD Status Update Feb 17 14:11:50 smsl-n100 volumio[865]: error: updateQueue error: null Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces system playlist update Feb 17 14:11:50 smsl-n100 volumio[865]: info: Ignoring MPD Status Update Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 30ms Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand add "USB/USBD/左右声道测试.mp3" took 23 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 21ms Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 17ms Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand play Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces system playlist update Feb 17 14:11:50 smsl-n100 volumio[865]: info: Ignoring MPD Status Update Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces system playlist update Feb 17 14:11:50 smsl-n100 volumio[865]: info: Ignoring MPD Status Update Feb 17 14:11:50 smsl-n100 volumio[865]: error: Upnp client error: Error: This socket has been ended by the other party Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 32ms Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand play took 23 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 22ms Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 17ms Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces state update: player Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::getState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand status Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces state update: player Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::getState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand status Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces state update: player Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::getState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand status Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces state update: player Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::getState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand status Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand status took 27 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand status took 20 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand status took 14 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces state update: player Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::getState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand status Feb 17 14:11:50 smsl-n100 volumio[865]: info: Feb 17 14:11:50 smsl-n100 volumio[865]: ---------------------------- MPD announces state update: player Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::getState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand status Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand status took 44 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand playlistinfo took 33 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand playlistinfo took 31 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand playlistinfo took 30 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand status took 21 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand status took 15 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseTrackInfo Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseTrackInfo Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseTrackInfo Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseState Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::servicePushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"左右声道测试.mp3","artist":"1","album":"1","uri":"USB/USBD/左右声道测试.mp3","trackType":"mp3"} Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: CURRENT POSITION 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState stateService play Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState currentStatus stop Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::servicePushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"左右声道测试.mp3","artist":"1","album":"1","uri":"USB/USBD/左右声道测试.mp3","trackType":"mp3"} Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: CURRENT POSITION 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState stateService play Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState currentStatus play Feb 17 14:11:50 smsl-n100 volumio[865]: info: Received an update from plugin. extracting info from payload Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output update for this device Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output update for this device Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::servicePushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"左右声道测试.mp3","artist":"1","album":"1","uri":"USB/USBD/左右声道测试.mp3","trackType":"mp3"} Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: CURRENT POSITION 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState stateService play Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState currentStatus play Feb 17 14:11:50 smsl-n100 volumio[865]: info: Received an update from plugin. extracting info from payload Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output update for this device Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output update for this device Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 210ms Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 259ms Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 253ms Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand playlistinfo took 192 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand playlistinfo took 181 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: info: sendMpdCommand playlistinfo took 179 milliseconds Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseTrackInfo Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseTrackInfo Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: ControllerMpd::parseTrackInfo Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::servicePushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"左右声道测试.mp3","artist":"1","album":"1","uri":"USB/USBD/左右声道测试.mp3","trackType":"mp3"} Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: CURRENT POSITION 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState stateService play Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState currentStatus play Feb 17 14:11:50 smsl-n100 volumio[865]: info: Received an update from plugin. extracting info from payload Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output update for this device Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output update for this device Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::servicePushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"左右声道测试.mp3","artist":"1","album":"1","uri":"USB/USBD/左右声道测试.mp3","trackType":"mp3"} Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: CURRENT POSITION 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState stateService play Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState currentStatus play Feb 17 14:11:50 smsl-n100 volumio[865]: info: Received an update from plugin. extracting info from payload Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output update for this device Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output update for this device Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output Feb 17 14:11:50 smsl-n100 volumio[865]: info: ControllerMpd::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::servicePushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"左右声道测试.mp3","artist":"1","album":"1","uri":"USB/USBD/左右声道测试.mp3","trackType":"mp3"} Feb 17 14:11:50 smsl-n100 volumio[865]: verbose: CURRENT POSITION 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState stateService play Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::syncState currentStatus play Feb 17 14:11:50 smsl-n100 volumio[865]: info: Received an update from plugin. extracting info from payload Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output update for this device Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output update for this device Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 435ms Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 407ms Feb 17 14:11:50 smsl-n100 volumio[865]: info: ------------------------------ 402ms Feb 17 14:11:50 smsl-n100 volumio[865]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/1/1/a48602b5-8050-4c20-a3c7-16dd186da86e.jpg' Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreStateMachine::pushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 14:11:50 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioPushState Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output update for this device Feb 17 14:11:50 smsl-n100 volumio[865]: info: MRS: Pushing multiroomSync output Feb 17 14:11:50 smsl-n100 volumio[865]: error: Serial API: Failed to decode command: 100, message: undefined Feb 17 14:11:50 smsl-n100 volumio[865]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 17 14:11:50 smsl-n100 volumio[865]: error: Serial API: Failed to decode command: 100, message: undefined Feb 17 14:11:50 smsl-n100 volumio[865]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 17 14:11:54 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioGetState Feb 17 14:11:54 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:11:56 smsl-n100 volumio[865]: info: Executing endpoint metavolumio Feb 17 14:11:56 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 14:11:56 smsl-n100 volumio[865]: info: Executing endpoint metavolumio Feb 17 14:11:56 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 14:11:56 smsl-n100 volumio[865]: info: Executing endpoint metavolumio Feb 17 14:11:56 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 14:12:00 smsl-n100 volumio[865]: error: Failed request for metavolumio API Feb 17 14:12:05 smsl-n100 volumio[865]: error: Failed request for metavolumio API Feb 17 14:12:13 smsl-n100 volumio[865]: info: CoreCommandRouter::volumioGetState Feb 17 14:12:13 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:12:15 smsl-n100 volumio[865]: info: Executing endpoint metavolumio Feb 17 14:12:15 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 14:12:15 smsl-n100 volumio[865]: info: Executing endpoint metavolumio Feb 17 14:12:15 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 14:12:15 smsl-n100 volumio[865]: info: Executing endpoint metavolumio Feb 17 14:12:15 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 14:12:16 smsl-n100 volumio[865]: info: Executing endpoint metavolumio Feb 17 14:12:16 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 14:12:18 smsl-n100 volumio[865]: info: Executing endpoint metavolumio Feb 17 14:12:18 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 14:12:19 smsl-n100 volumio[865]: info: CorePlayQueue::getTrack 0 Feb 17 14:12:19 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: mpd , goto Feb 17 14:12:19 smsl-n100 volumio[865]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/1/1/a48602b5-8050-4c20-a3c7-16dd186da86e.jpg' Feb 17 14:12:19 smsl-n100 volumio[865]: info: Executing endpoint getSimilarArtists Feb 17 14:12:19 smsl-n100 volumio[865]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Feb 17 14:12:19 smsl-n100 volumio[865]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 14:12:19 smsl-n100 volumio[865]: Error: connect ETIMEDOUT 104.16.251.55:443 Feb 17 14:12:19 smsl-n100 volumio[865]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 17 14:12:19 smsl-n100 volumio[865]: errno: -110, Feb 17 14:12:19 smsl-n100 volumio[865]: code: 'ETIMEDOUT', Feb 17 14:12:19 smsl-n100 volumio[865]: syscall: 'connect', Feb 17 14:12:19 smsl-n100 volumio[865]: address: '104.16.251.55', Feb 17 14:12:19 smsl-n100 volumio[865]: port: 443 Feb 17 14:12:19 smsl-n100 volumio[865]: } Feb 17 14:12:19 smsl-n100 volumio[865]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 14:12:20 smsl-n100 sudo[2345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-17 14:11 Feb 17 14:12:20 smsl-n100 sudo[2345]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8205c9d25502d90d2bb411bb156e1d5a8ef7404e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 20 Jan 2025 07:23:13 PM CET" VOLUMIO_VERSION="3.788" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="b3195a7f5841a4bc08e3e196c1a91b34"