-- Logs begin at Tue 2025-02-25 11:25:43 CST, end at Tue 2025-02-25 11:48:42 CST. -- Feb 25 11:47:53 smsl-n100 volumio[1139]: info: Preload queue cleared Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::ClearQueue Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::stop Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::stPlaybackTimer Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::updateTrackBlock Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrackBlock Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 6 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::serviceStop Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 6 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::serviceStop Feb 25 11:47:53 smsl-n100 volumio[1139]: info: ControllerMpd::stop Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::clearPlayQueue Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::saveQueue Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushQueue Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::addQueueItems Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::addQueueItems Feb 25 11:47:53 smsl-n100 volumio[1139]: info: Preload queue cleared Feb 25 11:47:53 smsl-n100 volumio[1139]: info: Adding Item to queue: music-library/USB/KINGSTON/测试曲目 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: Using cached record of: music-library/USB/KINGSTON/测试曲目 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushQueue Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::saveQueue Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::updateTrackBlock Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrackBlock Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPlay Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::play index 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::stop Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::play index undefined Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::startPlaybackTimer Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::clearAddPlayTracks USB/KINGSTON/测试曲目/左右声道测试.wav Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 11:47:53 smsl-n100 volumio[1139]: info: Feb 25 11:47:53 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:53 smsl-n100 volumio[1139]: info: sendMpdCommand stop took 78 milliseconds Feb 25 11:47:53 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:53 smsl-n100 volumio[1139]: info: sendMpdCommand stop took 35 milliseconds Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 11:47:53 smsl-n100 volumio[1139]: info: Feb 25 11:47:53 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:53 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:53 smsl-n100 volumio[1139]: info: Feb 25 11:47:53 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:53 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:53 smsl-n100 volumio[1139]: info: Feb 25 11:47:53 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:53 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:53 smsl-n100 volumio[1139]: info: Feb 25 11:47:53 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:53 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:53 smsl-n100 volumio[1139]: info: sendMpdCommand status took 22 milliseconds Feb 25 11:47:53 smsl-n100 volumio[1139]: info: sendMpdCommand clear took 18 milliseconds Feb 25 11:47:53 smsl-n100 volumio[1139]: info: sendMpdCommand status took 14 milliseconds Feb 25 11:47:53 smsl-n100 volumio[1139]: info: sendMpdCommand status took 12 milliseconds Feb 25 11:47:53 smsl-n100 volumio[1139]: info: sendMpdCommand status took 9 milliseconds Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/测试曲目/左右声道测试.wav" Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: 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} Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService stop Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus stop Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:53 smsl-n100 volumio[1139]: info: No code Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:53 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: 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} Feb 25 11:47:53 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService stop Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus stop Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:53 smsl-n100 volumio[1139]: info: No code Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:53 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:53 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: 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} Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService stop Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus stop Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: No code Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 156ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 154ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 153ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:54 smsl-n100 volumio[1139]: error: updateQueue error: null Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 165ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 158 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand add "USB/KINGSTON/测试曲目/左右声道测试.wav" took 158 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 18ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 15ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 13ms Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand play Feb 25 11:47:54 smsl-n100 volumio[1139]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 197ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 137ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand play took 129 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 125ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 121ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 118ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand status took 28 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand status took 27 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand status took 23 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand status took 20 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand status took 17 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Feb 25 11:47:54 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: 100, message: undefined Feb 25 11:47:54 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 25 11:47:54 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: 100, message: undefined Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 72 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 72 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 72 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 72 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 70 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand status took 65 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand status took 62 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand status took 59 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"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/KINGSTON/测试曲目/左右声道测试.wav","trackType":"wav"} Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus stop Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"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/KINGSTON/测试曲目/左右声道测试.wav","trackType":"wav"} Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"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/KINGSTON/测试曲目/左右声道测试.wav","trackType":"wav"} Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"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/KINGSTON/测试曲目/左右声道测试.wav","trackType":"wav"} Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"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/KINGSTON/测试曲目/左右声道测试.wav","trackType":"wav"} Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 218ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 266ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 260ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 258ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 256ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 224 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 223 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 223 milliseconds Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1464,"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/KINGSTON/测试曲目/左右声道测试.wav","trackType":"wav"} Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1464,"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/KINGSTON/测试曲目/左右声道测试.wav","trackType":"wav"} Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1464,"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/KINGSTON/测试曲目/左右声道测试.wav","trackType":"wav"} Feb 25 11:47:54 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:54 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 412ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 410ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: ------------------------------ 408ms Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:54 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:54 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: 100, message: undefined Feb 25 11:47:54 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 25 11:47:54 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: 100, message: undefined Feb 25 11:47:54 smsl-n100 volumio[1139]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 25 11:47:55 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 25 11:47:55 smsl-n100 volumio[1139]: info: CURURI: music-library/USB/KINGSTON/测试曲目 Feb 25 11:47:55 smsl-n100 volumio[1139]: info: Preload queue cleared Feb 25 11:47:55 smsl-n100 volumio[1139]: info: Preloading song: music-library/USB/KINGSTON/测试曲目/左右声道测试.wav Feb 25 11:47:55 smsl-n100 volumio[1139]: info: Exploding uri music-library/USB/KINGSTON/测试曲目/左右声道测试.wav in service mpd Feb 25 11:47:55 smsl-n100 volumio[1139]: info: ALBUMART /albumart?cacheid=877&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2F%E6%B5%8B%E8%AF%95%E6%9B%B2%E7%9B%AE%2F%E5%B7%A6%E5%8F%B3%E5%A3%B0%E9%81%93%E6%B5%8B%E8%AF%95.wav&metadata=false Feb 25 11:47:55 smsl-n100 volumio[1139]: info: URI /mnt/USB/KINGSTON/测试曲目/左右声道测试.wav Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Preload queue cleared Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::ClearQueue Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::stop Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::stPlaybackTimer Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::updateTrackBlock Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrackBlock Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:58 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::serviceStop Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 0 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::serviceStop Feb 25 11:47:58 smsl-n100 volumio[1139]: info: ControllerMpd::stop Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::clearPlayQueue Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::saveQueue Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushQueue Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::addQueueItems Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::addQueueItems Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Preload queue cleared Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Adding Item to queue: music-library/USB/KINGSTON/(9) 768k.wav Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Using cached record of: music-library/USB/KINGSTON/(9) 768k.wav Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Adding Item to queue: music-library/USB/KINGSTON/左右声道测试.wav Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Using cached record of: music-library/USB/KINGSTON/左右声道测试.wav Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Adding Item to queue: music-library/USB/KINGSTON/63372200381090822.flac Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Using cached record of: music-library/USB/KINGSTON/63372200381090822.flac Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Adding Item to queue: music-library/USB/KINGSTON/16 - 焚心似火（國語版）.flac Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Using cached record of: music-library/USB/KINGSTON/16 - 焚心似火（國語版）.flac Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Adding Item to queue: music-library/USB/KINGSTON/梁静茹 - 勇气.mp3 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Using cached record of: music-library/USB/KINGSTON/梁静茹 - 勇气.mp3 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Adding Item to queue: music-library/USB/KINGSTON/月半小夜曲.flac Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Using cached record of: music-library/USB/KINGSTON/月半小夜曲.flac Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushQueue Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::saveQueue Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::updateTrackBlock Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrackBlock Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPlay Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::play index 5 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::addQueueItems Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::addQueueItems Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Preload queue cleared Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Adding Item to queue: music-library/USB/KINGSTON/01 - 千千闕歌.flac Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Using cached record of: music-library/USB/KINGSTON/01 - 千千闕歌.flac Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Adding Item to queue: music-library/USB/KINGSTON/测试曲目 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Using cached record of: music-library/USB/KINGSTON/测试曲目 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Adding Item to queue: music-library/USB/KINGSTON/LOST.DIR Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Using cached record of: music-library/USB/KINGSTON/LOST.DIR Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Adding Item to queue: music-library/USB/KINGSTON/Android Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Using cached record of: music-library/USB/KINGSTON/Android Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::stop Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushQueue Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::saveQueue Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::play index undefined Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::updateTrackBlock Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrackBlock Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::startPlaybackTimer Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::clearAddPlayTracks USB/KINGSTON/月半小夜曲.flac Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Feb 25 11:47:58 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:58 smsl-n100 volumio[1139]: info: sendMpdCommand stop took 110 milliseconds Feb 25 11:47:58 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:58 smsl-n100 volumio[1139]: info: sendMpdCommand stop took 47 milliseconds Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Feb 25 11:47:58 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:58 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Feb 25 11:47:58 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:58 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Feb 25 11:47:58 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:58 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Feb 25 11:47:58 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:58 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:58 smsl-n100 volumio[1139]: info: sendMpdCommand status took 33 milliseconds Feb 25 11:47:58 smsl-n100 volumio[1139]: info: sendMpdCommand clear took 31 milliseconds Feb 25 11:47:58 smsl-n100 volumio[1139]: info: sendMpdCommand status took 25 milliseconds Feb 25 11:47:58 smsl-n100 volumio[1139]: info: sendMpdCommand status took 18 milliseconds Feb 25 11:47:58 smsl-n100 volumio[1139]: info: sendMpdCommand status took 13 milliseconds Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/月半小夜曲.flac" Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:58 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:58 smsl-n100 volumio[1139]: 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} Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 5 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService stop Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus stop Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:58 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:58 smsl-n100 volumio[1139]: info: No code Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:58 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:58 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:58 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:58 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:58 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:58 smsl-n100 volumio[1139]: 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} Feb 25 11:47:58 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService stop Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus stop Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: No code Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: 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} Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService stop Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus stop Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: No code Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 167ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 162ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 156ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:59 smsl-n100 volumio[1139]: error: updateQueue error: null Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 164ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 156 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand add "USB/KINGSTON/月半小夜曲.flac" took 156 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 17ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 14ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 11ms Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand play Feb 25 11:47:59 smsl-n100 volumio[1139]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 208ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces system playlist update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Ignoring MPD Status Update Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 156ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand play took 148 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 147ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 140ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 137ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand status took 29 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand status took 26 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand status took 22 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand status took 15 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand status took 10 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Feb 25 11:47:59 smsl-n100 volumio[1139]: ---------------------------- MPD announces state update: player Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::getState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: 100, message: undefined Feb 25 11:47:59 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 25 11:47:59 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: 100, message: undefined Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 59 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 58 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 58 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 57 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 58 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand status took 50 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand status took 44 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand status took 41 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseState Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850,"duration":295,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4866 Kbps","isStreaming":false,"title":"月半小夜曲","artist":"李克勤","album":"无损","uri":"USB/KINGSTON/月半小夜曲.flac","trackType":"flac"} Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus stop Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850,"duration":295,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4866 Kbps","isStreaming":false,"title":"月半小夜曲","artist":"李克勤","album":"无损","uri":"USB/KINGSTON/月半小夜曲.flac","trackType":"flac"} Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850,"duration":295,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4866 Kbps","isStreaming":false,"title":"月半小夜曲","artist":"李克勤","album":"无损","uri":"USB/KINGSTON/月半小夜曲.flac","trackType":"flac"} Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":934,"duration":295,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4887 Kbps","isStreaming":false,"title":"月半小夜曲","artist":"李克勤","album":"无损","uri":"USB/KINGSTON/月半小夜曲.flac","trackType":"flac"} Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":934,"duration":295,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4887 Kbps","isStreaming":false,"title":"月半小夜曲","artist":"李克勤","album":"无损","uri":"USB/KINGSTON/月半小夜曲.flac","trackType":"flac"} Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 213ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 254ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 244ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 241ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 235ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 214 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 213 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: info: sendMpdCommand playlistinfo took 213 milliseconds Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: ControllerMpd::parseTrackInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":934,"duration":295,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4887 Kbps","isStreaming":false,"title":"月半小夜曲","artist":"李克勤","album":"无损","uri":"USB/KINGSTON/月半小夜曲.flac","trackType":"flac"} Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1021,"duration":295,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4855 Kbps","isStreaming":false,"title":"月半小夜曲","artist":"李克勤","album":"无损","uri":"USB/KINGSTON/月半小夜曲.flac","trackType":"flac"} Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ControllerMpd::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::servicePushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1021,"duration":295,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4855 Kbps","isStreaming":false,"title":"月半小夜曲","artist":"李克勤","album":"无损","uri":"USB/KINGSTON/月半小夜曲.flac","trackType":"flac"} Feb 25 11:47:59 smsl-n100 volumio[1139]: verbose: CURRENT POSITION 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState stateService play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::syncState currentStatus play Feb 25 11:47:59 smsl-n100 volumio[1139]: info: Received an update from plugin. extracting info from payload Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 377ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 375ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: ------------------------------ 370ms Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreStateMachine::pushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CorePlayQueue::getTrack 5 Feb 25 11:47:59 smsl-n100 volumio[1139]: info: CoreCommandRouter::volumioPushState Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output update for this device Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MRS: Pushing multiroomSync output Feb 25 11:47:59 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: 100, message: undefined Feb 25 11:47:59 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 25 11:47:59 smsl-n100 volumio[1139]: error: Serial API: Failed to decode command: 100, message: undefined Feb 25 11:47:59 smsl-n100 volumio[1139]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 25 11:48:41 smsl-n100 volumio[1139]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 11:48:41 smsl-n100 volumio[1139]: Error: connect ETIMEDOUT 157.240.16.50:443 Feb 25 11:48:41 smsl-n100 volumio[1139]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 25 11:48:41 smsl-n100 volumio[1139]: errno: -110, Feb 25 11:48:41 smsl-n100 volumio[1139]: code: 'ETIMEDOUT', Feb 25 11:48:41 smsl-n100 volumio[1139]: syscall: 'connect', Feb 25 11:48:41 smsl-n100 volumio[1139]: address: '157.240.16.50', Feb 25 11:48:41 smsl-n100 volumio[1139]: port: 443 Feb 25 11:48:41 smsl-n100 volumio[1139]: } Feb 25 11:48:41 smsl-n100 volumio[1139]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 11:48:42 smsl-n100 sudo[6641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-25 11:47 Feb 25 11:48:42 smsl-n100 sudo[6641]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"