-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Mon 2025-09-15 15:40:35 EDT. -- Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioNext Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::next Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::stPlaybackTimer Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::updateTrackBlock Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrackBlock Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::serviceStop Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 0 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::serviceStop Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::stop Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand stop Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand stop took 77 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::play index undefined Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::startPlaybackTimer Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::clearAddPlayTracks NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::updateTrackBlock Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrackBlock Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand stop took 2 milliseconds Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand clear Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand status took 14 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand clear took 15 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand status took 14 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand status took 13 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand status took 12 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand status took 11 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand status took 10 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand status took 9 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand status took 8 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand status took 7 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand status took 6 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand status took 5 milliseconds Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand add "NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac" Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: 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} Sep 15 15:40:25 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState stateService stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: No code Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: 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} Sep 15 15:40:25 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState stateService stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: No code Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: 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} Sep 15 15:40:25 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState stateService stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: No code Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: 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} Sep 15 15:40:25 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState stateService stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: No code Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: 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} Sep 15 15:40:25 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState stateService stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: No code Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: 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} Sep 15 15:40:25 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState stateService stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: No code Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: 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} Sep 15 15:40:25 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState stateService stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: No code Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: 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} Sep 15 15:40:25 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState stateService stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: No code Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: 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} Sep 15 15:40:25 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState stateService stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: No code Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: 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} Sep 15 15:40:25 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState stateService stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: No code Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: 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} Sep 15 15:40:25 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState stateService stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: No code Sep 15 15:40:25 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:25 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:25 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 139ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 140ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 140ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 140ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 141ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 141ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 141ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 142ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 142ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 141ms Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: error: updateQueue error: null Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 159ms Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand playlistinfo took 156 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand add "NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac" took 155 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 17ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 16ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 15ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 13ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 12ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 11ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 10ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 9ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 8ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 7ms Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::parseTrackInfo Sep 15 15:40:25 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand play Sep 15 15:40:25 volumio volumio[804]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 177ms Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: Sep 15 15:40:25 volumio volumio[804]: ---------------------------- MPD announces system playlist update Sep 15 15:40:25 volumio volumio[804]: info: Ignoring MPD Status Update Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 73ms Sep 15 15:40:25 volumio volumio[804]: info: sendMpdCommand play took 68 milliseconds Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 67ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 66ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 65ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 64ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 63ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 62ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 61ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 60ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 59ms Sep 15 15:40:25 volumio volumio[804]: info: ------------------------------ 57ms Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 18 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 17 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 14 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 12 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 11 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 11 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 10 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 9 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 8 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 8 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 7 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 6 milliseconds Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: Sep 15 15:40:26 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 24 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 20 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 20 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 21 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 20 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 20 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 20 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 19 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 20 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 17 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 16 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 15 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 14 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 13 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 12 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 11 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 11 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 10 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand status took 9 milliseconds Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseTrackInfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseTrackInfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseTrackInfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseState Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus stop Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 106ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 118ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 118ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 114ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 114ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 114ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 114ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 112ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 112ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 112ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 111ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 111ms Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 86 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 83 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 82 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 83 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 83 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 82 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 83 milliseconds Sep 15 15:40:26 volumio volumio[804]: info: sendMpdCommand playlistinfo took 82 milliseconds Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseTrackInfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseTrackInfo Sep 15 15:40:26 volumio volumio[804]: verbose: ControllerMpd::parseTrackInfo Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ControllerMpd::pushState Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::servicePushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1257,"duration":798,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"289 Kbps","isStreaming":false,"title":"01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20__18)-6096cd1f","artist":"Dead & Company","album":"Blossom Music Center, Cuyahoga Falls, OH, 6/20/2018 (Live)","uri":"NAS/music/Dead & Company/Blossom_Music_Center_Cuyahoga_Falls_OH_6__20__2018_Live-Flac-2019/01-dead_and_company-feel_like_a_stranger_(live_at_blossom_music_center_cuyahoga_falls_oh_6__20_f.flac","trackType":"flac"} Sep 15 15:40:26 volumio volumio[804]: verbose: CURRENT POSITION 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState stateService play Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::syncState currentStatus play Sep 15 15:40:26 volumio volumio[804]: info: Received an update from plugin. extracting info from payload Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:26 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:26 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 192ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 183ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 182ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 181ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 181ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 181ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 185ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 185ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 185ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 185ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 184ms Sep 15 15:40:26 volumio volumio[804]: info: ------------------------------ 184ms Sep 15 15:40:34 volumio volumio[804]: info: Preload queue cleared Sep 15 15:40:34 volumio volumio[804]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 15 15:40:34 volumio volumio[804]: info: CoreStateMachine::ClearQueue Sep 15 15:40:34 volumio volumio[804]: info: CoreStateMachine::stop Sep 15 15:40:34 volumio volumio[804]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 15 15:40:34 volumio volumio[804]: info: CoreStateMachine::stPlaybackTimer Sep 15 15:40:34 volumio volumio[804]: info: CoreStateMachine::updateTrackBlock Sep 15 15:40:34 volumio volumio[804]: info: CorePlayQueue::getTrackBlock Sep 15 15:40:34 volumio volumio[804]: info: CoreStateMachine::pushState Sep 15 15:40:34 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:34 volumio volumio[804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 15 15:40:34 volumio volumio[804]: info: CoreCommandRouter::volumioPushState Sep 15 15:40:34 volumio volumio[804]: info: CoreStateMachine::serviceStop Sep 15 15:40:34 volumio volumio[804]: info: CorePlayQueue::getTrack 38 Sep 15 15:40:34 volumio volumio[804]: info: CoreCommandRouter::serviceStop Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::stop Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand stop Sep 15 15:40:34 volumio volumio[804]: info: CorePlayQueue::clearPlayQueue Sep 15 15:40:34 volumio volumio[804]: info: CorePlayQueue::saveQueue Sep 15 15:40:34 volumio volumio[804]: info: CoreCommandRouter::volumioPushQueue Sep 15 15:40:34 volumio volumio[804]: info: CoreStateMachine::addQueueItems Sep 15 15:40:34 volumio volumio[804]: info: CorePlayQueue::addQueueItems Sep 15 15:40:34 volumio volumio[804]: info: Preload queue cleared Sep 15 15:40:34 volumio volumio[804]: info: Adding Item to queue: music-library/NAS/music/Ed Sheeran Sep 15 15:40:34 volumio volumio[804]: info: Exploding uri music-library/NAS/music/Ed Sheeran in service mpd Sep 15 15:40:34 volumio volumio[804]: info: sendMpdCommand stop took 168 milliseconds Sep 15 15:40:34 volumio volumio[804]: info: Sep 15 15:40:34 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:34 volumio volumio[804]: info: Sep 15 15:40:34 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:34 volumio volumio[804]: info: Sep 15 15:40:34 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:34 volumio volumio[804]: info: Sep 15 15:40:34 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:34 volumio volumio[804]: info: Sep 15 15:40:34 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:34 volumio volumio[804]: info: Sep 15 15:40:34 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:34 volumio volumio[804]: info: Sep 15 15:40:34 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:34 volumio volumio[804]: info: Sep 15 15:40:34 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:34 volumio volumio[804]: info: Sep 15 15:40:34 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:34 volumio volumio[804]: info: Sep 15 15:40:34 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:34 volumio volumio[804]: info: Sep 15 15:40:34 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:34 volumio volumio[804]: info: ControllerMpd::getState Sep 15 15:40:34 volumio volumio[804]: verbose: ControllerMpd::sendMpdCommand status Sep 15 15:40:35 volumio volumio[804]: info: Sep 15 15:40:35 volumio volumio[804]: ---------------------------- MPD announces state update: player Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F01.%20One.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/01. One.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F02.%20I'm%20A%20Mess.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/02. I'm A Mess.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F03.%20Sing.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/03. Sing.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F04.%20Don't.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/04. Don't.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F05.%20Nina.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/05. Nina.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F06.%20Photograph.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/06. Photograph.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F07.%20Bloodstream.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/07. Bloodstream.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F08.%20Tenerife%20Sea.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/08. Tenerife Sea.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F09.%20Runaway.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/09. Runaway.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F10.%20The%20Man.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/10. The Man.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F11.%20Thinking%20Out%20Loud.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/11. Thinking Out Loud.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2F12.%20Afire%20Love.flac&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/12. Afire Love.flac Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2FEd%20Sheeran%20-%20X%20(2014)%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D.zip&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/Ed Sheeran - X (2014) [Vinyl] [FLAC 24-bit 96 kHz].zip Sep 15 15:40:35 volumio volumio[804]: info: ALBUMART /albumart?cacheid=922&web=Ed%20Sheeran/X/medium&path=%2Fmnt%2FNAS%2Fmusic%2FEd%20Sheeran%2FEd%20Sheeran-2014-X%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D%2FEd%20Sheeran%20-%20X%20(2014)%20%5BVinyl%5D%20%5BFLAC%2024-bit%2096%20kHz%5D.zip&metadata=false Sep 15 15:40:35 volumio volumio[804]: info: URI /mnt/NAS/music/Ed Sheeran/Ed Sheeran-2014-X [Vinyl] [FLAC 24-bit 96 kHz]/Ed Sheeran - X (2014) [Vinyl] [FLAC 24-bit 96 kHz].zip Sep 15 15:40:35 volumio volumio[804]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 15 15:40:35 volumio volumio[804]: Error: Unable to resolve or reject the same promise twice Sep 15 15:40:35 volumio volumio[804]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Sep 15 15:40:35 volumio volumio[804]: at /volumio/app/plugins/music_service/mpd/index.js:2541:21 Sep 15 15:40:35 volumio volumio[804]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Sep 15 15:40:35 volumio volumio[804]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Sep 15 15:40:35 volumio volumio[804]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Sep 15 15:40:35 volumio volumio[804]: at Socket.emit (events.js:315:20) Sep 15 15:40:35 volumio volumio[804]: at addChunk (internal/streams/readable.js:309:12) Sep 15 15:40:35 volumio volumio[804]: at readableAddChunk (internal/streams/readable.js:280:11) Sep 15 15:40:35 volumio volumio[804]: at Socket.Readable.push (internal/streams/readable.js:223:10) Sep 15 15:40:35 volumio volumio[804]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Sep 15 15:40:35 volumio volumio[804]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 15 15:40:35 volumio sudo[20415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-15 15:39 Sep 15 15:40:35 volumio sudo[20415]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="1d63a568b7d5e4a317f16be7d0961cbb2d82e282" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="4f8978e0148ab5e1610548b80abf1b4b5e03ea0a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 07 Feb 2023 02:43:13 PM CET" VOLUMIO_VERSION="3.429" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3223bbb74b9427313a173f7908c19cfa"