-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2024-04-22 20:37:24 CEST. -- Apr 22 20:36:13 volumio volumio[702]: info: Preload queue cleared Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::ClearQueue Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::stPlaybackTimer Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 5 Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::serviceStop Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 5 Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::serviceStop Apr 22 20:36:13 volumio volumio[702]: info: ControllerMpd::stop Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::clearPlayQueue Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::saveQueue Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushQueue Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::addQueueItems Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::addQueueItems Apr 22 20:36:13 volumio volumio[702]: info: Preload queue cleared Apr 22 20:36:13 volumio volumio[702]: info: Adding Item to queue: music-library/NAS/NAS/Bettye Lavette - Things Have Changed Apr 22 20:36:13 volumio volumio[702]: info: Exploding uri music-library/NAS/NAS/Bettye Lavette - Things Have Changed in service mpd Apr 22 20:36:13 volumio volumio[702]: info: sendMpdCommand stop took 58 milliseconds Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:13 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:13 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:13 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F01.%20Bettye%20Lavette%20-%20Things%20Have%20Changed.flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/01. Bettye Lavette - Things Have Changed.flac Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F02.%20Bettye%20Lavette%20-%20It%20Ain%E2%80%99t%20Me%20Babe.flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/02. Bettye Lavette - It Ain’t Me Babe.flac Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F03.%20Bettye%20Lavette%20-%20Political%20World.flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/03. Bettye Lavette - Political World.flac Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F04.%20Bettye%20Lavette%20-%20Don%E2%80%99t%20Fall%20Apart%20On%20Me%20Tonight.flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/04. Bettye Lavette - Don’t Fall Apart On Me Tonight.flac Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F05.%20Bettye%20Lavette%20-%20Seeing%20The%20Real%20You%20At%20Last.flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F06.%20Bettye%20Lavette%20-%20Mama%2C%20You%20Been%20On%20My%20Mind.flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/06. Bettye Lavette - Mama, You Been On My Mind.flac Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F07.%20Bettye%20Lavette%20-%20Ain%E2%80%99t%20Talkin%E2%80%99.flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/07. Bettye Lavette - Ain’t Talkin’.flac Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F08.%20Bettye%20Lavette%20-%20The%20Times%20They%20Are%20A-Changin'.flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/08. Bettye Lavette - The Times They Are A-Changin'.flac Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F09.%20Bettye%20Lavette%20-%20What%20Was%20It%20You%20Wanted.flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/09. Bettye Lavette - What Was It You Wanted.flac Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F10.%20Bettye%20Lavette%20-%20Emotionally%20Yours.flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/10. Bettye Lavette - Emotionally Yours.flac Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F11.%20Bettye%20Lavette%20-%20Do%20Right%20To%20Me%20Baby%20(Do%20Unto%20Others).flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/11. Bettye Lavette - Do Right To Me Baby (Do Unto Others).flac Apr 22 20:36:13 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/Things%20Have%20Changed/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%20Things%20Have%20Changed%2F12.%20Bettye%20Lavette%20-%20Going%2C%20Going%2C%20Gone.flac&metadata=false Apr 22 20:36:13 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - Things Have Changed/12. Bettye Lavette - Going, Going, Gone.flac Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushQueue Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::saveQueue Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPlay Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::play index 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::play index undefined Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::startPlaybackTimer Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Bettye Lavette - Things Have Changed/01. Bettye Lavette - Things Have Changed.flac Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:13 volumio volumio[702]: info: sendMpdCommand status took 16 milliseconds Apr 22 20:36:13 volumio volumio[702]: info: sendMpdCommand status took 15 milliseconds Apr 22 20:36:13 volumio volumio[702]: info: sendMpdCommand status took 14 milliseconds Apr 22 20:36:13 volumio volumio[702]: info: sendMpdCommand stop took 1 milliseconds Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand clear Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:13 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:13 volumio volumio[702]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 20:36:13 volumio volumio[702]: info: sendMpdCommand clear took 2 milliseconds Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Bettye Lavette - Things Have Changed/01. Bettye Lavette - Things Have Changed.flac" Apr 22 20:36:13 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Except The New Girl","artist":"Chris Isaak","album":"San Francisco Days ","uri":"NAS/NAS/Chris Isaak - San Francisco Days - 1993/06. Except The New Girl.flac","trackType":"flac"} Apr 22 20:36:13 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:13 volumio volumio[702]: info: No code Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:13 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Except The New Girl","artist":"Chris Isaak","album":"San Francisco Days ","uri":"NAS/NAS/Chris Isaak - San Francisco Days - 1993/06. Except The New Girl.flac","trackType":"flac"} Apr 22 20:36:13 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:13 volumio volumio[702]: info: No code Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:13 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Except The New Girl","artist":"Chris Isaak","album":"San Francisco Days ","uri":"NAS/NAS/Chris Isaak - San Francisco Days - 1993/06. Except The New Girl.flac","trackType":"flac"} Apr 22 20:36:13 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:13 volumio volumio[702]: info: No code Apr 22 20:36:13 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:13 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:13 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:13 volumio volumio[702]: info: ------------------------------ 34ms Apr 22 20:36:13 volumio volumio[702]: info: ------------------------------ 33ms Apr 22 20:36:13 volumio volumio[702]: info: ------------------------------ 34ms Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:13 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:13 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:13 volumio volumio[702]: error: updateQueue error: null Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:13 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:13 volumio volumio[702]: info: ------------------------------ 24ms Apr 22 20:36:13 volumio volumio[702]: info: sendMpdCommand add "NAS/NAS/Bettye Lavette - Things Have Changed/01. Bettye Lavette - Things Have Changed.flac" took 23 milliseconds Apr 22 20:36:13 volumio volumio[702]: info: ------------------------------ 2ms Apr 22 20:36:13 volumio volumio[702]: info: ------------------------------ 1ms Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand play Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:13 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:13 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:13 volumio volumio[702]: info: ------------------------------ 6ms Apr 22 20:36:13 volumio volumio[702]: info: sendMpdCommand play took 6 milliseconds Apr 22 20:36:13 volumio volumio[702]: info: ------------------------------ 6ms Apr 22 20:36:13 volumio volumio[702]: info: ------------------------------ 5ms Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:13 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:13 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:13 volumio volumio[702]: info: Apr 22 20:36:13 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:13 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:13 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand status took 65 milliseconds Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:14 volumio volumio[702]: info: Apr 22 20:36:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand status took 67 milliseconds Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand status took 66 milliseconds Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":416,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3262 Kbps","isStreaming":false,"title":"Things Have Changed","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/01. Bettye Lavette - Things Have Changed.flac","trackType":"flac"} Apr 22 20:36:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:14 volumio volumio[702]: info: ------------------------------ 71ms Apr 22 20:36:14 volumio volumio[702]: info: Apr 22 20:36:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:14 volumio volumio[702]: info: Apr 22 20:36:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand status took 5 milliseconds Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":493,"duration":416,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3114 Kbps","isStreaming":false,"title":"Things Have Changed","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/01. Bettye Lavette - Things Have Changed.flac","trackType":"flac"} Apr 22 20:36:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:14 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":619,"duration":416,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2851 Kbps","isStreaming":false,"title":"Things Have Changed","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/01. Bettye Lavette - Things Have Changed.flac","trackType":"flac"} Apr 22 20:36:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:14 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:14 volumio volumio[702]: info: ------------------------------ 88ms Apr 22 20:36:14 volumio volumio[702]: info: ------------------------------ 88ms Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":416,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3384 Kbps","isStreaming":false,"title":"Things Have Changed","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/01. Bettye Lavette - Things Have Changed.flac","trackType":"flac"} Apr 22 20:36:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:14 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:14 volumio volumio[702]: info: ------------------------------ 30ms Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 47 milliseconds Apr 22 20:36:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 47 milliseconds Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":416,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3384 Kbps","isStreaming":false,"title":"Things Have Changed","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/01. Bettye Lavette - Things Have Changed.flac","trackType":"flac"} Apr 22 20:36:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:14 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":416,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3384 Kbps","isStreaming":false,"title":"Things Have Changed","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/01. Bettye Lavette - Things Have Changed.flac","trackType":"flac"} Apr 22 20:36:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:14 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:14 volumio volumio[702]: info: ------------------------------ 59ms Apr 22 20:36:14 volumio volumio[702]: info: ------------------------------ 58ms Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioNext Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::next Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::stPlaybackTimer Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::serviceStop Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::serviceStop Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::stop Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand stop took 24 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::play index undefined Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::startPlaybackTimer Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Bettye Lavette - Things Have Changed/02. Bettye Lavette - It Ain’t Me Babe.flac Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand stop took 1 milliseconds Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand clear Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:46 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand status took 3 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand clear took 2 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand status took 1 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand status took 1 milliseconds Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Bettye Lavette - Things Have Changed/02. Bettye Lavette - It Ain’t Me Babe.flac" Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: 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} Apr 22 20:36:46 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: No code Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: 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} Apr 22 20:36:46 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: No code Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 12ms Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 12ms Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:46 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:46 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:46 volumio volumio[702]: error: updateQueue error: null Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:46 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 14ms Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand add "NAS/NAS/Bettye Lavette - Things Have Changed/02. Bettye Lavette - It Ain’t Me Babe.flac" took 13 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 2ms Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 1ms Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand play Apr 22 20:36:46 volumio volumio[702]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 17ms Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:46 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:46 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 12ms Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand play took 12 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 12ms Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 11ms Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand status took 4 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand status took 3 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"It Ain’t Me Babe","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/02. Bettye Lavette - It Ain’t Me Babe.flac","trackType":"flac"} Apr 22 20:36:46 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 6ms Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:46 volumio volumio[702]: info: Apr 22 20:36:46 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand status took 4 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand status took 1 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand status took 1 milliseconds Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"It Ain’t Me Babe","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/02. Bettye Lavette - It Ain’t Me Babe.flac","trackType":"flac"} Apr 22 20:36:46 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:46 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"It Ain’t Me Babe","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/02. Bettye Lavette - It Ain’t Me Babe.flac","trackType":"flac"} Apr 22 20:36:46 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:46 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 19ms Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 19ms Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 22 20:36:46 volumio volumio[702]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:46 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"It Ain’t Me Babe","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/02. Bettye Lavette - It Ain’t Me Babe.flac","trackType":"flac"} Apr 22 20:36:46 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:46 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"It Ain’t Me Babe","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/02. Bettye Lavette - It Ain’t Me Babe.flac","trackType":"flac"} Apr 22 20:36:46 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:46 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"It Ain’t Me Babe","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/02. Bettye Lavette - It Ain’t Me Babe.flac","trackType":"flac"} Apr 22 20:36:46 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:46 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:46 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:46 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 33ms Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 30ms Apr 22 20:36:46 volumio volumio[702]: info: ------------------------------ 31ms Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioNext Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::next Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::stPlaybackTimer Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::serviceStop Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::serviceStop Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::stop Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand stop took 21 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::play index undefined Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::startPlaybackTimer Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Bettye Lavette - Things Have Changed/03. Bettye Lavette - Political World.flac Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand stop took 2 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand clear Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand status took 1 milliseconds Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:48 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand clear took 1 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Bettye Lavette - Things Have Changed/03. Bettye Lavette - Political World.flac" Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"It Ain’t Me Babe","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/02. Bettye Lavette - It Ain’t Me Babe.flac","trackType":"flac"} Apr 22 20:36:48 volumio volumio[702]: verbose: CURRENT POSITION 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: No code Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 11ms Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 10ms Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:48 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:48 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:48 volumio volumio[702]: error: updateQueue error: null Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:48 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 9ms Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand add "NAS/NAS/Bettye Lavette - Things Have Changed/03. Bettye Lavette - Political World.flac" took 8 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 2ms Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 1ms Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand play Apr 22 20:36:48 volumio volumio[702]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 12ms Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:48 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:48 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 8ms Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand play took 7 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 6ms Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand status took 4 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand status took 3 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Political World","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/03. Bettye Lavette - Political World.flac","trackType":"flac"} Apr 22 20:36:48 volumio volumio[702]: verbose: CURRENT POSITION 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 11ms Apr 22 20:36:48 volumio volumio[702]: info: Apr 22 20:36:48 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Political World","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/03. Bettye Lavette - Political World.flac","trackType":"flac"} Apr 22 20:36:48 volumio volumio[702]: verbose: CURRENT POSITION 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:48 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Political World","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/03. Bettye Lavette - Political World.flac","trackType":"flac"} Apr 22 20:36:48 volumio volumio[702]: verbose: CURRENT POSITION 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:48 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Political World","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/03. Bettye Lavette - Political World.flac","trackType":"flac"} Apr 22 20:36:48 volumio volumio[702]: verbose: CURRENT POSITION 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:48 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Political World","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/03. Bettye Lavette - Political World.flac","trackType":"flac"} Apr 22 20:36:48 volumio volumio[702]: verbose: CURRENT POSITION 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:48 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 28ms Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 28ms Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 26ms Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 26ms Apr 22 20:36:48 volumio volumio[702]: info: sendMpdCommand playlistinfo took 20 milliseconds Apr 22 20:36:48 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:48 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Political World","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/03. Bettye Lavette - Political World.flac","trackType":"flac"} Apr 22 20:36:48 volumio volumio[702]: verbose: CURRENT POSITION 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:48 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:48 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:48 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:48 volumio volumio[702]: info: ------------------------------ 27ms Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioNext Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::next Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::stPlaybackTimer Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::serviceStop Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 2 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::serviceStop Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::stop Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand stop took 25 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::play index undefined Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::startPlaybackTimer Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Bettye Lavette - Things Have Changed/04. Bettye Lavette - Don’t Fall Apart On Me Tonight.flac Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand stop took 1 milliseconds Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand clear Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:49 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand status took 3 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand clear took 3 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand status took 3 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Bettye Lavette - Things Have Changed/04. Bettye Lavette - Don’t Fall Apart On Me Tonight.flac" Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: 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} Apr 22 20:36:49 volumio volumio[702]: verbose: CURRENT POSITION 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: No code Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: 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} Apr 22 20:36:49 volumio volumio[702]: verbose: CURRENT POSITION 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: No code Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 16ms Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 16ms Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:49 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:49 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:49 volumio volumio[702]: error: updateQueue error: null Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:49 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 16ms Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand add "NAS/NAS/Bettye Lavette - Things Have Changed/04. Bettye Lavette - Don’t Fall Apart On Me Tonight.flac" took 16 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 2ms Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand play Apr 22 20:36:49 volumio volumio[702]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 21ms Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:49 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:49 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 12ms Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand play took 11 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 10ms Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 9ms Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand status took 3 milliseconds Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand status took 5 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don’t Fall Apart On Me Tonight","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/04. Bettye Lavette - Don’t Fall Apart On Me Tonight.flac","trackType":"flac"} Apr 22 20:36:49 volumio volumio[702]: verbose: CURRENT POSITION 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 9ms Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:49 volumio volumio[702]: info: Apr 22 20:36:49 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand status took 5 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand status took 3 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don’t Fall Apart On Me Tonight","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/04. Bettye Lavette - Don’t Fall Apart On Me Tonight.flac","trackType":"flac"} Apr 22 20:36:49 volumio volumio[702]: verbose: CURRENT POSITION 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:49 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don’t Fall Apart On Me Tonight","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/04. Bettye Lavette - Don’t Fall Apart On Me Tonight.flac","trackType":"flac"} Apr 22 20:36:49 volumio volumio[702]: verbose: CURRENT POSITION 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:49 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 27ms Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 27ms Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 22 20:36:49 volumio volumio[702]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:49 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don’t Fall Apart On Me Tonight","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/04. Bettye Lavette - Don’t Fall Apart On Me Tonight.flac","trackType":"flac"} Apr 22 20:36:49 volumio volumio[702]: verbose: CURRENT POSITION 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:49 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don’t Fall Apart On Me Tonight","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/04. Bettye Lavette - Don’t Fall Apart On Me Tonight.flac","trackType":"flac"} Apr 22 20:36:49 volumio volumio[702]: verbose: CURRENT POSITION 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:49 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don’t Fall Apart On Me Tonight","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/04. Bettye Lavette - Don’t Fall Apart On Me Tonight.flac","trackType":"flac"} Apr 22 20:36:49 volumio volumio[702]: verbose: CURRENT POSITION 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:49 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:49 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:49 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 38ms Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 36ms Apr 22 20:36:49 volumio volumio[702]: info: ------------------------------ 35ms Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioNext Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::next Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::stPlaybackTimer Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::serviceStop Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 3 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::serviceStop Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::stop Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand stop took 17 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::play index undefined Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::startPlaybackTimer Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand status took 1 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand stop took 0 milliseconds Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand clear Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:50 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand clear took 2 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand status took 1 milliseconds Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac" Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don’t Fall Apart On Me Tonight","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/04. Bettye Lavette - Don’t Fall Apart On Me Tonight.flac","trackType":"flac"} Apr 22 20:36:50 volumio volumio[702]: verbose: CURRENT POSITION 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: No code Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: 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} Apr 22 20:36:50 volumio volumio[702]: verbose: CURRENT POSITION 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: No code Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: 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} Apr 22 20:36:50 volumio volumio[702]: verbose: CURRENT POSITION 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: No code Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 22ms Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 20ms Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 20ms Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:50 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:50 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:50 volumio volumio[702]: error: updateQueue error: null Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:50 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 22ms Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand add "NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac" took 21 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 2ms Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand play Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:50 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:50 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 12ms Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand play took 11 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 11ms Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 10ms Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand status took 4 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand status took 4 milliseconds Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:50 volumio volumio[702]: info: Apr 22 20:36:50 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand status took 6 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand status took 3 milliseconds Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seeing The Real You At Last","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac","trackType":"flac"} Apr 22 20:36:50 volumio volumio[702]: verbose: CURRENT POSITION 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seeing The Real You At Last","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac","trackType":"flac"} Apr 22 20:36:50 volumio volumio[702]: verbose: CURRENT POSITION 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:50 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seeing The Real You At Last","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac","trackType":"flac"} Apr 22 20:36:50 volumio volumio[702]: verbose: CURRENT POSITION 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:50 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 18ms Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 21ms Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 21ms Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand status took 15 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seeing The Real You At Last","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac","trackType":"flac"} Apr 22 20:36:50 volumio volumio[702]: verbose: CURRENT POSITION 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:50 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seeing The Real You At Last","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac","trackType":"flac"} Apr 22 20:36:50 volumio volumio[702]: verbose: CURRENT POSITION 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:50 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 35ms Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 31ms Apr 22 20:36:50 volumio volumio[702]: info: sendMpdCommand playlistinfo took 36 milliseconds Apr 22 20:36:50 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:50 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seeing The Real You At Last","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac","trackType":"flac"} Apr 22 20:36:50 volumio volumio[702]: verbose: CURRENT POSITION 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:50 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:50 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:50 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:50 volumio volumio[702]: info: ------------------------------ 58ms Apr 22 20:36:58 volumio volumio[702]: info: Preload queue cleared Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::ClearQueue Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::stPlaybackTimer Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::serviceStop Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 4 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::serviceStop Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::stop Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::clearPlayQueue Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::saveQueue Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushQueue Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::addQueueItems Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::addQueueItems Apr 22 20:36:58 volumio volumio[702]: info: Preload queue cleared Apr 22 20:36:58 volumio volumio[702]: info: Adding Item to queue: music-library/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz) Apr 22 20:36:58 volumio volumio[702]: info: Exploding uri music-library/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz) in service mpd Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand stop took 59 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:58 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/LaVette!/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%202023%20-%20LaVette!%20(24bit-96kHz)%2F01%20See%20Through%20Me%20(feat.%20Pedrito%20Martinez).flac&metadata=false Apr 22 20:36:58 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/01 See Through Me (feat. Pedrito Martinez).flac Apr 22 20:36:58 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/LaVette!/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%202023%20-%20LaVette!%20(24bit-96kHz)%2F02%20Don't%20Get%20Me%20Started.flac&metadata=false Apr 22 20:36:58 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/02 Don't Get Me Started.flac Apr 22 20:36:58 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/LaVette!/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%202023%20-%20LaVette!%20(24bit-96kHz)%2F03%20Lazy%20(And%20I%20Know%20It).flac&metadata=false Apr 22 20:36:58 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/03 Lazy (And I Know It).flac Apr 22 20:36:58 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/LaVette!/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%202023%20-%20LaVette!%20(24bit-96kHz)%2F04%20Sooner%20Or%20Later%20(feat.%20Anthony%20Hamilton%2C%20Ray%20Parker%20Jr.%20%26%20Rev.%20Charles%20Hodges).flac&metadata=false Apr 22 20:36:58 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/04 Sooner Or Later (feat. Anthony Hamilton, Ray Parker Jr. & Rev. Charles Hodges).flac Apr 22 20:36:58 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/LaVette!/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%202023%20-%20LaVette!%20(24bit-96kHz)%2F05%20Plan%20B.flac&metadata=false Apr 22 20:36:58 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/05 Plan B.flac Apr 22 20:36:58 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/LaVette!/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%202023%20-%20LaVette!%20(24bit-96kHz)%2F06%20Concrete%20Mind.flac&metadata=false Apr 22 20:36:58 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/06 Concrete Mind.flac Apr 22 20:36:58 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/LaVette!/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%202023%20-%20LaVette!%20(24bit-96kHz)%2F07%20In%20the%20Meantime%20(feat.%20John%20Mayer).flac&metadata=false Apr 22 20:36:58 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/07 In the Meantime (feat. John Mayer).flac Apr 22 20:36:58 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/LaVette!/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%202023%20-%20LaVette!%20(24bit-96kHz)%2F08%20Mess%20About%20It%20(feat.%20Ray%20Parker%20Jr.%20%26%20Jon%20Batiste).flac&metadata=false Apr 22 20:36:58 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/08 Mess About It (feat. Ray Parker Jr. & Jon Batiste).flac Apr 22 20:36:58 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/LaVette!/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%202023%20-%20LaVette!%20(24bit-96kHz)%2F09%20Hard%20To%20Be%20A%20Human.flac&metadata=false Apr 22 20:36:58 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/09 Hard To Be A Human.flac Apr 22 20:36:58 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/LaVette!/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%202023%20-%20LaVette!%20(24bit-96kHz)%2F10%20I'm%20Not%20Gonna%20Waste%20My%20Love.flac&metadata=false Apr 22 20:36:58 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/10 I'm Not Gonna Waste My Love.flac Apr 22 20:36:58 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Bettye%20Lavette/LaVette!/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FBettye%20Lavette%20-%202023%20-%20LaVette!%20(24bit-96kHz)%2F11%20It's%20Alright.flac&metadata=false Apr 22 20:36:58 volumio volumio[702]: info: URI /mnt/NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/11 It's Alright.flac Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushQueue Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::saveQueue Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPlay Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::play index 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::play index undefined Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::startPlaybackTimer Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/01 See Through Me (feat. Pedrito Martinez).flac Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand status took 12 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand status took 11 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand status took 10 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand stop took 0 milliseconds Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand clear Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:58 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand clear took 2 milliseconds Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/01 See Through Me (feat. Pedrito Martinez).flac" Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seeing The Real You At Last","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac","trackType":"flac"} Apr 22 20:36:58 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: No code Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seeing The Real You At Last","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac","trackType":"flac"} Apr 22 20:36:58 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: No code Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seeing The Real You At Last","artist":"Bettye Lavette","album":"Things Have Changed","uri":"NAS/NAS/Bettye Lavette - Things Have Changed/05. Bettye Lavette - Seeing The Real You At Last.flac","trackType":"flac"} Apr 22 20:36:58 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: No code Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 30ms Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 29ms Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 30ms Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:58 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:58 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:58 volumio volumio[702]: error: updateQueue error: null Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:58 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 23ms Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand add "NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/01 See Through Me (feat. Pedrito Martinez).flac" took 22 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 1ms Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand play Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:58 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:36:58 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 4ms Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand play took 3 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 3ms Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand status took 4 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand status took 3 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"See Through Me (feat. Pedrito Martinez)","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/01 See Through Me (feat. Pedrito Martinez).flac","trackType":"flac"} Apr 22 20:36:58 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 7ms Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:58 volumio volumio[702]: info: Apr 22 20:36:58 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand status took 5 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand status took 5 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand status took 5 milliseconds Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"See Through Me (feat. Pedrito Martinez)","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/01 See Through Me (feat. Pedrito Martinez).flac","trackType":"flac"} Apr 22 20:36:58 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:58 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"See Through Me (feat. Pedrito Martinez)","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/01 See Through Me (feat. Pedrito Martinez).flac","trackType":"flac"} Apr 22 20:36:58 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:58 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 29ms Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 29ms Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 22 20:36:58 volumio volumio[702]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:58 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"See Through Me (feat. Pedrito Martinez)","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/01 See Through Me (feat. Pedrito Martinez).flac","trackType":"flac"} Apr 22 20:36:58 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:58 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"See Through Me (feat. Pedrito Martinez)","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/01 See Through Me (feat. Pedrito Martinez).flac","trackType":"flac"} Apr 22 20:36:58 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:58 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"See Through Me (feat. Pedrito Martinez)","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/01 See Through Me (feat. Pedrito Martinez).flac","trackType":"flac"} Apr 22 20:36:58 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:36:58 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:36:58 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:36:58 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 40ms Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 38ms Apr 22 20:36:58 volumio volumio[702]: info: ------------------------------ 38ms Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioNext Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::next Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::stPlaybackTimer Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::serviceStop Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::serviceStop Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::stop Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand stop took 14 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::play index undefined Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::startPlaybackTimer Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/02 Don't Get Me Started.flac Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand stop took 2 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand status took 1 milliseconds Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand clear Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:03 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand clear took 2 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/02 Don't Get Me Started.flac" Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:03 volumio volumio[702]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 22 20:37:03 volumio volumio[702]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 5ms Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 4ms Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:03 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:03 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:03 volumio volumio[702]: error: updateQueue error: null Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:03 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 4ms Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand add "NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/02 Don't Get Me Started.flac" took 3 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 2ms Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 1ms Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand play Apr 22 20:37:03 volumio volumio[702]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 7ms Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:03 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:03 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 4ms Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand play took 3 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 2ms Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 1ms Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand status took 8 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand status took 5 milliseconds Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand status took 5 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand status took 4 milliseconds Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":311,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Get Me Started","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/02 Don't Get Me Started.flac","trackType":"flac"} Apr 22 20:37:03 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":311,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Get Me Started","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/02 Don't Get Me Started.flac","trackType":"flac"} Apr 22 20:37:03 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:03 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 29ms Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 30ms Apr 22 20:37:03 volumio volumio[702]: info: Apr 22 20:37:03 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand status took 18 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand playlistinfo took 15 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand status took 1 milliseconds Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":311,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Get Me Started","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/02 Don't Get Me Started.flac","trackType":"flac"} Apr 22 20:37:03 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:03 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":311,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Get Me Started","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/02 Don't Get Me Started.flac","trackType":"flac"} Apr 22 20:37:03 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:03 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 39ms Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 36ms Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand playlistinfo took 33 milliseconds Apr 22 20:37:03 volumio volumio[702]: info: sendMpdCommand playlistinfo took 32 milliseconds Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:03 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":311,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Get Me Started","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/02 Don't Get Me Started.flac","trackType":"flac"} Apr 22 20:37:03 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:03 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:03 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":311,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3181 Kbps","isStreaming":false,"title":"Don't Get Me Started","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/02 Don't Get Me Started.flac","trackType":"flac"} Apr 22 20:37:03 volumio volumio[702]: verbose: CURRENT POSITION 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:03 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:03 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:03 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:03 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 64ms Apr 22 20:37:03 volumio volumio[702]: info: ------------------------------ 46ms Apr 22 20:37:14 volumio volumio[702]: info: Preload queue cleared Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::ClearQueue Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::stPlaybackTimer Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::serviceStop Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 1 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::serviceStop Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::stop Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::clearPlayQueue Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::saveQueue Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushQueue Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::addQueueItems Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::addQueueItems Apr 22 20:37:14 volumio volumio[702]: info: Preload queue cleared Apr 22 20:37:14 volumio volumio[702]: info: Adding Item to queue: music-library/NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96) Apr 22 20:37:14 volumio volumio[702]: info: Exploding uri music-library/NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96) in service mpd Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:14 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Take%20It%20Home/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Take%20It%20Home%20-%201979-2021%20(24-96)%2F01.%20B.B.%20King%20-%20Better%20Not%20Look%20Down.flac&metadata=false Apr 22 20:37:14 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac Apr 22 20:37:14 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Take%20It%20Home/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Take%20It%20Home%20-%201979-2021%20(24-96)%2F02.%20B.B.%20King%20-%20Same%20Old%20Story%20(Same%20Old%20Song).flac&metadata=false Apr 22 20:37:14 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/02. B.B. King - Same Old Story (Same Old Song).flac Apr 22 20:37:14 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Take%20It%20Home/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Take%20It%20Home%20-%201979-2021%20(24-96)%2F03.%20B.B.%20King%20-%20Happy%20Birthday%20Blues.flac&metadata=false Apr 22 20:37:14 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/03. B.B. King - Happy Birthday Blues.flac Apr 22 20:37:14 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Take%20It%20Home/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Take%20It%20Home%20-%201979-2021%20(24-96)%2F04.%20B.B.%20King%20-%20I've%20Always%20Been%20Lonely.flac&metadata=false Apr 22 20:37:14 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/04. B.B. King - I've Always Been Lonely.flac Apr 22 20:37:14 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Take%20It%20Home/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Take%20It%20Home%20-%201979-2021%20(24-96)%2F05.%20B.B.%20King%20-%20Second%20Hand%20Woman.flac&metadata=false Apr 22 20:37:14 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/05. B.B. King - Second Hand Woman.flac Apr 22 20:37:14 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Take%20It%20Home/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Take%20It%20Home%20-%201979-2021%20(24-96)%2F06.%20B.B.%20King%20-%20Tonight%20I'm%20Gonna%20Make%20You%20A%20Star.flac&metadata=false Apr 22 20:37:14 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/06. B.B. King - Tonight I'm Gonna Make You A Star.flac Apr 22 20:37:14 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Take%20It%20Home/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Take%20It%20Home%20-%201979-2021%20(24-96)%2F07.%20B.B.%20King%20-%20The%20Beginning%20Of%20The%20End.flac&metadata=false Apr 22 20:37:14 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/07. B.B. King - The Beginning Of The End.flac Apr 22 20:37:14 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Take%20It%20Home/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Take%20It%20Home%20-%201979-2021%20(24-96)%2F08.%20B.B.%20King%20-%20A%20Story%20Everybody%20Knows.flac&metadata=false Apr 22 20:37:14 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/08. B.B. King - A Story Everybody Knows.flac Apr 22 20:37:14 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Take%20It%20Home/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Take%20It%20Home%20-%201979-2021%20(24-96)%2F09.%20B.B.%20King%20-%20Take%20It%20Home.flac&metadata=false Apr 22 20:37:14 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/09. B.B. King - Take It Home.flac Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand stop took 73 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushQueue Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::saveQueue Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPlay Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::play index 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::play index undefined Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::startPlaybackTimer Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand status took 10 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand stop took 3 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand status took 1 milliseconds Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand clear Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:14 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand clear took 2 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac" Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Get Me Started","artist":"Bettye Lavette","album":"LaVette!","uri":"NAS/NAS/Bettye Lavette - 2023 - LaVette! (24bit-96kHz)/02 Don't Get Me Started.flac","trackType":"flac"} Apr 22 20:37:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: No code Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 22 20:37:14 volumio volumio[702]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 22ms Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 10ms Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:14 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:14 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:14 volumio volumio[702]: error: updateQueue error: null Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:14 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 13ms Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand add "NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac" took 16 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 9ms Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 8ms Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand play Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:14 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:14 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 9ms Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand play took 4 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 4ms Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 3ms Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand status took 3 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand status took 1 milliseconds Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:14 volumio volumio[702]: info: Apr 22 20:37:14 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand status took 3 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand status took 2 milliseconds Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":203,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Better Not Look Down","artist":"B.B. King","album":"Take It Home","uri":"NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac","trackType":"flac"} Apr 22 20:37:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":203,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Better Not Look Down","artist":"B.B. King","album":"Take It Home","uri":"NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac","trackType":"flac"} Apr 22 20:37:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:14 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":203,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Better Not Look Down","artist":"B.B. King","album":"Take It Home","uri":"NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac","trackType":"flac"} Apr 22 20:37:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:14 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 17ms Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 19ms Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 18ms Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand status took 15 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":203,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Better Not Look Down","artist":"B.B. King","album":"Take It Home","uri":"NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac","trackType":"flac"} Apr 22 20:37:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:14 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":203,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Better Not Look Down","artist":"B.B. King","album":"Take It Home","uri":"NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac","trackType":"flac"} Apr 22 20:37:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:14 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 34ms Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 33ms Apr 22 20:37:14 volumio volumio[702]: info: sendMpdCommand playlistinfo took 33 milliseconds Apr 22 20:37:14 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:14 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":203,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Better Not Look Down","artist":"B.B. King","album":"Take It Home","uri":"NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac","trackType":"flac"} Apr 22 20:37:14 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:14 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:14 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:14 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:14 volumio volumio[702]: info: ------------------------------ 56ms Apr 22 20:37:18 volumio volumio[702]: info: Preload queue cleared Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::ClearQueue Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::stPlaybackTimer Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::serviceStop Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::serviceStop Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::stop Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::clearPlayQueue Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::saveQueue Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushQueue Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::addQueueItems Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::addQueueItems Apr 22 20:37:18 volumio volumio[702]: info: Preload queue cleared Apr 22 20:37:18 volumio volumio[702]: info: Adding Item to queue: music-library/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192] Apr 22 20:37:18 volumio volumio[702]: info: Exploding uri music-library/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192] in service mpd Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand stop took 103 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F01.%20Exactly%20Like%20You.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/01. Exactly Like You.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F02.%20On%20My%20Word%20Of%20Honor.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/02. On My Word Of Honor.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F03.%20I%20Want%20A%20Little%20Girl.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/03. I Want A Little Girl.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F04.%20I'll%20String%20Along%20With%20You.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/04. I'll String Along With You.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F05.%20I%20Need%20You%20So.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/05. I Need You So.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F06.%20A%20Mother's%20Love.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/06. A Mother's Love.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F07.%20(I%20Love%20You)%20For%20Sentimental%20Re.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/07. (I Love You) For Sentimental Re.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F08.%20Neighborhood%20Affair.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/08. Neighborhood Affair.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F09.%20Tomorrow%20Night.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/09. Tomorrow Night.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F10.%20There%20I've%20Said%20It%20Again.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/10. There I've Said It Again.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F11.%20Always%20On%20My%20Mind.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/11. Always On My Mind.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F12.%20Cross%20My%20Heart.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/12. Cross My Heart.flac Apr 22 20:37:18 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=B.B.%20King/Reflections/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FB.B.%20King%20-%20Reflections%20(2003)%20FLAC%20%5B24-192%5D%2F13.%20What%20A%20Wonderful%20World.flac&metadata=false Apr 22 20:37:18 volumio volumio[702]: info: URI /mnt/NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/13. What A Wonderful World.flac Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushQueue Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::saveQueue Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPlay Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::play index 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::play index undefined Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::startPlaybackTimer Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/01. Exactly Like You.flac Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand status took 12 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand status took 11 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand status took 11 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand stop took 1 milliseconds Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand clear Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:18 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand clear took 2 milliseconds Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/01. Exactly Like You.flac" Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Better Not Look Down","artist":"B.B. King","album":"Take It Home","uri":"NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac","trackType":"flac"} Apr 22 20:37:18 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: No code Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Better Not Look Down","artist":"B.B. King","album":"Take It Home","uri":"NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac","trackType":"flac"} Apr 22 20:37:18 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: No code Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Better Not Look Down","artist":"B.B. King","album":"Take It Home","uri":"NAS/NAS/B.B. King - Take It Home - 1979-2021 (24-96)/01. B.B. King - Better Not Look Down.flac","trackType":"flac"} Apr 22 20:37:18 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState stateService stop Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: No code Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 31ms Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 31ms Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 30ms Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:18 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:18 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:18 volumio volumio[702]: error: updateQueue error: null Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:18 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 24ms Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand add "NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/01. Exactly Like You.flac" took 23 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 2ms Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 1ms Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand play Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:18 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces system playlist update Apr 22 20:37:18 volumio volumio[702]: info: Ignoring MPD Status Update Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 5ms Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand play took 4 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 3ms Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand status took 73 milliseconds Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand status took 74 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand status took 73 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":201,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Exactly Like You","artist":"B.B. King","album":"Reflections","uri":"NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/01. Exactly Like You.flac","trackType":"flac"} Apr 22 20:37:18 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 80ms Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:18 volumio volumio[702]: info: Apr 22 20:37:18 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand status took 12 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand status took 9 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand status took 8 milliseconds Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseState Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7,"duration":201,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Exactly Like You","artist":"B.B. King","album":"Reflections","uri":"NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/01. Exactly Like You.flac","trackType":"flac"} Apr 22 20:37:18 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:18 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13,"duration":201,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Exactly Like You","artist":"B.B. King","album":"Reflections","uri":"NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/01. Exactly Like You.flac","trackType":"flac"} Apr 22 20:37:18 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:18 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 99ms Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 99ms Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 22 20:37:18 volumio volumio[702]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:18 volumio volumio[702]: verbose: ControllerMpd::parseTrackInfo Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":167,"duration":201,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"392 Kbps","isStreaming":false,"title":"Exactly Like You","artist":"B.B. King","album":"Reflections","uri":"NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/01. Exactly Like You.flac","trackType":"flac"} Apr 22 20:37:18 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:18 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":335,"duration":201,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5654 Kbps","isStreaming":false,"title":"Exactly Like You","artist":"B.B. King","album":"Reflections","uri":"NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/01. Exactly Like You.flac","trackType":"flac"} Apr 22 20:37:18 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:18 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: ControllerMpd::pushState Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::servicePushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: verbose: STATE SERVICE {"status":"play","position":0,"seek":396,"duration":201,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5589 Kbps","isStreaming":false,"title":"Exactly Like You","artist":"B.B. King","album":"Reflections","uri":"NAS/NAS/B.B. King - Reflections (2003) FLAC [24-192]/01. Exactly Like You.flac","trackType":"flac"} Apr 22 20:37:18 volumio volumio[702]: verbose: CURRENT POSITION 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState stateService play Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::syncState currentStatus play Apr 22 20:37:18 volumio volumio[702]: info: Received an update from plugin. extracting info from payload Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:18 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:18 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 41ms Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 38ms Apr 22 20:37:18 volumio volumio[702]: info: ------------------------------ 37ms Apr 22 20:37:23 volumio volumio[702]: info: Preload queue cleared Apr 22 20:37:23 volumio volumio[702]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 22 20:37:23 volumio volumio[702]: info: CoreStateMachine::ClearQueue Apr 22 20:37:23 volumio volumio[702]: info: CoreStateMachine::stop Apr 22 20:37:23 volumio volumio[702]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 20:37:23 volumio volumio[702]: info: CoreStateMachine::stPlaybackTimer Apr 22 20:37:23 volumio volumio[702]: info: CoreStateMachine::updateTrackBlock Apr 22 20:37:23 volumio volumio[702]: info: CorePlayQueue::getTrackBlock Apr 22 20:37:23 volumio volumio[702]: info: CoreStateMachine::pushState Apr 22 20:37:23 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:23 volumio volumio[702]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:37:23 volumio volumio[702]: info: CoreCommandRouter::volumioPushState Apr 22 20:37:23 volumio volumio[702]: info: CoreStateMachine::serviceStop Apr 22 20:37:23 volumio volumio[702]: info: CorePlayQueue::getTrack 0 Apr 22 20:37:23 volumio volumio[702]: info: CoreCommandRouter::serviceStop Apr 22 20:37:23 volumio volumio[702]: info: ControllerMpd::stop Apr 22 20:37:23 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 20:37:23 volumio volumio[702]: info: CorePlayQueue::clearPlayQueue Apr 22 20:37:23 volumio volumio[702]: info: CorePlayQueue::saveQueue Apr 22 20:37:23 volumio volumio[702]: info: CoreCommandRouter::volumioPushQueue Apr 22 20:37:23 volumio volumio[702]: info: CoreStateMachine::addQueueItems Apr 22 20:37:23 volumio volumio[702]: info: CorePlayQueue::addQueueItems Apr 22 20:37:23 volumio volumio[702]: info: Preload queue cleared Apr 22 20:37:23 volumio volumio[702]: info: Adding Item to queue: music-library/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac Apr 22 20:37:23 volumio volumio[702]: info: Exploding uri music-library/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac in service mpd Apr 22 20:37:23 volumio volumio[702]: info: sendMpdCommand stop took 52 milliseconds Apr 22 20:37:23 volumio volumio[702]: info: Apr 22 20:37:23 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:23 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:23 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:23 volumio volumio[702]: info: Apr 22 20:37:23 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:23 volumio volumio[702]: info: ControllerMpd::getState Apr 22 20:37:23 volumio volumio[702]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:37:23 volumio volumio[702]: info: Apr 22 20:37:23 volumio volumio[702]: ---------------------------- MPD announces state update: player Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F01%20-%20Pretty%20Places.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/01 - Pretty Places.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F02%20-%20Lost%20Cause.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/02 - Lost Cause.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F03%20-%20Break%20Yourself.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/03 - Break Yourself.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F04%20-%20Slow%20Dancing.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/04 - Slow Dancing.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F05%20-%20Paradise.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/05 - Paradise.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F06%20-%20Symptom%20of%20Your%20Touch.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/06 - Symptom of Your Touch.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F07%20-%20Lucky%20to%20Get%20Him.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/07 - Lucky to Get Him.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F08%20-%20Listen!!!.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/08 - Listen!!!.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F09%20-%20Don't%20Need%20Nothing.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/09 - Don't Need Nothing.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F10%20-%20Stomach.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/10 - Stomach.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F11%20-%20Personal%20Cathedrals.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/11 - Personal Cathedrals.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2F12%20-%20Hold%20Out.flac&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/12 - Hold Out.flac Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2Fa%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets.cue&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/a touch of the beat gets you up on your feet gets.cue Apr 22 20:37:23 volumio volumio[702]: info: ALBUMART /albumart?cacheid=159&web=Aly%20%26%20AJ/a%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets%20you%20out%20and%20then%20into%20the%20sun/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAly%20%26%20AJ%20-%20A%20Touch%20of%20the%20Beat%20Gets%20(2021)%20%5B24-96%5D%20flac%2Fa%20touch%20of%20the%20beat%20gets%20you%20up%20on%20your%20feet%20gets.cue&metadata=false Apr 22 20:37:23 volumio volumio[702]: info: URI /mnt/NAS/NAS/Aly & AJ - A Touch of the Beat Gets (2021) [24-96] flac/a touch of the beat gets you up on your feet gets.cue Apr 22 20:37:23 volumio volumio[702]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 20:37:23 volumio volumio[702]: Error: Unable to resolve or reject the same promise twice Apr 22 20:37:23 volumio volumio[702]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 22 20:37:23 volumio volumio[702]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 22 20:37:23 volumio volumio[702]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 22 20:37:23 volumio volumio[702]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 22 20:37:23 volumio volumio[702]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 22 20:37:23 volumio volumio[702]: at Socket.emit (events.js:315:20) Apr 22 20:37:23 volumio volumio[702]: at addChunk (internal/streams/readable.js:309:12) Apr 22 20:37:23 volumio volumio[702]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 22 20:37:23 volumio volumio[702]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 22 20:37:23 volumio volumio[702]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 22 20:37:23 volumio volumio[702]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 20:37:24 volumio sudo[20733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-22 20:36 Apr 22 20:37:24 volumio sudo[20733]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"