-- Logs begin at Fri 2024-11-29 09:18:21 CST, end at Mon 2024-12-02 14:47:16 CST. -- Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Preload queue cleared Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::ClearQueue Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::stop Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::stPlaybackTimer Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::updateTrackBlock Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrackBlock Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 5 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::serviceStop Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 5 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::serviceStop Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::stop Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::clearPlayQueue Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::saveQueue Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushQueue Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::addQueueItems Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::addQueueItems Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Preload queue cleared Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/(1) 44.1k.WAV Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/(1) 44.1k.WAV Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/(9) 768k.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/(9) 768k.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/1khz dsd64.dsf Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/1khz dsd64.dsf Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/256.dff Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/256.dff Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushQueue Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::saveQueue Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::updateTrackBlock Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrackBlock Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPlay Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::play index 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::addQueueItems Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::addQueueItems Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Preload queue cleared Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/3571544916.mp3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/3571544916.mp3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/DSD64天使.dff Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/DSD64天使.dff Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/刘德丽 - 新曲+精选[头版MQA-CD限量版].wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/刘德丽 - 新曲+精选[头版MQA-CD限量版].wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/左右声道测试.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/左右声道测试.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/63372200381090822.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/63372200381090822.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/蔡依林 - 大艺术家.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/蔡依林 - 大艺术家.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/(9) 705.6k.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/(9) 705.6k.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/16 - 焚心似火（國語版）.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/16 - 焚心似火（國語版）.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.dsf Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.dsf Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/10. 1KHz Sine Wave, 0 dB, R, emphasis off.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/10. 1KHz Sine Wave, 0 dB, R, emphasis off.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/11. 10KHz Sine Wave, 0 dB, R, emphasis off.dsf Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/11. 10KHz Sine Wave, 0 dB, R, emphasis off.dsf Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/01. Bad Romance.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/01. Bad Romance.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/发如雪.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/发如雪.wav Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/萨顶顶 - 左手指月 DSD512.dsf Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/萨顶顶 - 左手指月 DSD512.dsf Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/14 - 春风满小城.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/14 - 春风满小城.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/01 - 千千闕歌.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/01 - 千千闕歌.flac Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/DSD128 5.6 MHZ兄弟抱一下.dsf Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/DSD128 5.6 MHZ兄弟抱一下.dsf Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/表头音频文件 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/表头音频文件 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::stop Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushQueue Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::saveQueue Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::play index undefined Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::updateTrackBlock Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrackBlock Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::startPlaybackTimer Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::clearAddPlayTracks USB/ESDUSB/256.dff Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand stop took 69 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand stop took 17 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand clear Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand status took 9 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand clear took 11 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand status took 9 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand status took 8 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand add "USB/ESDUSB/256.dff" Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 64ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 63ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:03 smsl-d400n volumio[1336]: error: updateQueue error: null Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 72ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 66 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand add "USB/ESDUSB/256.dff" took 67 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 13ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 11ms Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand play Dec 02 14:46:03 smsl-d400n volumio[1336]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 86ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 43ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand play took 40 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 39ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 38ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:03 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MCU Signalled Playback Inactive Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand status took 10 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand status took 10 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand status took 8 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand status took 6 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Dec 02 14:46:03 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 11 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 11 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 11 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand status took 7 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand status took 6 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":68,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"256.dff","artist":null,"album":null,"uri":"USB/ESDUSB/256.dff","trackType":"dff"} Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":68,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"256.dff","artist":null,"album":null,"uri":"USB/ESDUSB/256.dff","trackType":"dff"} Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":68,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"256.dff","artist":null,"album":null,"uri":"USB/ESDUSB/256.dff","trackType":"dff"} Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":68,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"256.dff","artist":null,"album":null,"uri":"USB/ESDUSB/256.dff","trackType":"dff"} Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 71ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 94ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 90ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 89ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 76 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 75 milliseconds Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":68,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"256.dff","artist":null,"album":null,"uri":"USB/ESDUSB/256.dff","trackType":"dff"} Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":68,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"256.dff","artist":null,"album":null,"uri":"USB/ESDUSB/256.dff","trackType":"dff"} Dec 02 14:46:03 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:03 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:03 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:03 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 128ms Dec 02 14:46:03 smsl-d400n volumio[1336]: info: ------------------------------ 126ms Dec 02 14:46:03 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:03 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Preload queue cleared Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::ClearQueue Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::stop Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::stPlaybackTimer Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::updateTrackBlock Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrackBlock Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::serviceStop Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 3 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::serviceStop Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::stop Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::clearPlayQueue Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::saveQueue Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushQueue Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::addQueueItems Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::addQueueItems Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Preload queue cleared Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/(1) 44.1k.WAV Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/(1) 44.1k.WAV Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/(9) 768k.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/(9) 768k.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/1khz dsd64.dsf Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/1khz dsd64.dsf Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/256.dff Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/256.dff Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/3571544916.mp3 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/3571544916.mp3 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/DSD64天使.dff Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/DSD64天使.dff Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/刘德丽 - 新曲+精选[头版MQA-CD限量版].wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/刘德丽 - 新曲+精选[头版MQA-CD限量版].wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/左右声道测试.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/左右声道测试.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushQueue Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::saveQueue Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::updateTrackBlock Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrackBlock Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPlay Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::play index 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::addQueueItems Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::addQueueItems Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Preload queue cleared Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/63372200381090822.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/63372200381090822.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/蔡依林 - 大艺术家.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/蔡依林 - 大艺术家.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/(9) 705.6k.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/(9) 705.6k.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/16 - 焚心似火（國語版）.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/16 - 焚心似火（國語版）.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.dsf Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.dsf Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/10. 1KHz Sine Wave, 0 dB, R, emphasis off.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/10. 1KHz Sine Wave, 0 dB, R, emphasis off.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/11. 10KHz Sine Wave, 0 dB, R, emphasis off.dsf Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/11. 10KHz Sine Wave, 0 dB, R, emphasis off.dsf Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/01. Bad Romance.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/01. Bad Romance.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/发如雪.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/发如雪.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/萨顶顶 - 左手指月 DSD512.dsf Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/萨顶顶 - 左手指月 DSD512.dsf Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/14 - 春风满小城.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/14 - 春风满小城.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/01 - 千千闕歌.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/01 - 千千闕歌.flac Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/DSD128 5.6 MHZ兄弟抱一下.dsf Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/DSD128 5.6 MHZ兄弟抱一下.dsf Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/表头音频文件 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/表头音频文件 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::stop Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushQueue Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::saveQueue Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::play index undefined Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::updateTrackBlock Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrackBlock Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::startPlaybackTimer Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::clearAddPlayTracks USB/ESDUSB/左右声道测试.wav Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand stop took 72 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand stop took 19 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand clear Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand status took 13 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand clear took 13 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand status took 11 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand status took 10 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand add "USB/ESDUSB/左右声道测试.wav" Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:08 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:08 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 66ms Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 66ms Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:08 smsl-d400n volumio[1336]: error: updateQueue error: null Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 85ms Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 81 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand add "USB/ESDUSB/左右声道测试.wav" took 82 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 27ms Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 25ms Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand play Dec 02 14:46:08 smsl-d400n volumio[1336]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 102ms Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 49ms Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand play took 45 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 44ms Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 43ms Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Dec 02 14:46:08 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:08 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MCU Signalled Playback Inactive Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand status took 20 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand status took 18 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand status took 16 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":245,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"左右声道测试.wav","artist":null,"album":null,"uri":"USB/ESDUSB/左右声道测试.wav","trackType":"wav"} Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":245,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"左右声道测试.wav","artist":null,"album":null,"uri":"USB/ESDUSB/左右声道测试.wav","trackType":"wav"} Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":245,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"左右声道测试.wav","artist":null,"album":null,"uri":"USB/ESDUSB/左右声道测试.wav","trackType":"wav"} Dec 02 14:46:08 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:08 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:08 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:08 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 55ms Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 66ms Dec 02 14:46:08 smsl-d400n volumio[1336]: info: ------------------------------ 65ms Dec 02 14:46:08 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:08 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Preload queue cleared Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::ClearQueue Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::stop Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::stPlaybackTimer Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::updateTrackBlock Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrackBlock Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::serviceStop Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 7 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::serviceStop Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::stop Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::clearPlayQueue Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::saveQueue Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushQueue Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::addQueueItems Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::addQueueItems Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Preload queue cleared Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/(1) 44.1k.WAV Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/(1) 44.1k.WAV Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/(9) 768k.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/(9) 768k.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/1khz dsd64.dsf Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/1khz dsd64.dsf Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/256.dff Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/256.dff Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/3571544916.mp3 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/3571544916.mp3 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/DSD64天使.dff Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/DSD64天使.dff Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/刘德丽 - 新曲+精选[头版MQA-CD限量版].wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/刘德丽 - 新曲+精选[头版MQA-CD限量版].wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/左右声道测试.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/左右声道测试.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/63372200381090822.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/63372200381090822.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/蔡依林 - 大艺术家.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/蔡依林 - 大艺术家.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/(9) 705.6k.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/(9) 705.6k.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushQueue Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::saveQueue Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::updateTrackBlock Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrackBlock Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPlay Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::play index 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::addQueueItems Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::addQueueItems Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Preload queue cleared Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/16 - 焚心似火（國語版）.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/16 - 焚心似火（國語版）.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.dsf Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.dsf Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/08. 1KHz Sine Wave, 0 dB, L, emphasis off.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/10. 1KHz Sine Wave, 0 dB, R, emphasis off.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/10. 1KHz Sine Wave, 0 dB, R, emphasis off.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/11. 10KHz Sine Wave, 0 dB, R, emphasis off.dsf Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/11. 10KHz Sine Wave, 0 dB, R, emphasis off.dsf Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/01. Bad Romance.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/01. Bad Romance.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/发如雪.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/发如雪.wav Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/萨顶顶 - 左手指月 DSD512.dsf Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/萨顶顶 - 左手指月 DSD512.dsf Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/14 - 春风满小城.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/14 - 春风满小城.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/01 - 千千闕歌.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/01 - 千千闕歌.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/DSD128 5.6 MHZ兄弟抱一下.dsf Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/DSD128 5.6 MHZ兄弟抱一下.dsf Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Adding Item to queue: music-library/USB/ESDUSB/表头音频文件 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Using cached record of: music-library/USB/ESDUSB/表头音频文件 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::stop Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushQueue Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::saveQueue Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::play index undefined Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::updateTrackBlock Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrackBlock Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::startPlaybackTimer Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::clearAddPlayTracks USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand stop took 88 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand stop took 21 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand clear Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand status took 10 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand clear took 8 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand status took 7 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand status took 5 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand add "USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac" Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 63ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 62ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:19 smsl-d400n volumio[1336]: error: updateQueue error: null Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 73ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 70 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand add "USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac" took 70 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 15ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 13ms Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand play Dec 02 14:46:19 smsl-d400n volumio[1336]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 87ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:19 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 73ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand play took 69 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 71ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 69ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand status took 20 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand status took 18 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand status took 14 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand status took 12 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Dec 02 14:46:19 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 41 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand status took 39 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand status took 38 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850,"duration":391,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4963 Kbps","isStreaming":false,"title":"Hotel California","artist":"Eagles","album":"Hotel California","uri":"USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac","trackType":"flac"} Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850,"duration":391,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4963 Kbps","isStreaming":false,"title":"Hotel California","artist":"Eagles","album":"Hotel California","uri":"USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac","trackType":"flac"} Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850,"duration":391,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4963 Kbps","isStreaming":false,"title":"Hotel California","artist":"Eagles","album":"Hotel California","uri":"USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac","trackType":"flac"} Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850,"duration":391,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4963 Kbps","isStreaming":false,"title":"Hotel California","artist":"Eagles","album":"Hotel California","uri":"USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac","trackType":"flac"} Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 119ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 139ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 130ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 128ms Dec 02 14:46:19 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:19 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:19 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:19 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:19 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 76 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 75 milliseconds Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850,"duration":391,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4963 Kbps","isStreaming":false,"title":"Hotel California","artist":"Eagles","album":"Hotel California","uri":"USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac","trackType":"flac"} Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":934,"duration":391,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4943 Kbps","isStreaming":false,"title":"Hotel California","artist":"Eagles","album":"Hotel California","uri":"USB/ESDUSB/Eagles_-_01_-_Hotel_California.flac","trackType":"flac"} Dec 02 14:46:19 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:19 smsl-d400n volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:19 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:19 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 164ms Dec 02 14:46:19 smsl-d400n volumio[1336]: info: ------------------------------ 163ms Dec 02 14:46:19 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:19 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:19 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:19 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:19 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:19 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:19 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:19 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:20 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:30 smsl-d400n volumiologrotate[717]: ls: cannot access '/var/log/samba/log.wb-SMSL': No such file or directory Dec 02 14:46:30 smsl-d400n kernel: usb 2-1: USB disconnect, device number 3 Dec 02 14:46:30 smsl-d400n volumiologrotate[717]: ls: cannot access 'D400N': No such file or directory Dec 02 14:46:30 smsl-d400n volumio[1336]: info: Partition removed: {"syspath":"/sys/devices/platform/ff600000.usb/xhci-hcd.0.auto/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-xhci-hcd.0.auto-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-uuid/5E22-988A /dev/disk/by-partuuid/66be38ce-01 /dev/disk/by-label/ESDUSB /dev/disk/by-id/usb-Generic_Flash_Disk_423E72E3-0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/ff600000.usb/xhci-hcd.0.auto/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"12","ID_BUS":"usb","ID_FS_LABEL":"ESDUSB","ID_FS_LABEL_ENC":"ESDUSB","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"5E22-988A","ID_FS_UUID_ENC":"5E22-988A","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"Flash_Disk","ID_MODEL_ENC":"Flash\\x20Disk\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"7788","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"15767552","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"66be38ce-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"66be38ce","ID_PATH":"platform-xhci-hcd.0.auto-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0_auto-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"8.07","ID_SERIAL":"Generic_Flash_Disk_423E72E3-0:0","ID_SERIAL_SHORT":"423E72E3","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Generic","ID_VENDOR_ENC":"Generic\\x20","ID_VENDOR_ID":"0011","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"3053","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"1725844205"} Dec 02 14:46:30 smsl-d400n sudo[7200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Dec 02 14:46:30 smsl-d400n sudo[7200]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 14:46:30 smsl-d400n sudo[7200]: pam_unix(sudo:session): session closed for user root Dec 02 14:46:30 smsl-d400n volumio[1336]: umount: /media/ESDUSB: target is busy. Dec 02 14:46:30 smsl-d400n volumio[1336]: error: Failed to umount ESDUSB: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sda1" Dec 02 14:46:30 smsl-d400n volumio[1336]: umount: /media/ESDUSB: target is busy. Dec 02 14:46:30 smsl-d400n kernel: FAT-fs (sda1): FAT read failed (blocknr 2417) Dec 02 14:46:30 smsl-d400n kernel: FAT-fs (sda1): FAT read failed (blocknr 2417) Dec 02 14:46:30 smsl-d400n kernel: FAT-fs (sda1): FAT read failed (blocknr 2417) Dec 02 14:46:30 smsl-d400n kernel: FAT-fs (sda1): FAT read failed (blocknr 2417) Dec 02 14:46:30 smsl-d400n kernel: FAT-fs (sda1): FAT read failed (blocknr 2417) Dec 02 14:46:30 smsl-d400n kernel: FAT-fs (sda1): FAT read failed (blocknr 2417) Dec 02 14:46:30 smsl-d400n kernel: FAT-fs (sda1): FAT read failed (blocknr 2417) Dec 02 14:46:30 smsl-d400n kernel: FAT-fs (sda1): FAT read failed (blocknr 2417) Dec 02 14:46:30 smsl-d400n kernel: FAT-fs (sda1): FAT read failed (blocknr 2417) Dec 02 14:46:30 smsl-d400n kernel: FAT-fs (sda1): FAT read failed (blocknr 2417) Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Dec 02 14:46:32 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Dec 02 14:46:32 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Dec 02 14:46:32 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:32 smsl-d400n volumio[1336]: info: sendMpdCommand status took 8 milliseconds Dec 02 14:46:32 smsl-d400n volumio[1336]: info: sendMpdCommand status took 5 milliseconds Dec 02 14:46:32 smsl-d400n volumio[1336]: info: sendMpdCommand status took 3 milliseconds Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 11 Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 11 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::play index undefined Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:32 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:32 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::startPlaybackTimer Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: ControllerMpd::clearAddPlayTracks USB/ESDUSB/16 - 焚心似火（國語版）.flac Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ------------------------------ 105ms Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ------------------------------ 103ms Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ------------------------------ 102ms Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:32 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:32 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:32 smsl-d400n volumio[1336]: info: sendMpdCommand stop took 18 milliseconds Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand clear Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Dec 02 14:46:32 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:32 smsl-d400n volumio[1336]: info: sendMpdCommand clear took 43 milliseconds Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand add "USB/ESDUSB/16 - 焚心似火（國語版）.flac" Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Dec 02 14:46:32 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Dec 02 14:46:32 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:32 smsl-d400n volumio[1336]: error: updateQueue error: null Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Dec 02 14:46:32 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ------------------------------ 13ms Dec 02 14:46:32 smsl-d400n volumio[1336]: info: sendMpdCommand add "USB/ESDUSB/16 - 焚心似火（國語版）.flac" took 12 milliseconds Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ------------------------------ 11ms Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ------------------------------ 10ms Dec 02 14:46:32 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand play Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Dec 02 14:46:32 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Dec 02 14:46:32 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:32 smsl-d400n volumio[1336]: info: Dec 02 14:46:32 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ------------------------------ 19ms Dec 02 14:46:32 smsl-d400n volumio[1336]: info: sendMpdCommand play took 17 milliseconds Dec 02 14:46:32 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:33 smsl-d400n volumio[1336]: info: ------------------------------ 16ms Dec 02 14:46:33 smsl-d400n volumio[1336]: info: ------------------------------ 14ms Dec 02 14:46:33 smsl-d400n volumio[1336]: info: Dec 02 14:46:33 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:33 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:33 smsl-d400n volumio[1336]: info: Dec 02 14:46:33 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: player Dec 02 14:46:33 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 02 14:46:33 smsl-d400n volumio[1336]: info: sendMpdCommand status took 36 milliseconds Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 02 14:46:33 smsl-d400n volumio[1336]: info: sendMpdCommand status took 35 milliseconds Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 02 14:46:33 smsl-d400n volumio[1336]: info: sendMpdCommand status took 33 milliseconds Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 14:46:33 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:33 smsl-d400n volumio[1336]: info: sendMpdCommand clearerror took 23 milliseconds Dec 02 14:46:33 smsl-d400n volumio[1336]: info: sendMpdCommand clearerror took 23 milliseconds Dec 02 14:46:33 smsl-d400n volumio[1336]: info: sendMpdCommand clearerror took 22 milliseconds Dec 02 14:46:33 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 02 14:46:33 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 02 14:46:33 smsl-d400n volumio[1336]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 02 14:46:33 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: 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":"16 - 焚心似火（國語版）","artist":"葉倩文","album":"SACD COLLECTION（限量版）","uri":"USB/ESDUSB/16 - 焚心似火（國語版）.flac","trackType":"flac"} Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:33 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:33 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: 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":"16 - 焚心似火（國語版）","artist":"葉倩文","album":"SACD COLLECTION（限量版）","uri":"USB/ESDUSB/16 - 焚心似火（國語版）.flac","trackType":"flac"} Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:33 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:33 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: 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":"16 - 焚心似火（國語版）","artist":"葉倩文","album":"SACD COLLECTION（限量版）","uri":"USB/ESDUSB/16 - 焚心似火（國語版）.flac","trackType":"flac"} Dec 02 14:46:33 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:33 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:33 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:33 smsl-d400n volumio[1336]: info: ------------------------------ 186ms Dec 02 14:46:33 smsl-d400n volumio[1336]: info: ------------------------------ 184ms Dec 02 14:46:33 smsl-d400n volumio[1336]: info: ------------------------------ 183ms Dec 02 14:46:33 smsl-d400n volumio[1336]: info: MCU Signalled Playback Inactive Dec 02 14:46:33 smsl-d400n volumio[1336]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/9ab8e4cf-e549-4665-b984-2a00c82c635d.jpg' Dec 02 14:46:33 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:35 smsl-d400n kernel: fat__get_entry: 1726 callbacks suppressed Dec 02 14:46:35 smsl-d400n kernel: FAT-fs (sda1): Directory bread(block 32768) failed Dec 02 14:46:35 smsl-d400n kernel: FAT-fs (sda1): Directory bread(block 32769) failed Dec 02 14:46:35 smsl-d400n kernel: FAT-fs (sda1): Directory bread(block 32770) failed Dec 02 14:46:35 smsl-d400n kernel: FAT-fs (sda1): Directory bread(block 32771) failed Dec 02 14:46:35 smsl-d400n kernel: FAT-fs (sda1): Directory bread(block 32772) failed Dec 02 14:46:35 smsl-d400n kernel: FAT-fs (sda1): Directory bread(block 32773) failed Dec 02 14:46:35 smsl-d400n kernel: FAT-fs (sda1): Directory bread(block 32774) failed Dec 02 14:46:35 smsl-d400n kernel: FAT-fs (sda1): Directory bread(block 32775) failed Dec 02 14:46:35 smsl-d400n kernel: FAT-fs (sda1): Directory bread(block 409664) failed Dec 02 14:46:35 smsl-d400n kernel: FAT-fs (sda1): Directory bread(block 409665) failed Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Scanning removed location : "USB/ESDUSB" Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: update Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: update Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: update Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MPD Database updated - AlbumList cache refreshed Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: database Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: update Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 17 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 15 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 14 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 14 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 13 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 12 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Command Router : Notfying DB Updatetrue Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::Close All Modals sent Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Command Router : Notfying DB Updatetrue Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::Close All Modals sent Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Command Router : Notfying DB Updatefalse Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::Close All Modals sent Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ------------------------------ 267ms Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ------------------------------ 264ms Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ------------------------------ 263ms Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MPD Database updated - AlbumList cache refreshed Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: database Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces system playlist update Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Ignoring MPD Status Update Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: update Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: error: updateQueue error: null Dec 02 14:46:35 smsl-d400n volumio[1336]: error: updateQueue error: null Dec 02 14:46:35 smsl-d400n volumio[1336]: error: updateQueue error: null Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 275 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ------------------------------ 278ms Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 273 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 271 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ------------------------------ 19ms Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 16 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 14 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ------------------------------ 18ms Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 14 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Command Router : Notfying DB Updatefalse Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::Close All Modals sent Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Command Router : Notfying DB Updatefalse Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::Close All Modals sent Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:35 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ------------------------------ 482ms Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ------------------------------ 483ms Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ------------------------------ 226ms Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ------------------------------ 227ms Dec 02 14:46:35 smsl-d400n volumio[1336]: info: MPD Database updated - AlbumList cache refreshed Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: database Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: Dec 02 14:46:35 smsl-d400n volumio[1336]: ---------------------------- MPD announces state update: update Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: ControllerMpd::getState Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 116 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 114 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: info: sendMpdCommand status took 114 milliseconds Dec 02 14:46:35 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: Command Router : Notfying DB Updatefalse Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreCommandRouter::Close All Modals sent Dec 02 14:46:36 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:36 smsl-d400n volumio[1336]: verbose: ControllerMpd::parseState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:36 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:36 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:36 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:36 smsl-d400n volumio[1336]: info: ControllerMpd::pushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreCommandRouter::servicePushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:36 smsl-d400n volumio[1336]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 02 14:46:36 smsl-d400n volumio[1336]: verbose: CURRENT POSITION 12 Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState stateService stop Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:36 smsl-d400n volumio[1336]: info: No code Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreStateMachine::pushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CorePlayQueue::getTrack 12 Dec 02 14:46:36 smsl-d400n volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output update for this device Dec 02 14:46:36 smsl-d400n volumio[1336]: info: MRS: Pushing multiroomSync output Dec 02 14:46:36 smsl-d400n volumio[1336]: info: ------------------------------ 226ms Dec 02 14:46:36 smsl-d400n volumio[1336]: info: ------------------------------ 227ms Dec 02 14:46:36 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:36 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:46:36 smsl-d400n volumio[1336]: error: Serial API: Failed to decode command: GET, message: STATE Dec 02 14:47:16 smsl-d400n volumio[1336]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 02 14:47:16 smsl-d400n volumio[1336]: Error: connect ETIMEDOUT 162.125.32.2:443 Dec 02 14:47:16 smsl-d400n volumio[1336]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Dec 02 14:47:16 smsl-d400n volumio[1336]: errno: -110, Dec 02 14:47:16 smsl-d400n volumio[1336]: code: 'ETIMEDOUT', Dec 02 14:47:16 smsl-d400n volumio[1336]: syscall: 'connect', Dec 02 14:47:16 smsl-d400n volumio[1336]: address: '162.125.32.2', Dec 02 14:47:16 smsl-d400n volumio[1336]: port: 443 Dec 02 14:47:16 smsl-d400n volumio[1336]: } Dec 02 14:47:16 smsl-d400n volumio[1336]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 02 14:47:16 smsl-d400n sudo[7308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-02 14:46 Dec 02 14:47:16 smsl-d400n sudo[7308]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 14 Nov 2024 10:37:31 AM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="nanopineo3-armbian" VOLUMIO_DEVICENAME="NanoPi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="693350a73c5f32caa813f2d9ff9306ea"