-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Fri 2026-03-27 19:55:00 CST. -- Mar 27 19:53:21 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 27 19:53:21 volumio volumio[792]: info: CURURI: music-library/USB/72F0685905AD1DD2/Best Always Mar 27 19:53:21 volumio volumio[792]: info: Preload queue cleared Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/When I Dream.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Talking In Your Sleep.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Ready For The Times To Get Better.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Nobody Wants To Be Alone.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Miss The Mississippi And You.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/For The Good Times.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Always.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Don't It Make My Brown Eyes Blue.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Crying In The Rain.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Crazy.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Nights.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/The Way.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/No Love In The Heart Of The City.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Angel.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Just Can't Leave Your Love Alone.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/In The Fire.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/New Way To Say I Love You.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/On Me.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Blue Side.flac Mar 27 19:53:21 volumio volumio[792]: info: Preloading song: music-library/USB/72F0685905AD1DD2/Best Always/Sound Of Goodbye.flac Mar 27 19:53:21 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/When I Dream.flac in service mpd Mar 27 19:53:21 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FWhen%20I%20Dream.flac&metadata=false Mar 27 19:53:21 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/When I Dream.flac Mar 27 19:53:21 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Talking In Your Sleep.flac in service mpd Mar 27 19:53:21 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FTalking%20In%20Your%20Sleep.flac&metadata=false Mar 27 19:53:21 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Talking In Your Sleep.flac Mar 27 19:53:21 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Ready For The Times To Get Better.flac in service mpd Mar 27 19:53:21 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FReady%20For%20The%20Times%20To%20Get%20Better.flac&metadata=false Mar 27 19:53:21 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Ready For The Times To Get Better.flac Mar 27 19:53:21 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Nobody Wants To Be Alone.flac in service mpd Mar 27 19:53:21 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FNobody%20Wants%20To%20Be%20Alone.flac&metadata=false Mar 27 19:53:21 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Nobody Wants To Be Alone.flac Mar 27 19:53:21 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Miss The Mississippi And You.flac in service mpd Mar 27 19:53:21 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FMiss%20The%20Mississippi%20And%20You.flac&metadata=false Mar 27 19:53:21 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Miss The Mississippi And You.flac Mar 27 19:53:21 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/For The Good Times.flac in service mpd Mar 27 19:53:21 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FFor%20The%20Good%20Times.flac&metadata=false Mar 27 19:53:21 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/For The Good Times.flac Mar 27 19:53:21 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Always.flac in service mpd Mar 27 19:53:21 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FAlways.flac&metadata=false Mar 27 19:53:21 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Always.flac Mar 27 19:53:21 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Don't It Make My Brown Eyes Blue.flac in service mpd Mar 27 19:53:21 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FDon't%20It%20Make%20My%20Brown%20Eyes%20Blue.flac&metadata=false Mar 27 19:53:21 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Don't It Make My Brown Eyes Blue.flac Mar 27 19:53:21 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Crying In The Rain.flac in service mpd Mar 27 19:53:21 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FCrying%20In%20The%20Rain.flac&metadata=false Mar 27 19:53:21 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Crying In The Rain.flac Mar 27 19:53:22 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Crazy.flac in service mpd Mar 27 19:53:22 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FCrazy.flac&metadata=false Mar 27 19:53:22 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Crazy.flac Mar 27 19:53:22 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Nights.flac in service mpd Mar 27 19:53:22 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FNights.flac&metadata=false Mar 27 19:53:22 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Nights.flac Mar 27 19:53:22 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/The Way.flac in service mpd Mar 27 19:53:22 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FThe%20Way.flac&metadata=false Mar 27 19:53:22 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/The Way.flac Mar 27 19:53:22 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/No Love In The Heart Of The City.flac in service mpd Mar 27 19:53:22 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FNo%20Love%20In%20The%20Heart%20Of%20The%20City.flac&metadata=false Mar 27 19:53:22 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/No Love In The Heart Of The City.flac Mar 27 19:53:22 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Angel.flac in service mpd Mar 27 19:53:22 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FAngel.flac&metadata=false Mar 27 19:53:22 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Angel.flac Mar 27 19:53:22 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Just Can't Leave Your Love Alone.flac in service mpd Mar 27 19:53:22 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FJust%20Can't%20Leave%20Your%20Love%20Alone.flac&metadata=false Mar 27 19:53:22 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Just Can't Leave Your Love Alone.flac Mar 27 19:53:22 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/In The Fire.flac in service mpd Mar 27 19:53:22 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FIn%20The%20Fire.flac&metadata=false Mar 27 19:53:22 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/In The Fire.flac Mar 27 19:53:22 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/New Way To Say I Love You.flac in service mpd Mar 27 19:53:22 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FNew%20Way%20To%20Say%20I%20Love%20You.flac&metadata=false Mar 27 19:53:22 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/New Way To Say I Love You.flac Mar 27 19:53:22 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/On Me.flac in service mpd Mar 27 19:53:22 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FOn%20Me.flac&metadata=false Mar 27 19:53:22 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/On Me.flac Mar 27 19:53:22 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Blue Side.flac in service mpd Mar 27 19:53:22 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FBlue%20Side.flac&metadata=false Mar 27 19:53:22 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Blue Side.flac Mar 27 19:53:22 volumio volumio[792]: info: Preload queue cleared Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::ClearQueue Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::stop Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::stPlaybackTimer Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::updateTrackBlock Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrackBlock Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::serviceStop Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::serviceStop Mar 27 19:53:22 volumio volumio[792]: info: ControllerMpd::stop Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand stop Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::clearPlayQueue Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::saveQueue Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioPushQueue Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::addQueueItems Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::addQueueItems Mar 27 19:53:22 volumio volumio[792]: info: Preload queue cleared Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/When I Dream.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/When I Dream.flac Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioPushQueue Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::saveQueue Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::updateTrackBlock Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrackBlock Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioPlay Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::play index 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::addQueueItems Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::addQueueItems Mar 27 19:53:22 volumio volumio[792]: info: Preload queue cleared Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Talking In Your Sleep.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Talking In Your Sleep.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Ready For The Times To Get Better.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Ready For The Times To Get Better.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Nobody Wants To Be Alone.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Nobody Wants To Be Alone.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Miss The Mississippi And You.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Miss The Mississippi And You.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/For The Good Times.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/For The Good Times.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Always.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Always.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Don't It Make My Brown Eyes Blue.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Don't It Make My Brown Eyes Blue.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Crying In The Rain.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Crying In The Rain.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Crazy.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Crazy.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Nights.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Nights.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/The Way.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/The Way.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/No Love In The Heart Of The City.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/No Love In The Heart Of The City.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Angel.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Angel.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Just Can't Leave Your Love Alone.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Just Can't Leave Your Love Alone.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/In The Fire.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/In The Fire.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/New Way To Say I Love You.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/New Way To Say I Love You.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/On Me.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/On Me.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Blue Side.flac Mar 27 19:53:22 volumio volumio[792]: info: Using cached record of: music-library/USB/72F0685905AD1DD2/Best Always/Blue Side.flac Mar 27 19:53:22 volumio volumio[792]: info: Adding Item to queue: music-library/USB/72F0685905AD1DD2/Best Always/Sound Of Goodbye.flac Mar 27 19:53:22 volumio volumio[792]: info: Exploding uri music-library/USB/72F0685905AD1DD2/Best Always/Sound Of Goodbye.flac in service mpd Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::stop Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::play index undefined Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::startPlaybackTimer Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::clearAddPlayTracks USB/72F0685905AD1DD2/Best Always/When I Dream.flac Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand stop Mar 27 19:53:22 volumio volumio[792]: info: Mar 27 19:53:22 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:53:22 volumio volumio[792]: info: ALBUMART /albumart?cacheid=881&web=Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/extralarge&path=%2Fmnt%2FUSB%2F72F0685905AD1DD2%2FBest%20Always%2FSound%20Of%20Goodbye.flac&metadata=false Mar 27 19:53:22 volumio volumio[792]: info: URI /mnt/USB/72F0685905AD1DD2/Best Always/Sound Of Goodbye.flac Mar 27 19:53:22 volumio volumio[792]: info: sendMpdCommand stop took 39 milliseconds Mar 27 19:53:22 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:53:22 volumio volumio[792]: info: sendMpdCommand stop took 6 milliseconds Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand clear Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioPushQueue Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::saveQueue Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::updateTrackBlock Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrackBlock Mar 27 19:53:22 volumio volumio[792]: info: Mar 27 19:53:22 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:53:22 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:53:22 volumio volumio[792]: info: Mar 27 19:53:22 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:53:22 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:53:22 volumio volumio[792]: info: Mar 27 19:53:22 volumio volumio[792]: ---------------------------- MPD announces system playlist update Mar 27 19:53:22 volumio volumio[792]: info: Ignoring MPD Status Update Mar 27 19:53:22 volumio volumio[792]: info: sendMpdCommand status took 14 milliseconds Mar 27 19:53:22 volumio volumio[792]: info: sendMpdCommand clear took 13 milliseconds Mar 27 19:53:22 volumio volumio[792]: info: sendMpdCommand status took 5 milliseconds Mar 27 19:53:22 volumio volumio[792]: info: sendMpdCommand status took 4 milliseconds Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand add "USB/72F0685905AD1DD2/Best Always/When I Dream.flac" Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:53:22 volumio volumio[792]: info: ControllerMpd::pushState Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::servicePushState Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: 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} Mar 27 19:53:22 volumio volumio[792]: verbose: CURRENT POSITION 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::syncState stateService stop Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::syncState currentStatus stop Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:22 volumio volumio[792]: info: No code Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:22 volumio volumio[792]: info: ControllerMpd::pushState Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::servicePushState Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: 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} Mar 27 19:53:22 volumio volumio[792]: verbose: CURRENT POSITION 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::syncState stateService stop Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::syncState currentStatus stop Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:22 volumio volumio[792]: info: No code Mar 27 19:53:22 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:22 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:22 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:22 volumio volumio[792]: info: ------------------------------ 35ms Mar 27 19:53:22 volumio volumio[792]: info: ------------------------------ 35ms Mar 27 19:53:22 volumio volumio[792]: info: Mar 27 19:53:22 volumio volumio[792]: ---------------------------- MPD announces system playlist update Mar 27 19:53:22 volumio volumio[792]: info: Ignoring MPD Status Update Mar 27 19:53:22 volumio volumio[792]: info: Mar 27 19:53:22 volumio volumio[792]: ---------------------------- MPD announces system playlist update Mar 27 19:53:22 volumio volumio[792]: info: Ignoring MPD Status Update Mar 27 19:53:22 volumio volumio[792]: error: updateQueue error: null Mar 27 19:53:22 volumio volumio[792]: info: Mar 27 19:53:22 volumio volumio[792]: ---------------------------- MPD announces system playlist update Mar 27 19:53:22 volumio volumio[792]: info: Ignoring MPD Status Update Mar 27 19:53:22 volumio volumio[792]: info: ------------------------------ 42ms Mar 27 19:53:22 volumio volumio[792]: info: sendMpdCommand playlistinfo took 40 milliseconds Mar 27 19:53:22 volumio volumio[792]: info: sendMpdCommand add "USB/72F0685905AD1DD2/Best Always/When I Dream.flac" took 39 milliseconds Mar 27 19:53:22 volumio volumio[792]: info: ------------------------------ 10ms Mar 27 19:53:22 volumio volumio[792]: info: ------------------------------ 10ms Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::parseTrackInfo Mar 27 19:53:22 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand play Mar 27 19:53:22 volumio volumio[792]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 27 19:53:22 volumio volumio[792]: info: ------------------------------ 62ms Mar 27 19:53:22 volumio volumio[792]: info: Mar 27 19:53:22 volumio volumio[792]: ---------------------------- MPD announces system playlist update Mar 27 19:53:22 volumio volumio[792]: info: Ignoring MPD Status Update Mar 27 19:53:22 volumio volumio[792]: info: Mar 27 19:53:22 volumio volumio[792]: ---------------------------- MPD announces system playlist update Mar 27 19:53:22 volumio volumio[792]: info: Ignoring MPD Status Update Mar 27 19:53:22 volumio volumio[792]: info: ------------------------------ 17ms Mar 27 19:53:22 volumio volumio[792]: info: sendMpdCommand play took 12 milliseconds Mar 27 19:53:22 volumio volumio[792]: info: ------------------------------ 10ms Mar 27 19:53:22 volumio volumio[792]: info: ------------------------------ 9ms Mar 27 19:53:23 volumio volumio[792]: info: Mar 27 19:53:23 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:53:23 volumio volumio[792]: info: Mar 27 19:53:23 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:53:23 volumio volumio[792]: info: Mar 27 19:53:23 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:53:23 volumio volumio[792]: info: Mar 27 19:53:23 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand status took 8 milliseconds Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand status took 7 milliseconds Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand status took 7 milliseconds Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 19:53:23 volumio volumio[792]: info: Mar 27 19:53:23 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:53:23 volumio volumio[792]: info: Mar 27 19:53:23 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand status took 30 milliseconds Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand playlistinfo took 28 milliseconds Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand playlistinfo took 27 milliseconds Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand playlistinfo took 27 milliseconds Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand status took 25 milliseconds Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand status took 23 milliseconds Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseTrackInfo Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseTrackInfo Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseTrackInfo Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::pushState Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::servicePushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"489 Kbps","isStreaming":false,"title":"When I Dream","artist":"Crystal Gayle","album":"The Crystal Gayle Collection","uri":"USB/72F0685905AD1DD2/Best Always/When I Dream.flac","trackType":"flac"} Mar 27 19:53:23 volumio volumio[792]: verbose: CURRENT POSITION 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState stateService play Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState currentStatus stop Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::pushState Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::servicePushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"489 Kbps","isStreaming":false,"title":"When I Dream","artist":"Crystal Gayle","album":"The Crystal Gayle Collection","uri":"USB/72F0685905AD1DD2/Best Always/When I Dream.flac","trackType":"flac"} Mar 27 19:53:23 volumio volumio[792]: verbose: CURRENT POSITION 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState stateService play Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState currentStatus play Mar 27 19:53:23 volumio volumio[792]: info: Received an update from plugin. extracting info from payload Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::pushState Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::servicePushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"489 Kbps","isStreaming":false,"title":"When I Dream","artist":"Crystal Gayle","album":"The Crystal Gayle Collection","uri":"USB/72F0685905AD1DD2/Best Always/When I Dream.flac","trackType":"flac"} Mar 27 19:53:23 volumio volumio[792]: verbose: CURRENT POSITION 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState stateService play Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState currentStatus play Mar 27 19:53:23 volumio volumio[792]: info: Received an update from plugin. extracting info from payload Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:23 volumio volumio[792]: info: ------------------------------ 59ms Mar 27 19:53:23 volumio volumio[792]: info: ------------------------------ 70ms Mar 27 19:53:23 volumio volumio[792]: info: ------------------------------ 69ms Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand playlistinfo took 41 milliseconds Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand playlistinfo took 41 milliseconds Mar 27 19:53:23 volumio volumio[792]: info: sendMpdCommand playlistinfo took 41 milliseconds Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseTrackInfo Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseTrackInfo Mar 27 19:53:23 volumio volumio[792]: verbose: ControllerMpd::parseTrackInfo Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::pushState Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::servicePushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"489 Kbps","isStreaming":false,"title":"When I Dream","artist":"Crystal Gayle","album":"The Crystal Gayle Collection","uri":"USB/72F0685905AD1DD2/Best Always/When I Dream.flac","trackType":"flac"} Mar 27 19:53:23 volumio volumio[792]: verbose: CURRENT POSITION 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState stateService play Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState currentStatus play Mar 27 19:53:23 volumio volumio[792]: info: Received an update from plugin. extracting info from payload Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::pushState Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::servicePushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"489 Kbps","isStreaming":false,"title":"When I Dream","artist":"Crystal Gayle","album":"The Crystal Gayle Collection","uri":"USB/72F0685905AD1DD2/Best Always/When I Dream.flac","trackType":"flac"} Mar 27 19:53:23 volumio volumio[792]: verbose: CURRENT POSITION 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState stateService play Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState currentStatus play Mar 27 19:53:23 volumio volumio[792]: info: Received an update from plugin. extracting info from payload Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:23 volumio volumio[792]: info: ControllerMpd::pushState Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::servicePushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"489 Kbps","isStreaming":false,"title":"When I Dream","artist":"Crystal Gayle","album":"The Crystal Gayle Collection","uri":"USB/72F0685905AD1DD2/Best Always/When I Dream.flac","trackType":"flac"} Mar 27 19:53:23 volumio volumio[792]: verbose: CURRENT POSITION 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState stateService play Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::syncState currentStatus play Mar 27 19:53:23 volumio volumio[792]: info: Received an update from plugin. extracting info from payload Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:23 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:53:23 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:53:23 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:53:23 volumio volumio[792]: info: ------------------------------ 112ms Mar 27 19:53:23 volumio volumio[792]: info: ------------------------------ 105ms Mar 27 19:53:23 volumio volumio[792]: info: ------------------------------ 103ms Mar 27 19:54:24 volumio volumio[792]: info: CoreCommandRouter::volumioPause Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::pause Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::stPlaybackTimer Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::servicePause Mar 27 19:54:24 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:54:24 volumio volumio[792]: info: CoreCommandRouter::servicePause Mar 27 19:54:24 volumio volumio[792]: info: ControllerMpd::pause Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand pause Mar 27 19:54:24 volumio volumio[792]: info: sendMpdCommand pause took 2 milliseconds Mar 27 19:54:24 volumio volumio[792]: info: Mar 27 19:54:24 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:54:24 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:54:24 volumio volumio[792]: info: Mar 27 19:54:24 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:54:24 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:54:24 volumio volumio[792]: info: Mar 27 19:54:24 volumio volumio[792]: ---------------------------- MPD announces state update: player Mar 27 19:54:24 volumio volumio[792]: info: ControllerMpd::getState Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand status Mar 27 19:54:24 volumio volumio[792]: info: sendMpdCommand status took 5 milliseconds Mar 27 19:54:24 volumio volumio[792]: info: sendMpdCommand status took 3 milliseconds Mar 27 19:54:24 volumio volumio[792]: info: sendMpdCommand status took 2 milliseconds Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::parseState Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 19:54:24 volumio volumio[792]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 27 19:54:24 volumio volumio[792]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 27 19:54:24 volumio volumio[792]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::parseTrackInfo Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::parseTrackInfo Mar 27 19:54:24 volumio volumio[792]: verbose: ControllerMpd::parseTrackInfo Mar 27 19:54:24 volumio volumio[792]: info: ControllerMpd::pushState Mar 27 19:54:24 volumio volumio[792]: info: CoreCommandRouter::servicePushState Mar 27 19:54:24 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:54:24 volumio volumio[792]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":62347,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"681 Kbps","isStreaming":false,"title":"When I Dream","artist":"Crystal Gayle","album":"The Crystal Gayle Collection","uri":"USB/72F0685905AD1DD2/Best Always/When I Dream.flac","trackType":"flac"} Mar 27 19:54:24 volumio volumio[792]: verbose: CURRENT POSITION 0 Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::syncState stateService pause Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::syncState currentStatus pause Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:54:24 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:54:24 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 19:54:24 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::stPlaybackTimer Mar 27 19:54:24 volumio volumio[792]: info: ControllerMpd::pushState Mar 27 19:54:24 volumio volumio[792]: info: CoreCommandRouter::servicePushState Mar 27 19:54:24 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:54:24 volumio volumio[792]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":62347,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"681 Kbps","isStreaming":false,"title":"When I Dream","artist":"Crystal Gayle","album":"The Crystal Gayle Collection","uri":"USB/72F0685905AD1DD2/Best Always/When I Dream.flac","trackType":"flac"} Mar 27 19:54:24 volumio volumio[792]: verbose: CURRENT POSITION 0 Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::syncState stateService pause Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::syncState currentStatus pause Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:54:24 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:54:24 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::stPlaybackTimer Mar 27 19:54:24 volumio volumio[792]: info: ControllerMpd::pushState Mar 27 19:54:24 volumio volumio[792]: info: CoreCommandRouter::servicePushState Mar 27 19:54:24 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:54:24 volumio volumio[792]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":62347,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"681 Kbps","isStreaming":false,"title":"When I Dream","artist":"Crystal Gayle","album":"The Crystal Gayle Collection","uri":"USB/72F0685905AD1DD2/Best Always/When I Dream.flac","trackType":"flac"} Mar 27 19:54:24 volumio volumio[792]: verbose: CURRENT POSITION 0 Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::syncState stateService pause Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::syncState currentStatus pause Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::pushState Mar 27 19:54:24 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:54:24 volumio volumio[792]: info: CoreCommandRouter::volumioPushState Mar 27 19:54:24 volumio volumio[792]: info: CoreStateMachine::stPlaybackTimer Mar 27 19:54:24 volumio volumio[792]: info: ------------------------------ 33ms Mar 27 19:54:24 volumio volumio[792]: info: ------------------------------ 31ms Mar 27 19:54:24 volumio volumio[792]: info: ------------------------------ 30ms Mar 27 19:54:25 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 27 19:54:25 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 27 19:54:26 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 27 19:54:26 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 27 19:54:26 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 27 19:54:26 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 27 19:54:27 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 27 19:54:27 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 27 19:54:29 volumio volumio[792]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Crystal%20Gayle/The%20Crystal%20Gayle%20Collection/cf776c0a-9727-4809-91c1-4d52286fb70d.jpg' Mar 27 19:54:30 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 27 19:54:30 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 27 19:54:30 volumio volumio[792]: info: Discovery: Getting this device information Mar 27 19:54:30 volumio volumio[792]: info: CoreCommandRouter::volumioGetState Mar 27 19:54:30 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:54:30 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 27 19:54:57 volumio volumio[792]: verbose: New Socket.io Connection to 192.168.3.98 from 192.168.3.40 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 5 Mar 27 19:54:57 volumio volumio[792]: info: CoreCommandRouter::volumioGetState Mar 27 19:54:57 volumio volumio[792]: info: CorePlayQueue::getTrack 0 Mar 27 19:54:57 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 27 19:54:57 volumio volumio[792]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 27 19:54:59 volumio volumio[792]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 19:54:59 volumio volumio[792]: Error: connect ETIMEDOUT 208.101.60.87:443 Mar 27 19:54:59 volumio volumio[792]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 27 19:54:59 volumio volumio[792]: errno: -110, Mar 27 19:54:59 volumio volumio[792]: code: 'ETIMEDOUT', Mar 27 19:54:59 volumio volumio[792]: syscall: 'connect', Mar 27 19:54:59 volumio volumio[792]: address: '208.101.60.87', Mar 27 19:54:59 volumio volumio[792]: port: 443 Mar 27 19:54:59 volumio volumio[792]: } Mar 27 19:54:59 volumio volumio[792]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 19:55:00 volumio sudo[24172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-27 19:53 Mar 27 19:55:00 volumio sudo[24172]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"