-- Logs begin at Thu 2019-02-14 11:12:01 CET, end at Wed 2024-05-01 11:50:57 CEST. -- May 01 11:49:17 volumio volumio[860]: info: Preload queue cleared May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::ClearQueue May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::stop May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::stPlaybackTimer May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrackBlock May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::serviceStop May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::serviceStop May 01 11:49:17 volumio volumio[860]: info: ControllerMpd::stop May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand stop May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::clearPlayQueue May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::saveQueue May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::volumioPushQueue May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::addQueueItems May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::addQueueItems May 01 11:49:17 volumio volumio[860]: info: Preload queue cleared May 01 11:49:17 volumio volumio[860]: info: Adding Item to queue: webrp/2 May 01 11:49:17 volumio volumio[860]: info: Exploding uri webrp/2 in service radio_paradise May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::volumioPushQueue May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::saveQueue May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrackBlock May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::volumioPlay May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::play index 0 May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::stop May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::play index undefined May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::startPlaybackTimer May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand stop May 01 11:49:17 volumio volumio[860]: info: May 01 11:49:17 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:17 volumio volumio[860]: info: sendMpdCommand stop took 41 milliseconds May 01 11:49:17 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:17 volumio volumio[860]: info: sendMpdCommand stop took 11 milliseconds May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B00265RUY6.jpg","uri":"https://stream.radioparadise.com/world-etc-flac","name":"Fouta Toro","title":"Fouta Toro","artist":"Sean Blackman","album":"In Transit","streaming":true,"disableUiControls":true,"duration":241,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 01 11:49:17 volumio volumio[860]: verbose: CURRENT POSITION 0 May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::syncState stateService stop May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:17 volumio volumio[860]: info: No code May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand clear May 01 11:49:17 volumio volumio[860]: info: May 01 11:49:17 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:17 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:17 volumio volumio[860]: info: May 01 11:49:17 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:17 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:17 volumio volumio[860]: info: May 01 11:49:17 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:17 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:17 volumio volumio[860]: info: sendMpdCommand status took 70 milliseconds May 01 11:49:17 volumio volumio[860]: info: sendMpdCommand clear took 43 milliseconds May 01 11:49:17 volumio volumio[860]: info: sendMpdCommand status took 17 milliseconds May 01 11:49:17 volumio volumio[860]: info: sendMpdCommand status took 16 milliseconds May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand consume 1 May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:17 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:17 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:17 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:17 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:17 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:17 volumio volumio[860]: info: ------------------------------ 49ms May 01 11:49:17 volumio volumio[860]: info: ------------------------------ 47ms May 01 11:49:17 volumio volumio[860]: info: May 01 11:49:17 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:17 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:17 volumio volumio[860]: info: May 01 11:49:17 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:17 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:17 volumio volumio[860]: error: updateQueue error: null May 01 11:49:17 volumio volumio[860]: error: updateQueue error: null May 01 11:49:17 volumio volumio[860]: error: updateQueue error: null May 01 11:49:17 volumio volumio[860]: info: ------------------------------ 47ms May 01 11:49:17 volumio volumio[860]: info: sendMpdCommand playlistinfo took 42 milliseconds May 01 11:49:17 volumio volumio[860]: info: sendMpdCommand consume 1 took 42 milliseconds May 01 11:49:17 volumio volumio[860]: info: ------------------------------ 12ms May 01 11:49:17 volumio volumio[860]: info: ------------------------------ 11ms May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:17 volumio volumio[860]: info: [1714556957637] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/rock-flac May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/rock-flac" May 01 11:49:17 volumio volumio[860]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 11:49:17 volumio volumio[860]: info: ------------------------------ 119ms May 01 11:49:17 volumio volumio[860]: info: May 01 11:49:17 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:17 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:17 volumio volumio[860]: info: sendMpdCommand add "https://stream.radioparadise.com/rock-flac" took 4 milliseconds May 01 11:49:17 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand play May 01 11:49:17 volumio volumio[860]: info: May 01 11:49:17 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:17 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:17 volumio volumio[860]: info: May 01 11:49:17 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:17 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:17 volumio volumio[860]: info: ------------------------------ 19ms May 01 11:49:17 volumio volumio[860]: info: sendMpdCommand play took 9 milliseconds May 01 11:49:17 volumio volumio[860]: info: ------------------------------ 9ms May 01 11:49:17 volumio volumio[860]: info: ------------------------------ 7ms May 01 11:49:17 volumio volumio[860]: info: [1714556957660] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=2 May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand status took 6 milliseconds May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand status took 5 milliseconds May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand status took 3 milliseconds May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand status took 8 milliseconds May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand playlistinfo took 8 milliseconds May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand playlistinfo took 7 milliseconds May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand playlistinfo took 7 milliseconds May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand status took 5 milliseconds May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand status took 4 milliseconds May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:18 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:18 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:18 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 30ms May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 28ms May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 27ms May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand playlistinfo took 12 milliseconds May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand playlistinfo took 12 milliseconds May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand playlistinfo took 12 milliseconds May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:18 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:18 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:18 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 34ms May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 28ms May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 27ms May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:18 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:18 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:18 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:18 volumio volumio[860]: info: May 01 11:49:18 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 11ms May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand status took 10 milliseconds May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 7ms May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand status took 5 milliseconds May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 4ms May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand status took 4 milliseconds May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand playlistinfo took 4 milliseconds May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand playlistinfo took 5 milliseconds May 01 11:49:18 volumio volumio[860]: info: sendMpdCommand playlistinfo took 5 milliseconds May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:18 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:18 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:18 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:18 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:18 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 33ms May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 29ms May 01 11:49:18 volumio volumio[860]: info: ------------------------------ 27ms May 01 11:49:18 volumio volumio[860]: info: [1714556958387] [RadioParadise] received new metadata: {"time":54,"artist":"Manic Street Preachers","title":"Sleepflower","album":"Gold Against the Soul","year":"1993","cover":"https://img.radioparadise.com/covers/l/B000025KKX.jpg","cover_med":"https://img.radioparadise.com/covers/m/B000025KKX.jpg","cover_small":"https://img.radioparadise.com/covers/s/B000025KKX.jpg"} May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B000025KKX.jpg","uri":"https://stream.radioparadise.com/rock-flac","name":"Sleepflower","title":"Sleepflower","artist":"Manic Street Preachers","album":"Gold Against the Soul","streaming":true,"disableUiControls":true,"duration":59,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 01 11:49:18 volumio volumio[860]: verbose: CURRENT POSITION 0 May 01 11:49:18 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:49:18 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:49:18 volumio volumio[860]: info: [1714556958391] [RadioParadise] setting new timer with duration of 59000 seconds. May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:18 volumio volumio[860]: info: CorePlayQueue::getTrack 1 May 01 11:49:28 volumio volumio[860]: info: Preload queue cleared May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::ClearQueue May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::stop May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::stPlaybackTimer May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrackBlock May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::serviceStop May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::serviceStop May 01 11:49:28 volumio volumio[860]: info: ControllerMpd::stop May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand stop May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::clearPlayQueue May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::saveQueue May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::volumioPushQueue May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::addQueueItems May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::addQueueItems May 01 11:49:28 volumio volumio[860]: info: Preload queue cleared May 01 11:49:28 volumio volumio[860]: info: Adding Item to queue: webrp/1 May 01 11:49:28 volumio volumio[860]: info: Using cached record of: webrp/1 May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::volumioPushQueue May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::saveQueue May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrackBlock May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::volumioPlay May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::play index 0 May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::stop May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::play index undefined May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::startPlaybackTimer May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand stop May 01 11:49:28 volumio volumio[860]: info: May 01 11:49:28 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:28 volumio volumio[860]: info: sendMpdCommand stop took 54 milliseconds May 01 11:49:28 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:28 volumio volumio[860]: info: sendMpdCommand stop took 13 milliseconds May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B000025KKX.jpg","uri":"https://stream.radioparadise.com/rock-flac","name":"Sleepflower","title":"Sleepflower","artist":"Manic Street Preachers","album":"Gold Against the Soul","streaming":true,"disableUiControls":true,"duration":59,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 01 11:49:28 volumio volumio[860]: verbose: CURRENT POSITION 0 May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::syncState stateService stop May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:28 volumio volumio[860]: info: No code May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand clear May 01 11:49:28 volumio volumio[860]: info: May 01 11:49:28 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:28 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:28 volumio volumio[860]: info: May 01 11:49:28 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:28 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:28 volumio volumio[860]: info: May 01 11:49:28 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:28 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:28 volumio volumio[860]: info: sendMpdCommand status took 62 milliseconds May 01 11:49:28 volumio volumio[860]: info: sendMpdCommand clear took 45 milliseconds May 01 11:49:28 volumio volumio[860]: info: sendMpdCommand status took 20 milliseconds May 01 11:49:28 volumio volumio[860]: info: sendMpdCommand status took 18 milliseconds May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand consume 1 May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:28 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:28 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:28 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:28 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:28 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:28 volumio volumio[860]: info: ------------------------------ 51ms May 01 11:49:28 volumio volumio[860]: info: ------------------------------ 50ms May 01 11:49:28 volumio volumio[860]: info: May 01 11:49:28 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:28 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:28 volumio volumio[860]: info: May 01 11:49:28 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:28 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:28 volumio volumio[860]: error: updateQueue error: null May 01 11:49:28 volumio volumio[860]: error: updateQueue error: null May 01 11:49:28 volumio volumio[860]: info: ------------------------------ 49ms May 01 11:49:28 volumio volumio[860]: info: sendMpdCommand playlistinfo took 46 milliseconds May 01 11:49:28 volumio volumio[860]: info: sendMpdCommand consume 1 took 47 milliseconds May 01 11:49:28 volumio volumio[860]: info: ------------------------------ 16ms May 01 11:49:28 volumio volumio[860]: info: ------------------------------ 16ms May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:28 volumio volumio[860]: info: [1714556968997] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/mellow-flac May 01 11:49:28 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/mellow-flac" May 01 11:49:28 volumio volumio[860]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 11:49:28 volumio volumio[860]: info: ------------------------------ 116ms May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:29 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand add "https://stream.radioparadise.com/mellow-flac" took 4 milliseconds May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand play May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:29 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:29 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 21ms May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand play took 6 milliseconds May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 5ms May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 3ms May 01 11:49:29 volumio volumio[860]: info: [1714556969029] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1 May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand status took 6 milliseconds May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand status took 5 milliseconds May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand status took 4 milliseconds May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand status took 16 milliseconds May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand playlistinfo took 14 milliseconds May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand playlistinfo took 12 milliseconds May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand playlistinfo took 10 milliseconds May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand status took 8 milliseconds May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand status took 5 milliseconds May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:29 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:29 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:29 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:29 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:29 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:29 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:29 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:29 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:29 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 34ms May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 31ms May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 30ms May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand playlistinfo took 8 milliseconds May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand playlistinfo took 6 milliseconds May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand playlistinfo took 6 milliseconds May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:29 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:29 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:29 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:29 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:29 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:29 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:29 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:29 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:29 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 39ms May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 29ms May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 28ms May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:29 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:29 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:49:29 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:49:29 volumio volumio[860]: info: May 01 11:49:29 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::getState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 14ms May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand status took 9 milliseconds May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 8ms May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand status took 7 milliseconds May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 6ms May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand status took 5 milliseconds May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand playlistinfo took 3 milliseconds May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand playlistinfo took 3 milliseconds May 01 11:49:29 volumio volumio[860]: info: sendMpdCommand playlistinfo took 3 milliseconds May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:29 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:29 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:29 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:29 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:29 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:29 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:29 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:29 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:49:29 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:29 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:29 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 23ms May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 18ms May 01 11:49:29 volumio volumio[860]: info: ------------------------------ 15ms May 01 11:49:29 volumio volumio[860]: info: [1714556969688] [RadioParadise] received new metadata: {"time":21,"artist":"Rod Stewart","title":"Mandolin Wind","album":"Every Picture Tells a Story","year":"1971","cover":"https://img.radioparadise.com/covers/l/B00000612P.jpg","cover_med":"https://img.radioparadise.com/covers/m/B00000612P.jpg","cover_small":"https://img.radioparadise.com/covers/s/B00000612P.jpg"} May 01 11:49:29 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:29 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:29 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:29 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B00000612P.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Mandolin Wind","title":"Mandolin Wind","artist":"Rod Stewart","album":"Every Picture Tells a Story","streaming":true,"disableUiControls":true,"duration":26,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 01 11:49:29 volumio volumio[860]: verbose: CURRENT POSITION 0 May 01 11:49:29 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:49:29 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:49:29 volumio volumio[860]: info: [1714556969704] [RadioParadise] setting new timer with duration of 26000 seconds. May 01 11:49:49 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 11:49:49 volumio volumio[860]: info: CURURI: music-library May 01 11:49:49 volumio volumio[860]: info: Preload queue cleared May 01 11:49:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 11:49:50 volumio volumio[860]: info: CURURI: music-library/USB May 01 11:49:50 volumio volumio[860]: info: Preload queue cleared May 01 11:49:53 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 11:49:53 volumio volumio[860]: info: CURURI: music-library/INTERNAL May 01 11:49:53 volumio volumio[860]: info: Preload queue cleared May 01 11:49:54 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 11:49:54 volumio volumio[860]: info: CURURI: music-library/INTERNAL/test May 01 11:49:54 volumio volumio[860]: info: Preload queue cleared May 01 11:49:54 volumio volumio[860]: info: Preloading song: music-library/INTERNAL/test/part_1_set_01.mp3 May 01 11:49:54 volumio volumio[860]: info: Preloading song: music-library/INTERNAL/test/part_1_set_02.mp3 May 01 11:49:54 volumio volumio[860]: info: Preloading song: music-library/INTERNAL/test/part_1_set_03.mp3 May 01 11:49:54 volumio volumio[860]: info: Preloading song: music-library/INTERNAL/test/part_1_set_04.mp3 May 01 11:49:54 volumio volumio[860]: info: Preloading song: music-library/INTERNAL/test/part_1_set_05.mp3 May 01 11:49:54 volumio volumio[860]: info: Preloading song: music-library/INTERNAL/test/part_1_set_06.mp3 May 01 11:49:54 volumio volumio[860]: info: Preloading song: music-library/INTERNAL/test/part_1_set_07_Lyuba.mp3 May 01 11:49:54 volumio volumio[860]: info: Preloading song: music-library/INTERNAL/test/part_1_set_08.mp3 May 01 11:49:54 volumio volumio[860]: info: Preloading song: music-library/INTERNAL/test/part_1_set_09.mp3 May 01 11:49:54 volumio volumio[860]: info: Preloading song: music-library/INTERNAL/test/part_1_set_10.mp3 May 01 11:49:54 volumio volumio[860]: info: Exploding uri music-library/INTERNAL/test/part_1_set_01.mp3 in service mpd May 01 11:49:54 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FINTERNAL%2Ftest%2Fpart_1_set_01.mp3&metadata=false May 01 11:49:54 volumio volumio[860]: info: URI /mnt/INTERNAL/test/part_1_set_01.mp3 May 01 11:49:54 volumio volumio[860]: info: Exploding uri music-library/INTERNAL/test/part_1_set_02.mp3 in service mpd May 01 11:49:54 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FINTERNAL%2Ftest%2Fpart_1_set_02.mp3&metadata=false May 01 11:49:54 volumio volumio[860]: info: URI /mnt/INTERNAL/test/part_1_set_02.mp3 May 01 11:49:54 volumio volumio[860]: info: Exploding uri music-library/INTERNAL/test/part_1_set_03.mp3 in service mpd May 01 11:49:54 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FINTERNAL%2Ftest%2Fpart_1_set_03.mp3&metadata=false May 01 11:49:54 volumio volumio[860]: info: URI /mnt/INTERNAL/test/part_1_set_03.mp3 May 01 11:49:54 volumio volumio[860]: info: Exploding uri music-library/INTERNAL/test/part_1_set_04.mp3 in service mpd May 01 11:49:54 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FINTERNAL%2Ftest%2Fpart_1_set_04.mp3&metadata=false May 01 11:49:54 volumio volumio[860]: info: URI /mnt/INTERNAL/test/part_1_set_04.mp3 May 01 11:49:54 volumio volumio[860]: info: Exploding uri music-library/INTERNAL/test/part_1_set_05.mp3 in service mpd May 01 11:49:54 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FINTERNAL%2Ftest%2Fpart_1_set_05.mp3&metadata=false May 01 11:49:54 volumio volumio[860]: info: URI /mnt/INTERNAL/test/part_1_set_05.mp3 May 01 11:49:54 volumio volumio[860]: info: Exploding uri music-library/INTERNAL/test/part_1_set_06.mp3 in service mpd May 01 11:49:54 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FINTERNAL%2Ftest%2Fpart_1_set_06.mp3&metadata=false May 01 11:49:54 volumio volumio[860]: info: URI /mnt/INTERNAL/test/part_1_set_06.mp3 May 01 11:49:55 volumio volumio[860]: info: Exploding uri music-library/INTERNAL/test/part_1_set_07_Lyuba.mp3 in service mpd May 01 11:49:55 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FINTERNAL%2Ftest%2Fpart_1_set_07_Lyuba.mp3&metadata=false May 01 11:49:55 volumio volumio[860]: info: URI /mnt/INTERNAL/test/part_1_set_07_Lyuba.mp3 May 01 11:49:55 volumio volumio[860]: info: Exploding uri music-library/INTERNAL/test/part_1_set_08.mp3 in service mpd May 01 11:49:55 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FINTERNAL%2Ftest%2Fpart_1_set_08.mp3&metadata=false May 01 11:49:55 volumio volumio[860]: info: URI /mnt/INTERNAL/test/part_1_set_08.mp3 May 01 11:49:55 volumio volumio[860]: info: Exploding uri music-library/INTERNAL/test/part_1_set_09.mp3 in service mpd May 01 11:49:55 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FINTERNAL%2Ftest%2Fpart_1_set_09.mp3&metadata=false May 01 11:49:55 volumio volumio[860]: info: URI /mnt/INTERNAL/test/part_1_set_09.mp3 May 01 11:49:55 volumio volumio[860]: info: Exploding uri music-library/INTERNAL/test/part_1_set_10.mp3 in service mpd May 01 11:49:55 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FINTERNAL%2Ftest%2Fpart_1_set_10.mp3&metadata=false May 01 11:49:55 volumio volumio[860]: info: URI /mnt/INTERNAL/test/part_1_set_10.mp3 May 01 11:49:55 volumio volumio[860]: info: [1714556995704] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1 May 01 11:49:56 volumio volumio[860]: info: [1714556996293] [RadioParadise] received new metadata: {"time":5,"artist":"Rod Stewart","title":"Mandolin Wind","album":"Every Picture Tells a Story","year":"1971","cover":"https://img.radioparadise.com/covers/l/B00000612P.jpg","cover_med":"https://img.radioparadise.com/covers/m/B00000612P.jpg","cover_small":"https://img.radioparadise.com/covers/s/B00000612P.jpg"} May 01 11:49:56 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:56 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:49:56 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:56 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B00000612P.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Mandolin Wind","title":"Mandolin Wind","artist":"Rod Stewart","album":"Every Picture Tells a Story","streaming":true,"disableUiControls":true,"duration":10,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 01 11:49:56 volumio volumio[860]: verbose: CURRENT POSITION 0 May 01 11:49:56 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:49:56 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:49:56 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:49:56 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:56 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:56 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:49:56 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:56 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:49:56 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:49:56 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:49:56 volumio volumio[860]: info: [1714556996336] [RadioParadise] setting new timer with duration of 10000 seconds. May 01 11:49:56 volumio volumio[860]: info: CoreCommandRouter::volumioGetQueue May 01 11:49:56 volumio volumio[860]: info: CoreStateMachine::getQueue May 01 11:49:56 volumio volumio[860]: info: CorePlayQueue::getQueue May 01 11:50:00 volumio volumio[860]: info: Preload queue cleared May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::ClearQueue May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::stop May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::stPlaybackTimer May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrackBlock May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::serviceStop May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 0 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::serviceStop May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::stop May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand stop May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::clearPlayQueue May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::saveQueue May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushQueue May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::addQueueItems May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::addQueueItems May 01 11:50:00 volumio volumio[860]: info: Preload queue cleared May 01 11:50:00 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_01.mp3 May 01 11:50:00 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_01.mp3 May 01 11:50:00 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_02.mp3 May 01 11:50:00 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_02.mp3 May 01 11:50:00 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_03.mp3 May 01 11:50:00 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_03.mp3 May 01 11:50:00 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_04.mp3 May 01 11:50:00 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_04.mp3 May 01 11:50:00 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_05.mp3 May 01 11:50:00 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_05.mp3 May 01 11:50:00 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_06.mp3 May 01 11:50:00 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_06.mp3 May 01 11:50:00 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_07_Lyuba.mp3 May 01 11:50:00 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_07_Lyuba.mp3 May 01 11:50:00 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_08.mp3 May 01 11:50:00 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_08.mp3 May 01 11:50:00 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_09.mp3 May 01 11:50:00 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_09.mp3 May 01 11:50:00 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_10.mp3 May 01 11:50:00 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_10.mp3 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushQueue May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::saveQueue May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrackBlock May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPlay May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::play index 6 May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::stop May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::play index undefined May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::startPlaybackTimer May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/test/part_1_set_07_Lyuba.mp3 May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand stop May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand stop took 49 milliseconds May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand stop took 12 milliseconds May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received radio_paradise May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand clear May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:00 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand status took 38 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand clear took 31 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand status took 26 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand status took 17 milliseconds May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/test/part_1_set_07_Lyuba.mp3" May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: 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} May 01 11:50:00 volumio volumio[860]: verbose: CURRENT POSITION 6 May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState stateService stop May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: No code May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: 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} May 01 11:50:00 volumio volumio[860]: verbose: CURRENT POSITION 6 May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState stateService stop May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: No code May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 113ms May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 109ms May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:00 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:00 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:00 volumio volumio[860]: error: updateQueue error: null May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:00 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 110ms May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand playlistinfo took 108 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand add "INTERNAL/test/part_1_set_07_Lyuba.mp3" took 107 milliseconds May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 15ms May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 14ms May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand play May 01 11:50:00 volumio volumio[860]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 154ms May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:00 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:00 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 35ms May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand play took 31 milliseconds May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 29ms May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 27ms May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand status took 8 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand status took 7 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand status took 6 milliseconds May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:00 volumio volumio[860]: info: May 01 11:50:00 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand status took 11 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand playlistinfo took 8 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand playlistinfo took 8 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand playlistinfo took 9 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand status took 6 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand status took 5 milliseconds May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_07_Lyuba.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_07_Lyuba.mp3","trackType":"mp3"} May 01 11:50:00 volumio volumio[860]: verbose: CURRENT POSITION 6 May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_07_Lyuba.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_07_Lyuba.mp3","trackType":"mp3"} May 01 11:50:00 volumio volumio[860]: verbose: CURRENT POSITION 6 May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:00 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_07_Lyuba.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_07_Lyuba.mp3","trackType":"mp3"} May 01 11:50:00 volumio volumio[860]: verbose: CURRENT POSITION 6 May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:00 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 48ms May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 82ms May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 81ms May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand playlistinfo took 63 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand playlistinfo took 61 milliseconds May 01 11:50:00 volumio volumio[860]: info: sendMpdCommand playlistinfo took 61 milliseconds May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:00 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_07_Lyuba.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_07_Lyuba.mp3","trackType":"mp3"} May 01 11:50:00 volumio volumio[860]: verbose: CURRENT POSITION 6 May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:00 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_07_Lyuba.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_07_Lyuba.mp3","trackType":"mp3"} May 01 11:50:00 volumio volumio[860]: verbose: CURRENT POSITION 6 May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:00 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_07_Lyuba.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_07_Lyuba.mp3","trackType":"mp3"} May 01 11:50:00 volumio volumio[860]: verbose: CURRENT POSITION 6 May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:00 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:00 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:00 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 163ms May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 156ms May 01 11:50:00 volumio volumio[860]: info: ------------------------------ 155ms May 01 11:50:22 volumio volumio[860]: info: Preload queue cleared May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::ClearQueue May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::stop May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::stPlaybackTimer May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrackBlock May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::serviceStop May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 6 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::serviceStop May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::stop May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand stop May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::clearPlayQueue May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::saveQueue May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushQueue May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::addQueueItems May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::addQueueItems May 01 11:50:22 volumio volumio[860]: info: Preload queue cleared May 01 11:50:22 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_01.mp3 May 01 11:50:22 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_01.mp3 May 01 11:50:22 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_02.mp3 May 01 11:50:22 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_02.mp3 May 01 11:50:22 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_03.mp3 May 01 11:50:22 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_03.mp3 May 01 11:50:22 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_04.mp3 May 01 11:50:22 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_04.mp3 May 01 11:50:22 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_05.mp3 May 01 11:50:22 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_05.mp3 May 01 11:50:22 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_06.mp3 May 01 11:50:22 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_06.mp3 May 01 11:50:22 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_07_Lyuba.mp3 May 01 11:50:22 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_07_Lyuba.mp3 May 01 11:50:22 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_08.mp3 May 01 11:50:22 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_08.mp3 May 01 11:50:22 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_09.mp3 May 01 11:50:22 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_09.mp3 May 01 11:50:22 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_10.mp3 May 01 11:50:22 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_10.mp3 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushQueue May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::saveQueue May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrackBlock May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPlay May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::play index 9 May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::stop May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::play index undefined May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::startPlaybackTimer May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/test/part_1_set_10.mp3 May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand stop May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand stop took 39 milliseconds May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand stop took 9 milliseconds May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand clear May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:22 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand status took 9 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand clear took 8 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand status took 6 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand status took 6 milliseconds May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/test/part_1_set_10.mp3" May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: 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} May 01 11:50:22 volumio volumio[860]: verbose: CURRENT POSITION 9 May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState stateService stop May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: No code May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: 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} May 01 11:50:22 volumio volumio[860]: verbose: CURRENT POSITION 9 May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState stateService stop May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: No code May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 94ms May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 94ms May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:22 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:22 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:22 volumio volumio[860]: error: updateQueue error: null May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:22 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 105ms May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand playlistinfo took 103 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand add "INTERNAL/test/part_1_set_10.mp3" took 102 milliseconds May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 16ms May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 10ms May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand play May 01 11:50:22 volumio volumio[860]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 118ms May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:22 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:22 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 34ms May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand play took 31 milliseconds May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 29ms May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 28ms May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand status took 38 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand status took 37 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand status took 30 milliseconds May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:22 volumio volumio[860]: info: May 01 11:50:22 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand status took 20 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand playlistinfo took 18 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand playlistinfo took 19 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand playlistinfo took 18 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand status took 15 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand status took 13 milliseconds May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"part_1_set_10.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_10.mp3","trackType":"mp3"} May 01 11:50:22 volumio volumio[860]: verbose: CURRENT POSITION 9 May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_10.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_10.mp3","trackType":"mp3"} May 01 11:50:22 volumio volumio[860]: verbose: CURRENT POSITION 9 May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:22 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_10.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_10.mp3","trackType":"mp3"} May 01 11:50:22 volumio volumio[860]: verbose: CURRENT POSITION 9 May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:22 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 93ms May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 135ms May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 130ms May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand playlistinfo took 79 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand playlistinfo took 78 milliseconds May 01 11:50:22 volumio volumio[860]: info: sendMpdCommand playlistinfo took 77 milliseconds May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:22 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_10.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_10.mp3","trackType":"mp3"} May 01 11:50:22 volumio volumio[860]: verbose: CURRENT POSITION 9 May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:22 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_10.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_10.mp3","trackType":"mp3"} May 01 11:50:22 volumio volumio[860]: verbose: CURRENT POSITION 9 May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:22 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_10.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_10.mp3","trackType":"mp3"} May 01 11:50:22 volumio volumio[860]: verbose: CURRENT POSITION 9 May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:22 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:22 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:22 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 184ms May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 179ms May 01 11:50:22 volumio volumio[860]: info: ------------------------------ 177ms May 01 11:50:25 volumio volumio[860]: info: Preload queue cleared May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::ClearQueue May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::stop May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::stPlaybackTimer May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrackBlock May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::serviceStop May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 9 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::serviceStop May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::stop May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand stop May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::clearPlayQueue May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::saveQueue May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushQueue May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::addQueueItems May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::addQueueItems May 01 11:50:25 volumio volumio[860]: info: Preload queue cleared May 01 11:50:25 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_01.mp3 May 01 11:50:25 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_01.mp3 May 01 11:50:25 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_02.mp3 May 01 11:50:25 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_02.mp3 May 01 11:50:25 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_03.mp3 May 01 11:50:25 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_03.mp3 May 01 11:50:25 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_04.mp3 May 01 11:50:25 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_04.mp3 May 01 11:50:25 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_05.mp3 May 01 11:50:25 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_05.mp3 May 01 11:50:25 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_06.mp3 May 01 11:50:25 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_06.mp3 May 01 11:50:25 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_07_Lyuba.mp3 May 01 11:50:25 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_07_Lyuba.mp3 May 01 11:50:25 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_08.mp3 May 01 11:50:25 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_08.mp3 May 01 11:50:25 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_09.mp3 May 01 11:50:25 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_09.mp3 May 01 11:50:25 volumio volumio[860]: info: Adding Item to queue: music-library/INTERNAL/test/part_1_set_10.mp3 May 01 11:50:25 volumio volumio[860]: info: Using cached record of: music-library/INTERNAL/test/part_1_set_10.mp3 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushQueue May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::saveQueue May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrackBlock May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPlay May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::play index 8 May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::stop May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::play index undefined May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::startPlaybackTimer May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/test/part_1_set_09.mp3 May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand stop May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand stop took 49 milliseconds May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand stop took 9 milliseconds May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand clear May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:25 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand status took 12 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand clear took 12 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand status took 10 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand status took 10 milliseconds May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/test/part_1_set_09.mp3" May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: 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} May 01 11:50:25 volumio volumio[860]: verbose: CURRENT POSITION 8 May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState stateService stop May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: No code May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: 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} May 01 11:50:25 volumio volumio[860]: verbose: CURRENT POSITION 8 May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState stateService stop May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: No code May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 92ms May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 91ms May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:25 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:25 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:25 volumio volumio[860]: error: updateQueue error: null May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:25 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 94ms May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand playlistinfo took 90 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand add "INTERNAL/test/part_1_set_09.mp3" took 90 milliseconds May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 7ms May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 6ms May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand play May 01 11:50:25 volumio volumio[860]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 107ms May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:25 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces system playlist update May 01 11:50:25 volumio volumio[860]: info: Ignoring MPD Status Update May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 41ms May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand play took 38 milliseconds May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 37ms May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 36ms May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand status took 23 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand status took 20 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand status took 18 milliseconds May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:25 volumio volumio[860]: info: May 01 11:50:25 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::getState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand status May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand status took 19 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand playlistinfo took 18 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand playlistinfo took 17 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand playlistinfo took 16 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand status took 15 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand status took 13 milliseconds May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseState May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_09.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_09.mp3","trackType":"mp3"} May 01 11:50:25 volumio volumio[860]: verbose: CURRENT POSITION 8 May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus stop May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_09.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_09.mp3","trackType":"mp3"} May 01 11:50:25 volumio volumio[860]: verbose: CURRENT POSITION 8 May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:25 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_09.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_09.mp3","trackType":"mp3"} May 01 11:50:25 volumio volumio[860]: verbose: CURRENT POSITION 8 May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:25 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 78ms May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 116ms May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 113ms May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand playlistinfo took 76 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand playlistinfo took 75 milliseconds May 01 11:50:25 volumio volumio[860]: info: sendMpdCommand playlistinfo took 74 milliseconds May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:25 volumio volumio[860]: verbose: ControllerMpd::parseTrackInfo May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_09.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_09.mp3","trackType":"mp3"} May 01 11:50:25 volumio volumio[860]: verbose: CURRENT POSITION 8 May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:25 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_09.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_09.mp3","trackType":"mp3"} May 01 11:50:25 volumio volumio[860]: verbose: CURRENT POSITION 8 May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:25 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: ControllerMpd::pushState May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::servicePushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"part_1_set_09.mp3","artist":null,"album":null,"uri":"INTERNAL/test/part_1_set_09.mp3","trackType":"mp3"} May 01 11:50:25 volumio volumio[860]: verbose: CURRENT POSITION 8 May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState stateService play May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::syncState currentStatus play May 01 11:50:25 volumio volumio[860]: info: Received an update from plugin. extracting info from payload May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:25 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:25 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 194ms May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 188ms May 01 11:50:25 volumio volumio[860]: info: ------------------------------ 187ms May 01 11:50:43 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 11:50:43 volumio volumio[860]: info: CURURI: music-library/INTERNAL/test May 01 11:50:43 volumio volumio[860]: info: Preload queue cleared May 01 11:50:45 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 11:50:45 volumio volumio[860]: info: CURURI: music-library/INTERNAL May 01 11:50:45 volumio volumio[860]: info: Preload queue cleared May 01 11:50:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 11:50:47 volumio volumio[860]: info: CURURI: music-library/USB May 01 11:50:47 volumio volumio[860]: info: Preload queue cleared May 01 11:50:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 11:50:48 volumio volumio[860]: info: CURURI: music-library/USB/04AC-A364 May 01 11:50:48 volumio volumio[860]: info: Preload queue cleared May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- #KUPALA - Jerry Heil, alyona alyona, Ela..mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- #НЕСЕСТРИ -Jerry Heil & Людмила Шемаєва (МАМА).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Alina Pash - BOSORKANYA (Official Video).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Alina Pash - Ласки дівочі (lyric video).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Alina Pash - Тіні Забутих Предків (Lyric video).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Alisa Sova - Ой там на горі.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Anna Nadzion - Verbovaya Doshchechka (Ukrainian folk) українська народна пісня _Вербовая дощечка_.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Authentix - Мавка.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- CHEEV - Гарно так (MOOD VIDEO).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- DakhaBrakha - Monakh.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- DakhaBrakha - Sho z-pod duba (Live on KEXP).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- FIINKA - Довбуш _ Eurovision 2023 Ukraine.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- FIINKA feat ZAPAL - Зірочки.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Folknery - Karchata (Official video) _ Фолькнери - Карчата.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Go_A - ШУМ (Official Video).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Jamala - 1944 (Official Music Video).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- KALUSH feat Skofka - Додому.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- KAZKA — Плакала [Official Video].mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- KOZAK SIROMAHA - Засвіт встали козаченьки.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- KRUTЬ – Колискова (Lyric Video) _ EUROVISION 2023.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- LATEXFAUNA BOHUN _ audio & lyrics.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- ONUKA - ZENIT (Official Music Video).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- OZERNA.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Pink Floyd - Hey Hey Rise Up (feat. Andriy Khlyvnyuk of Boombox).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Rock-H _ Рокаш та Ангеліна Моняк - ЧОМ ТА ЧОМ (official video).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Serge Proshe, July Vitraniuk - Mother Dreams (Original Mix) [Outta Limits].mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- SKOFKA - ЧУТИ ГІМН.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- STASYA - Дівка.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- The Doox - Колискова (Live).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- The Doox & July Vitraniuk - Гопак_Hopak.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- THE HARDKISS - Журавлi (official video).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Wellboy - Гуси ??.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- YAGODY - Зелена Ліщина (2021).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- YARMAK - RAGNAROK.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- ZAPAL - Семантика.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- ВИА _Смеричка_ -Червона рута-1971г..mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Володимир Івасюк _Я піду в далекі гори_.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Вона.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Древо - Ой там на горi.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Ірина Білик - Мовчати (OFFICIAL VIDEO).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Мандри - Мельника дочка.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Ми помрем не в Парижі (feat. Каша Сальцова).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Ніна Матвієнко - Квітка душа.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Один в каное - Ікони (Шістдесятникам).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Один в каное - У мене немає дому _ Odyn v kanoe - I have no home.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Ой на горі вогонь горить (Ukrainian Cossack song).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Океан Ельзи and Coldplay - Обійми (live HD).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Оксана Муха - Гуцулко Ксеню (live).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Олег Скрипка — Гуцулка Ксеня [Official Audio].mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Подобається, як ти ідеш.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Порізала_м пальчик, та й болить.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Руслана - Знаю Я (offical music video).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Святослав Вакарчук та Христина Соловій - Гамерицький край.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Скрябин Кузьма Спи собі сама (HD).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Христина Соловій - Тримай (official video).mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/- Элина Иващенко (Украина) - Ой, у вишневому саду.mp3 May 01 11:50:48 volumio volumio[860]: info: Preloading song: music-library/USB/04AC-A364/Metallica_ Live in San Francisco, CA - November 3, 2018 (AWMH Helping Hands Concert) [Full Concert] (online-audio-converter.com).mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- #KUPALA - Jerry Heil, alyona alyona, Ela..mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%23KUPALA%20-%20Jerry%20Heil%2C%20alyona%20alyona%2C%20Ela..mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- #KUPALA - Jerry Heil, alyona alyona, Ela..mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- #НЕСЕСТРИ -Jerry Heil & Людмила Шемаєва (МАМА).mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%23%D0%9D%D0%95%D0%A1%D0%95%D0%A1%D0%A2%D0%A0%D0%98%20-Jerry%20Heil%20%26%20%D0%9B%D1%8E%D0%B4%D0%BC%D0%B8%D0%BB%D0%B0%20%D0%A8%D0%B5%D0%BC%D0%B0%D1%94%D0%B2%D0%B0%20(%D0%9C%D0%90%D0%9C%D0%90).mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- #НЕСЕСТРИ -Jerry Heil & Людмила Шемаєва (МАМА).mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Alina Pash - BOSORKANYA (Official Video).mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Alina%20Pash%20-%20BOSORKANYA%20(Official%20Video).mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Alina Pash - BOSORKANYA (Official Video).mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Alina Pash - Ласки дівочі (lyric video).mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Alina%20Pash%20-%20%D0%9B%D0%B0%D1%81%D0%BA%D0%B8%20%D0%B4%D1%96%D0%B2%D0%BE%D1%87%D1%96%20(lyric%20video).mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Alina Pash - Ласки дівочі (lyric video).mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Alina Pash - Тіні Забутих Предків (Lyric video).mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Alina%20Pash%20-%20%D0%A2%D1%96%D0%BD%D1%96%20%D0%97%D0%B0%D0%B1%D1%83%D1%82%D0%B8%D1%85%20%D0%9F%D1%80%D0%B5%D0%B4%D0%BA%D1%96%D0%B2%20(Lyric%20video).mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Alina Pash - Тіні Забутих Предків (Lyric video).mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Alisa Sova - Ой там на горі.mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Alisa%20Sova%20-%20%D0%9E%D0%B9%20%D1%82%D0%B0%D0%BC%20%D0%BD%D0%B0%20%D0%B3%D0%BE%D1%80%D1%96.mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Alisa Sova - Ой там на горі.mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Anna Nadzion - Verbovaya Doshchechka (Ukrainian folk) українська народна пісня _Вербовая дощечка_.mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Anna%20Nadzion%20-%20Verbovaya%20Doshchechka%20(Ukrainian%20folk)%20%D1%83%D0%BA%D1%80%D0%B0%D1%97%D0%BD%D1%81%D1%8C%D0%BA%D0%B0%20%D0%BD%D0%B0%D1%80%D0%BE%D0%B4%D0%BD%D0%B0%20%D0%BF%D1%96%D1%81%D0%BD%D1%8F%20_%D0%92%D0%B5%D1%80%D0%B1%D0%BE%D0%B2%D0%B0%D1%8F%20%D0%B4%D0%BE%D1%89%D0%B5%D1%87%D0%BA%D0%B0_.mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Anna Nadzion - Verbovaya Doshchechka (Ukrainian folk) українська народна пісня _Вербовая дощечка_.mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Authentix - Мавка.mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Authentix%20-%20%D0%9C%D0%B0%D0%B2%D0%BA%D0%B0.mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Authentix - Мавка.mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- CHEEV - Гарно так (MOOD VIDEO).mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20CHEEV%20-%20%D0%93%D0%B0%D1%80%D0%BD%D0%BE%20%D1%82%D0%B0%D0%BA%20(MOOD%20VIDEO).mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- CHEEV - Гарно так (MOOD VIDEO).mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- DakhaBrakha - Monakh.mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20DakhaBrakha%20-%20Monakh.mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- DakhaBrakha - Monakh.mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- DakhaBrakha - Sho z-pod duba (Live on KEXP).mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20DakhaBrakha%20-%20Sho%20z-pod%20duba%20(Live%20on%20KEXP).mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- DakhaBrakha - Sho z-pod duba (Live on KEXP).mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- FIINKA - Довбуш _ Eurovision 2023 Ukraine.mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20FIINKA%20-%20%D0%94%D0%BE%D0%B2%D0%B1%D1%83%D1%88%20_%20Eurovision%202023%20Ukraine.mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- FIINKA - Довбуш _ Eurovision 2023 Ukraine.mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- FIINKA feat ZAPAL - Зірочки.mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20FIINKA%20feat%20ZAPAL%20-%20%D0%97%D1%96%D1%80%D0%BE%D1%87%D0%BA%D0%B8.mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- FIINKA feat ZAPAL - Зірочки.mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Folknery - Karchata (Official video) _ Фолькнери - Карчата.mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Folknery%20-%20Karchata%20(Official%20video)%20_%20%D0%A4%D0%BE%D0%BB%D1%8C%D0%BA%D0%BD%D0%B5%D1%80%D0%B8%20-%20%D0%9A%D0%B0%D1%80%D1%87%D0%B0%D1%82%D0%B0.mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Folknery - Karchata (Official video) _ Фолькнери - Карчата.mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Go_A - ШУМ (Official Video).mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Go_A%20-%20%D0%A8%D0%A3%D0%9C%20(Official%20Video).mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Go_A - ШУМ (Official Video).mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Jamala - 1944 (Official Music Video).mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Jamala%20-%201944%20(Official%20Music%20Video).mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Jamala - 1944 (Official Music Video).mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- KALUSH feat Skofka - Додому.mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20KALUSH%20feat%20Skofka%20-%20%D0%94%D0%BE%D0%B4%D0%BE%D0%BC%D1%83.mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- KALUSH feat Skofka - Додому.mp3 May 01 11:50:48 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- KAZKA — Плакала [Official Video].mp3 in service mpd May 01 11:50:48 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20KAZKA%20%E2%80%94%20%D0%9F%D0%BB%D0%B0%D0%BA%D0%B0%D0%BB%D0%B0%20%5BOfficial%20Video%5D.mp3&metadata=false May 01 11:50:48 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- KAZKA — Плакала [Official Video].mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- KOZAK SIROMAHA - Засвіт встали козаченьки.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20KOZAK%20SIROMAHA%20-%20%D0%97%D0%B0%D1%81%D0%B2%D1%96%D1%82%20%D0%B2%D1%81%D1%82%D0%B0%D0%BB%D0%B8%20%D0%BA%D0%BE%D0%B7%D0%B0%D1%87%D0%B5%D0%BD%D1%8C%D0%BA%D0%B8.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- KOZAK SIROMAHA - Засвіт встали козаченьки.mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- KRUTЬ – Колискова (Lyric Video) _ EUROVISION 2023.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20KRUT%D0%AC%20%E2%80%93%20%D0%9A%D0%BE%D0%BB%D0%B8%D1%81%D0%BA%D0%BE%D0%B2%D0%B0%20(Lyric%20Video)%20_%20EUROVISION%202023.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- KRUTЬ – Колискова (Lyric Video) _ EUROVISION 2023.mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- LATEXFAUNA BOHUN _ audio & lyrics.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20LATEXFAUNA%20BOHUN%20%20_%20audio%20%26%20lyrics.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- LATEXFAUNA BOHUN _ audio & lyrics.mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- ONUKA - ZENIT (Official Music Video).mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20ONUKA%20-%20ZENIT%20(Official%20Music%20Video).mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- ONUKA - ZENIT (Official Music Video).mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- OZERNA.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20OZERNA.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- OZERNA.mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Pink Floyd - Hey Hey Rise Up (feat. Andriy Khlyvnyuk of Boombox).mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Pink%20Floyd%20-%20Hey%20Hey%20Rise%20Up%20(feat.%20Andriy%20Khlyvnyuk%20of%20Boombox).mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Pink Floyd - Hey Hey Rise Up (feat. Andriy Khlyvnyuk of Boombox).mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Rock-H _ Рокаш та Ангеліна Моняк - ЧОМ ТА ЧОМ (official video).mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Rock-H%20_%20%D0%A0%D0%BE%D0%BA%D0%B0%D1%88%20%D1%82%D0%B0%20%D0%90%D0%BD%D0%B3%D0%B5%D0%BB%D1%96%D0%BD%D0%B0%20%D0%9C%D0%BE%D0%BD%D1%8F%D0%BA%20-%20%D0%A7%D0%9E%D0%9C%20%D0%A2%D0%90%20%D0%A7%D0%9E%D0%9C%20(official%20video).mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Rock-H _ Рокаш та Ангеліна Моняк - ЧОМ ТА ЧОМ (official video).mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Serge Proshe, July Vitraniuk - Mother Dreams (Original Mix) [Outta Limits].mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Serge%20Proshe%2C%20July%20Vitraniuk%20-%20Mother%20Dreams%20(Original%20Mix)%20%5BOutta%20Limits%5D.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Serge Proshe, July Vitraniuk - Mother Dreams (Original Mix) [Outta Limits].mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- SKOFKA - ЧУТИ ГІМН.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20SKOFKA%20-%20%D0%A7%D0%A3%D0%A2%D0%98%20%D0%93%D0%86%D0%9C%D0%9D.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- SKOFKA - ЧУТИ ГІМН.mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- STASYA - Дівка.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20STASYA%20-%20%D0%94%D1%96%D0%B2%D0%BA%D0%B0.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- STASYA - Дівка.mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- The Doox - Колискова (Live).mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20The%20Doox%20%20-%20%D0%9A%D0%BE%D0%BB%D0%B8%D1%81%D0%BA%D0%BE%D0%B2%D0%B0%20(Live).mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- The Doox - Колискова (Live).mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- The Doox & July Vitraniuk - Гопак_Hopak.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20The%20Doox%20%26%20July%20Vitraniuk%20-%20%D0%93%D0%BE%D0%BF%D0%B0%D0%BA_Hopak.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- The Doox & July Vitraniuk - Гопак_Hopak.mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- THE HARDKISS - Журавлi (official video).mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20THE%20HARDKISS%20-%20%D0%96%D1%83%D1%80%D0%B0%D0%B2%D0%BBi%20(official%20video).mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- THE HARDKISS - Журавлi (official video).mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Wellboy - Гуси ??.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20Wellboy%20-%20%D0%93%D1%83%D1%81%D0%B8%20%3F%3F.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Wellboy - Гуси ??.mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- YAGODY - Зелена Ліщина (2021).mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20YAGODY%20-%20%D0%97%D0%B5%D0%BB%D0%B5%D0%BD%D0%B0%20%D0%9B%D1%96%D1%89%D0%B8%D0%BD%D0%B0%20(2021).mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- YAGODY - Зелена Ліщина (2021).mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- YARMAK - RAGNAROK.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20YARMAK%20-%20RAGNAROK.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- YARMAK - RAGNAROK.mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- ZAPAL - Семантика.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20ZAPAL%20-%20%D0%A1%D0%B5%D0%BC%D0%B0%D0%BD%D1%82%D0%B8%D0%BA%D0%B0.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- ZAPAL - Семантика.mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- ВИА _Смеричка_ -Червона рута-1971г..mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%92%D0%98%D0%90%20_%D0%A1%D0%BC%D0%B5%D1%80%D0%B8%D1%87%D0%BA%D0%B0_%20-%D0%A7%D0%B5%D1%80%D0%B2%D0%BE%D0%BD%D0%B0%20%D1%80%D1%83%D1%82%D0%B0-1971%D0%B3..mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- ВИА _Смеричка_ -Червона рута-1971г..mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Володимир Івасюк _Я піду в далекі гори_.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%92%D0%BE%D0%BB%D0%BE%D0%B4%D0%B8%D0%BC%D0%B8%D1%80%20%D0%86%D0%B2%D0%B0%D1%81%D1%8E%D0%BA%20_%D0%AF%20%D0%BF%D1%96%D0%B4%D1%83%20%D0%B2%20%D0%B4%D0%B0%D0%BB%D0%B5%D0%BA%D1%96%20%D0%B3%D0%BE%D1%80%D0%B8_.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Володимир Івасюк _Я піду в далекі гори_.mp3 May 01 11:50:49 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Вона.mp3 in service mpd May 01 11:50:49 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%92%D0%BE%D0%BD%D0%B0.mp3&metadata=false May 01 11:50:49 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Вона.mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Древо - Ой там на горi.mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%94%D1%80%D0%B5%D0%B2%D0%BE%20-%20%D0%9E%D0%B9%20%D1%82%D0%B0%D0%BC%20%D0%BD%D0%B0%20%D0%B3%D0%BE%D1%80i.mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Древо - Ой там на горi.mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Ірина Білик - Мовчати (OFFICIAL VIDEO).mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%86%D1%80%D0%B8%D0%BD%D0%B0%20%D0%91%D1%96%D0%BB%D0%B8%D0%BA%20-%20%D0%9C%D0%BE%D0%B2%D1%87%D0%B0%D1%82%D0%B8%20(OFFICIAL%20VIDEO).mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Ірина Білик - Мовчати (OFFICIAL VIDEO).mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Мандри - Мельника дочка.mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%9C%D0%B0%D0%BD%D0%B4%D1%80%D0%B8%20-%20%D0%9C%D0%B5%D0%BB%D1%8C%D0%BD%D0%B8%D0%BA%D0%B0%20%D0%B4%D0%BE%D1%87%D0%BA%D0%B0.mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Мандри - Мельника дочка.mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Ми помрем не в Парижі (feat. Каша Сальцова).mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%9C%D0%B8%20%D0%BF%D0%BE%D0%BC%D1%80%D0%B5%D0%BC%20%D0%BD%D0%B5%20%D0%B2%20%D0%9F%D0%B0%D1%80%D0%B8%D0%B6%D1%96%20(feat.%20%D0%9A%D0%B0%D1%88%D0%B0%20%D0%A1%D0%B0%D0%BB%D1%8C%D1%86%D0%BE%D0%B2%D0%B0).mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Ми помрем не в Парижі (feat. Каша Сальцова).mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Ніна Матвієнко - Квітка душа.mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%9D%D1%96%D0%BD%D0%B0%20%D0%9C%D0%B0%D1%82%D0%B2%D1%96%D1%94%D0%BD%D0%BA%D0%BE%20-%20%D0%9A%D0%B2%D1%96%D1%82%D0%BA%D0%B0%20%D0%B4%D1%83%D1%88%D0%B0.mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Ніна Матвієнко - Квітка душа.mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Один в каное - Ікони (Шістдесятникам).mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%9E%D0%B4%D0%B8%D0%BD%20%D0%B2%20%D0%BA%D0%B0%D0%BD%D0%BE%D0%B5%20-%20%D0%86%D0%BA%D0%BE%D0%BD%D0%B8%20(%D0%A8%D1%96%D1%81%D1%82%D0%B4%D0%B5%D1%81%D1%8F%D1%82%D0%BD%D0%B8%D0%BA%D0%B0%D0%BC).mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Один в каное - Ікони (Шістдесятникам).mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Один в каное - У мене немає дому _ Odyn v kanoe - I have no home.mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%9E%D0%B4%D0%B8%D0%BD%20%D0%B2%20%D0%BA%D0%B0%D0%BD%D0%BE%D0%B5%20-%20%D0%A3%20%D0%BC%D0%B5%D0%BD%D0%B5%20%D0%BD%D0%B5%D0%BC%D0%B0%D1%94%20%D0%B4%D0%BE%D0%BC%D1%83%20_%20Odyn%20v%20kanoe%20-%20I%20have%20no%20home.mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Один в каное - У мене немає дому _ Odyn v kanoe - I have no home.mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Ой на горі вогонь горить (Ukrainian Cossack song).mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%9E%D0%B9%20%D0%BD%D0%B0%20%D0%B3%D0%BE%D1%80%D1%96%20%D0%B2%D0%BE%D0%B3%D0%BE%D0%BD%D1%8C%20%D0%B3%D0%BE%D1%80%D0%B8%D1%82%D1%8C%20(Ukrainian%20Cossack%20song).mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Ой на горі вогонь горить (Ukrainian Cossack song).mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Океан Ельзи and Coldplay - Обійми (live HD).mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%9E%D0%BA%D0%B5%D0%B0%D0%BD%20%D0%95%D0%BB%D1%8C%D0%B7%D0%B8%20and%20Coldplay%20-%20%D0%9E%D0%B1%D1%96%D0%B9%D0%BC%D0%B8%20(live%20HD).mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Океан Ельзи and Coldplay - Обійми (live HD).mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Оксана Муха - Гуцулко Ксеню (live).mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%9E%D0%BA%D1%81%D0%B0%D0%BD%D0%B0%20%D0%9C%D1%83%D1%85%D0%B0%20-%20%D0%93%D1%83%D1%86%D1%83%D0%BB%D0%BA%D0%BE%20%D0%9A%D1%81%D0%B5%D0%BD%D1%8E%20(live).mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Оксана Муха - Гуцулко Ксеню (live).mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Олег Скрипка — Гуцулка Ксеня [Official Audio].mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%9E%D0%BB%D0%B5%D0%B3%20%D0%A1%D0%BA%D1%80%D0%B8%D0%BF%D0%BA%D0%B0%20%E2%80%94%20%D0%93%D1%83%D1%86%D1%83%D0%BB%D0%BA%D0%B0%20%D0%9A%D1%81%D0%B5%D0%BD%D1%8F%20%5BOfficial%20Audio%5D.mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Олег Скрипка — Гуцулка Ксеня [Official Audio].mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Подобається, як ти ідеш.mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%9F%D0%BE%D0%B4%D0%BE%D0%B1%D0%B0%D1%94%D1%82%D1%8C%D1%81%D1%8F%2C%20%D1%8F%D0%BA%20%D1%82%D0%B8%20%D1%96%D0%B4%D0%B5%D1%88.mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Подобається, як ти ідеш.mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Порізала_м пальчик, та й болить.mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%9F%D0%BE%D1%80%D1%96%D0%B7%D0%B0%D0%BB%D0%B0_%D0%BC%20%D0%BF%D0%B0%D0%BB%D1%8C%D1%87%D0%B8%D0%BA%2C%20%D1%82%D0%B0%20%D0%B9%20%D0%B1%D0%BE%D0%BB%D0%B8%D1%82%D1%8C.mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Порізала_м пальчик, та й болить.mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Руслана - Знаю Я (offical music video).mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%A0%D1%83%D1%81%D0%BB%D0%B0%D0%BD%D0%B0%20-%20%D0%97%D0%BD%D0%B0%D1%8E%20%D0%AF%20(offical%20music%20video).mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Руслана - Знаю Я (offical music video).mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Святослав Вакарчук та Христина Соловій - Гамерицький край.mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%A1%D0%B2%D1%8F%D1%82%D0%BE%D1%81%D0%BB%D0%B0%D0%B2%20%D0%92%D0%B0%D0%BA%D0%B0%D1%80%D1%87%D1%83%D0%BA%20%D1%82%D0%B0%20%D0%A5%D1%80%D0%B8%D1%81%D1%82%D0%B8%D0%BD%D0%B0%20%D0%A1%D0%BE%D0%BB%D0%BE%D0%B2%D1%96%D0%B9%20-%20%D0%93%D0%B0%D0%BC%D0%B5%D1%80%D0%B8%D1%86%D1%8C%D0%BA%D0%B8%D0%B9%20%D0%BA%D1%80%D0%B0%D0%B9.mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Святослав Вакарчук та Христина Соловій - Гамерицький край.mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Скрябин Кузьма Спи собі сама (HD).mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%A1%D0%BA%D1%80%D1%8F%D0%B1%D0%B8%D0%BD%20%D0%9A%D1%83%D0%B7%D1%8C%D0%BC%D0%B0%20%D0%A1%D0%BF%D0%B8%20%D1%81%D0%BE%D0%B1%D1%96%20%D1%81%D0%B0%D0%BC%D0%B0%20(HD).mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Скрябин Кузьма Спи собі сама (HD).mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Христина Соловій - Тримай (official video).mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%A5%D1%80%D0%B8%D1%81%D1%82%D0%B8%D0%BD%D0%B0%20%D0%A1%D0%BE%D0%BB%D0%BE%D0%B2%D1%96%D0%B9%20-%20%D0%A2%D1%80%D0%B8%D0%BC%D0%B0%D0%B9%20(official%20video).mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Христина Соловій - Тримай (official video).mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/- Элина Иващенко (Украина) - Ой, у вишневому саду.mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2F-%20%D0%AD%D0%BB%D0%B8%D0%BD%D0%B0%20%D0%98%D0%B2%D0%B0%D1%89%D0%B5%D0%BD%D0%BA%D0%BE%20(%D0%A3%D0%BA%D1%80%D0%B0%D0%B8%D0%BD%D0%B0)%20-%20%20%D0%9E%D0%B9%2C%20%D1%83%20%D0%B2%D0%B8%D1%88%D0%BD%D0%B5%D0%B2%D0%BE%D0%BC%D1%83%20%D1%81%D0%B0%D0%B4%D1%83.mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/- Элина Иващенко (Украина) - Ой, у вишневому саду.mp3 May 01 11:50:50 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/Metallica_ Live in San Francisco, CA - November 3, 2018 (AWMH Helping Hands Concert) [Full Concert] (online-audio-converter.com).mp3 in service mpd May 01 11:50:50 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=Will%20Weems//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FMetallica_%20Live%20in%20San%20Francisco%2C%20CA%20-%20November%203%2C%202018%20(AWMH%20Helping%20Hands%20Concert)%20%5BFull%20Concert%5D%20(online-audio-converter.com).mp3&metadata=false May 01 11:50:50 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/Metallica_ Live in San Francisco, CA - November 3, 2018 (AWMH Helping Hands Concert) [Full Concert] (online-audio-converter.com).mp3 May 01 11:50:56 volumio volumio[860]: info: Preload queue cleared May 01 11:50:56 volumio volumio[860]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 11:50:56 volumio volumio[860]: info: CoreStateMachine::ClearQueue May 01 11:50:56 volumio volumio[860]: info: CoreStateMachine::stop May 01 11:50:56 volumio volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 11:50:56 volumio volumio[860]: info: CoreStateMachine::stPlaybackTimer May 01 11:50:56 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock May 01 11:50:56 volumio volumio[860]: info: CorePlayQueue::getTrackBlock May 01 11:50:56 volumio volumio[860]: info: CoreStateMachine::pushState May 01 11:50:56 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:56 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 11:50:56 volumio volumio[860]: info: CoreCommandRouter::volumioPushState May 01 11:50:56 volumio volumio[860]: info: CoreStateMachine::serviceStop May 01 11:50:56 volumio volumio[860]: info: CorePlayQueue::getTrack 8 May 01 11:50:56 volumio volumio[860]: info: CoreCommandRouter::serviceStop May 01 11:50:56 volumio volumio[860]: info: ControllerMpd::stop May 01 11:50:56 volumio volumio[860]: verbose: ControllerMpd::sendMpdCommand stop May 01 11:50:56 volumio volumio[860]: info: CorePlayQueue::clearPlayQueue May 01 11:50:56 volumio volumio[860]: info: CorePlayQueue::saveQueue May 01 11:50:56 volumio volumio[860]: info: CoreCommandRouter::volumioPushQueue May 01 11:50:56 volumio volumio[860]: info: CoreStateMachine::addQueueItems May 01 11:50:56 volumio volumio[860]: info: CorePlayQueue::addQueueItems May 01 11:50:56 volumio volumio[860]: info: Preload queue cleared May 01 11:50:56 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- #KUPALA - Jerry Heil, alyona alyona, Ela..mp3 May 01 11:50:56 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- #KUPALA - Jerry Heil, alyona alyona, Ela..mp3 May 01 11:50:56 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- #НЕСЕСТРИ -Jerry Heil & Людмила Шемаєва (МАМА).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- #НЕСЕСТРИ -Jerry Heil & Людмила Шемаєва (МАМА).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Alina Pash - BOSORKANYA (Official Video).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Alina Pash - BOSORKANYA (Official Video).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Alina Pash - Ласки дівочі (lyric video).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Alina Pash - Ласки дівочі (lyric video).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Alina Pash - Тіні Забутих Предків (Lyric video).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Alina Pash - Тіні Забутих Предків (Lyric video).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Alisa Sova - Ой там на горі.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Alisa Sova - Ой там на горі.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Anna Nadzion - Verbovaya Doshchechka (Ukrainian folk) українська народна пісня _Вербовая дощечка_.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Anna Nadzion - Verbovaya Doshchechka (Ukrainian folk) українська народна пісня _Вербовая дощечка_.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Authentix - Мавка.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Authentix - Мавка.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- CHEEV - Гарно так (MOOD VIDEO).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- CHEEV - Гарно так (MOOD VIDEO).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- DakhaBrakha - Monakh.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- DakhaBrakha - Monakh.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- DakhaBrakha - Sho z-pod duba (Live on KEXP).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- DakhaBrakha - Sho z-pod duba (Live on KEXP).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- FIINKA - Довбуш _ Eurovision 2023 Ukraine.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- FIINKA - Довбуш _ Eurovision 2023 Ukraine.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- FIINKA feat ZAPAL - Зірочки.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- FIINKA feat ZAPAL - Зірочки.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Folknery - Karchata (Official video) _ Фолькнери - Карчата.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Folknery - Karchata (Official video) _ Фолькнери - Карчата.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Go_A - ШУМ (Official Video).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Go_A - ШУМ (Official Video).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Jamala - 1944 (Official Music Video).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Jamala - 1944 (Official Music Video).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- KALUSH feat Skofka - Додому.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- KALUSH feat Skofka - Додому.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- KAZKA — Плакала [Official Video].mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- KAZKA — Плакала [Official Video].mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- KOZAK SIROMAHA - Засвіт встали козаченьки.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- KOZAK SIROMAHA - Засвіт встали козаченьки.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- KRUTЬ – Колискова (Lyric Video) _ EUROVISION 2023.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- KRUTЬ – Колискова (Lyric Video) _ EUROVISION 2023.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- LATEXFAUNA BOHUN _ audio & lyrics.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- LATEXFAUNA BOHUN _ audio & lyrics.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- ONUKA - ZENIT (Official Music Video).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- ONUKA - ZENIT (Official Music Video).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- OZERNA.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- OZERNA.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Pink Floyd - Hey Hey Rise Up (feat. Andriy Khlyvnyuk of Boombox).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Pink Floyd - Hey Hey Rise Up (feat. Andriy Khlyvnyuk of Boombox).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Rock-H _ Рокаш та Ангеліна Моняк - ЧОМ ТА ЧОМ (official video).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Rock-H _ Рокаш та Ангеліна Моняк - ЧОМ ТА ЧОМ (official video).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Serge Proshe, July Vitraniuk - Mother Dreams (Original Mix) [Outta Limits].mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Serge Proshe, July Vitraniuk - Mother Dreams (Original Mix) [Outta Limits].mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- SKOFKA - ЧУТИ ГІМН.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- SKOFKA - ЧУТИ ГІМН.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- STASYA - Дівка.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- STASYA - Дівка.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- The Doox - Колискова (Live).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- The Doox - Колискова (Live).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- The Doox & July Vitraniuk - Гопак_Hopak.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- The Doox & July Vitraniuk - Гопак_Hopak.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- THE HARDKISS - Журавлi (official video).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- THE HARDKISS - Журавлi (official video).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Wellboy - Гуси ??.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Wellboy - Гуси ??.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- YAGODY - Зелена Ліщина (2021).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- YAGODY - Зелена Ліщина (2021).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- YARMAK - RAGNAROK.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- YARMAK - RAGNAROK.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- ZAPAL - Семантика.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- ZAPAL - Семантика.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- ВИА _Смеричка_ -Червона рута-1971г..mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- ВИА _Смеричка_ -Червона рута-1971г..mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Володимир Івасюк _Я піду в далекі гори_.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Володимир Івасюк _Я піду в далекі гори_.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Вона.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Вона.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Древо - Ой там на горi.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Древо - Ой там на горi.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Ірина Білик - Мовчати (OFFICIAL VIDEO).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Ірина Білик - Мовчати (OFFICIAL VIDEO).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Мандри - Мельника дочка.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Мандри - Мельника дочка.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Ми помрем не в Парижі (feat. Каша Сальцова).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Ми помрем не в Парижі (feat. Каша Сальцова).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Ніна Матвієнко - Квітка душа.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Ніна Матвієнко - Квітка душа.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Один в каное - Ікони (Шістдесятникам).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Один в каное - Ікони (Шістдесятникам).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Один в каное - У мене немає дому _ Odyn v kanoe - I have no home.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Один в каное - У мене немає дому _ Odyn v kanoe - I have no home.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Ой на горі вогонь горить (Ukrainian Cossack song).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Ой на горі вогонь горить (Ukrainian Cossack song).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Океан Ельзи and Coldplay - Обійми (live HD).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Океан Ельзи and Coldplay - Обійми (live HD).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Оксана Муха - Гуцулко Ксеню (live).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Оксана Муха - Гуцулко Ксеню (live).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Олег Скрипка — Гуцулка Ксеня [Official Audio].mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Олег Скрипка — Гуцулка Ксеня [Official Audio].mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Подобається, як ти ідеш.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Подобається, як ти ідеш.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Порізала_м пальчик, та й болить.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Порізала_м пальчик, та й болить.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Руслана - Знаю Я (offical music video).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Руслана - Знаю Я (offical music video).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Святослав Вакарчук та Христина Соловій - Гамерицький край.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Святослав Вакарчук та Христина Соловій - Гамерицький край.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Скрябин Кузьма Спи собі сама (HD).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Скрябин Кузьма Спи собі сама (HD).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Христина Соловій - Тримай (official video).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Христина Соловій - Тримай (official video).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/- Элина Иващенко (Украина) - Ой, у вишневому саду.mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/- Элина Иващенко (Украина) - Ой, у вишневому саду.mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/Metallica_ Live in San Francisco, CA - November 3, 2018 (AWMH Helping Hands Concert) [Full Concert] (online-audio-converter.com).mp3 May 01 11:50:57 volumio volumio[860]: info: Using cached record of: music-library/USB/04AC-A364/Metallica_ Live in San Francisco, CA - November 3, 2018 (AWMH Helping Hands Concert) [Full Concert] (online-audio-converter.com).mp3 May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/DakhaBrakha May 01 11:50:57 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/DakhaBrakha in service mpd May 01 11:50:57 volumio volumio[860]: info: Adding Item to queue: music-library/USB/04AC-A364/Ukrainian_day May 01 11:50:57 volumio volumio[860]: info: Exploding uri music-library/USB/04AC-A364/Ukrainian_day in service mpd May 01 11:50:57 volumio volumio[860]: info: May 01 11:50:57 volumio volumio[860]: ---------------------------- MPD announces state update: player May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2F2009%20-%20%D0%9D%D0%B0%20%D0%BC%D0%B5%D0%B6%D1%96%2F%D0%94%D0%B0%D1%85%D0%B0%D0%91%D1%80%D0%B0%D1%85%D0%B0%20-%20%D0%9D%D0%B0%20%D0%BC%D0%B5%D0%B6%D1%96.flac&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/2009 - На межі/ДахаБраха - На межі.flac May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2F2012%20%D0%A5%D0%BC%D0%B5%D0%BB%D0%B5%D0%B2%D0%B0%20project%2FD%D0%90%D0%A5%D0%90%D0%91%D0%A0%D0%90%D0%A5%D0%90%20%26%20PORT%20MONE%20-%20%D0%A5%D0%BC%D0%B5%D0%BB%D0%B5%D0%B2%D0%B0%20project.flac&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/2012 Хмелева project/DАХАБРАХА & PORT MONE - Хмелева project.flac May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2FAstrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)%5Bmp3%5D%2FPeppi_2_01_Peppi_khodyt_po_kramnytsiakh.mp3&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/Astrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)[mp3]/Peppi_2_01_Peppi_khodyt_po_kramnytsiakh.mp3 May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2FAstrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)%5Bmp3%5D%2FPeppi_2_02_Peppi_pyshe_lysta_i_yde_do_shkoly_ale_tilky_nenadovho.mp3&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/Astrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)[mp3]/Peppi_2_02_Peppi_pyshe_lysta_i_yde_do_shkoly_ale_tilky_nenadovho.mp3 May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2FAstrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)%5Bmp3%5D%2FPeppi_2_03_Peppi_yde_zi_shkoliaramy_na_prohulianku.mp3&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/Astrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)[mp3]/Peppi_2_03_Peppi_yde_zi_shkoliaramy_na_prohulianku.mp3 May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2FAstrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)%5Bmp3%5D%2FPeppi_2_04_Peppi_yde_na_yarmarok.mp3&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/Astrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)[mp3]/Peppi_2_04_Peppi_yde_na_yarmarok.mp3 May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2FAstrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)%5Bmp3%5D%2FPeppi_2_05_Peppi_zaznaie_korabelnoi_avarii.mp3&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/Astrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)[mp3]/Peppi_2_05_Peppi_zaznaie_korabelnoi_avarii.mp3 May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2FAstrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)%5Bmp3%5D%2FPeppi_2_06_Do_Peppi_pryizdyt_vysokyi_hist.mp3&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/Astrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)[mp3]/Peppi_2_06_Do_Peppi_pryizdyt_vysokyi_hist.mp3 May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2FAstrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)%5Bmp3%5D%2FPeppi_2_07_Peppi_vlashtovuie_proshchalnyi_benket.mp3&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/Astrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)[mp3]/Peppi_2_07_Peppi_vlashtovuie_proshchalnyi_benket.mp3 May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=//extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2FAstrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)%5Bmp3%5D%2FPeppi_2_08_Peppi_sidaie_na_korabel.mp3&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/Astrid_Lindgren_Peppi_Dovhapanchokha_sidae_na_korabel(2008)[mp3]/Peppi_2_08_Peppi_sidaie_na_korabel.mp3 May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=DakhaBrakha/The%20Road/extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2FDakhaBrakha2016%2FDakhaBrakha%20-%20The%20Road.cue&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/DakhaBrakha2016/DakhaBrakha - The Road.cue May 01 11:50:57 volumio volumio[860]: info: ALBUMART /albumart?cacheid=659&web=DakhaBrakha/The%20Road/extralarge&path=%2Fmnt%2FUSB%2F04AC-A364%2FDakhaBrakha%2FDakhaBrakha2016%2FDakhaBrakha%20-%20The%20Road.cue&metadata=false May 01 11:50:57 volumio volumio[860]: info: URI /mnt/USB/04AC-A364/DakhaBrakha/DakhaBrakha2016/DakhaBrakha - The Road.cue May 01 11:50:57 volumio volumio[860]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 11:50:57 volumio volumio[860]: Error: Unable to resolve or reject the same promise twice May 01 11:50:57 volumio volumio[860]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) May 01 11:50:57 volumio volumio[860]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 May 01 11:50:57 volumio volumio[860]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) May 01 11:50:57 volumio volumio[860]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) May 01 11:50:57 volumio volumio[860]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) May 01 11:50:57 volumio volumio[860]: at Socket.emit (events.js:315:20) May 01 11:50:57 volumio volumio[860]: at addChunk (internal/streams/readable.js:309:12) May 01 11:50:57 volumio volumio[860]: at readableAddChunk (internal/streams/readable.js:280:11) May 01 11:50:57 volumio volumio[860]: at Socket.Readable.push (internal/streams/readable.js:223:10) May 01 11:50:57 volumio volumio[860]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) May 01 11:50:57 volumio volumio[860]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 11:50:57 volumio sudo[2043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 11:49 May 01 11:50:57 volumio sudo[2043]: 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"