-- Logs begin at Wed 2021-10-06 10:34:49 UTC, end at Sat 2026-03-28 06:29:19 UTC. -- Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:28:10 volumio volumio[837]: info: Retrieving Cloud Streaming UI Mar 28 06:28:10 volumio volumio[837]: info: Getting Tidal Cloud Configuration Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:28:10 volumio volumio[837]: info: Getting Qobuz Cloud Configuration Mar 28 06:28:10 volumio volumio[837]: info: Asking plugin for UI Config Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:28:10 volumio volumio[837]: info: Getting Spotify Cloud Configuration Mar 28 06:28:10 volumio volumio[837]: info: Asking plugin for UI Config Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:28:10 volumio volumio[837]: info: Saving Spotify Acccount Mar 28 06:28:10 volumio volumio[837]: info: Got Tidal Cloud Configuration Mar 28 06:28:10 volumio volumio[837]: info: Got it Mar 28 06:28:10 volumio volumio[837]: info: Got it Mar 28 06:28:10 volumio volumio[837]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:28:10 volumio volumio[837]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::volumioGetBrowseSources Mar 28 06:28:10 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 28 06:28:11 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 28 06:28:14 volumio volumio[837]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 28 06:28:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 28 06:28:19 volumio volumio[837]: info: CoreCommandRouter::volumioPlay Mar 28 06:28:19 volumio volumio[837]: verbose: UNSET VOLATILE Mar 28 06:28:19 volumio volumio[837]: info: CoreStateMachine::play index undefined Mar 28 06:28:19 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 06:28:19 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:30 volumio volumio[837]: info: VolumeController::SetAlsaVolume60 Mar 28 06:28:30 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:30 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:30 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:30 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:30 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Unable to find simple control 'SoftMaster',0 Mar 28 06:28:30 volumio volumio[837]: info: VolumeController::SetAlsaVolume60 Mar 28 06:28:30 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:30 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:30 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:30 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:31 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Mar 28 06:28:36 volumio volumio[837]: info: CoreCommandRouter::volumioStop Mar 28 06:28:36 volumio volumio[837]: info: CoreStateMachine::stop Mar 28 06:28:36 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 06:28:36 volumio volumio[837]: verbose: UNSET VOLATILE Mar 28 06:28:36 volumio volumio[837]: info: CoreStateMachine::stPlaybackTimer Mar 28 06:28:36 volumio volumio[837]: info: CoreStateMachine::updateTrackBlock Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrackBlock Mar 28 06:28:37 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:37 volumio volumio[837]: info: CoreStateMachine::serviceStop Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::serviceStop Mar 28 06:28:37 volumio volumio[837]: info: [1774679317036] ControllerWebradio::stop Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand stop Mar 28 06:28:37 volumio volumio[837]: info: Mar 28 06:28:37 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand stop took 49 milliseconds Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:37 volumio volumio[837]: info: Mar 28 06:28:37 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:37 volumio volumio[837]: info: Mar 28 06:28:37 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:37 volumio volumio[837]: info: Mar 28 06:28:37 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:37 volumio volumio[837]: info: Mar 28 06:28:37 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:37 volumio volumio[837]: info: Mar 28 06:28:37 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand status took 88 milliseconds Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand status took 82 milliseconds Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand status took 64 milliseconds Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand status took 58 milliseconds Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand status took 46 milliseconds Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand status took 38 milliseconds Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand playlistinfo took 81 milliseconds Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand playlistinfo took 77 milliseconds Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand playlistinfo took 76 milliseconds Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand playlistinfo took 75 milliseconds Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand playlistinfo took 106 milliseconds Mar 28 06:28:37 volumio volumio[837]: info: sendMpdCommand playlistinfo took 103 milliseconds Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:37 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:37 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:37 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:37 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:37 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:37 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 28 06:28:37 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:37 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:37 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:37 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:37 volumio volumio[837]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 28 06:28:37 volumio volumio[837]: info: ------------------------------ 744ms Mar 28 06:28:37 volumio volumio[837]: info: ------------------------------ 728ms Mar 28 06:28:37 volumio volumio[837]: info: ------------------------------ 717ms Mar 28 06:28:37 volumio volumio[837]: info: ------------------------------ 708ms Mar 28 06:28:37 volumio volumio[837]: info: ------------------------------ 698ms Mar 28 06:28:37 volumio volumio[837]: info: ------------------------------ 687ms Mar 28 06:28:38 volumio volumio[837]: info: CoreCommandRouter::volumioPlay Mar 28 06:28:38 volumio volumio[837]: verbose: UNSET VOLATILE Mar 28 06:28:38 volumio volumio[837]: info: CoreStateMachine::play index undefined Mar 28 06:28:38 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 06:28:38 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:38 volumio volumio[837]: info: CoreStateMachine::startPlaybackTimer Mar 28 06:28:38 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:38 volumio volumio[837]: info: [1774679318242] ControllerWebradio::clearAddPlayTrack Mar 28 06:28:38 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand stop Mar 28 06:28:38 volumio volumio[837]: info: sendMpdCommand stop took 25 milliseconds Mar 28 06:28:38 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand clear Mar 28 06:28:38 volumio volumio[837]: info: Mar 28 06:28:38 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:38 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:38 volumio volumio[837]: info: sendMpdCommand clear took 14 milliseconds Mar 28 06:28:38 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand load "http://ic7.101.ru:8000/v13_1" Mar 28 06:28:38 volumio volumio[837]: info: Mar 28 06:28:38 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:38 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:38 volumio volumio[837]: info: Mar 28 06:28:38 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:38 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:38 volumio volumio[837]: info: Mar 28 06:28:38 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:38 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:38 volumio volumio[837]: info: Mar 28 06:28:38 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:38 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:38 volumio volumio[837]: info: Mar 28 06:28:38 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:38 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:38 volumio volumio[837]: error: updateQueue error: null Mar 28 06:28:38 volumio volumio[837]: info: ------------------------------ 78ms Mar 28 06:28:38 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand add "http://ic7.101.ru:8000/v13_1" Mar 28 06:28:38 volumio volumio[837]: error: updateQueue error: null Mar 28 06:28:38 volumio volumio[837]: error: updateQueue error: null Mar 28 06:28:38 volumio volumio[837]: error: updateQueue error: null Mar 28 06:28:39 volumio volumio[837]: error: updateQueue error: null Mar 28 06:28:39 volumio volumio[837]: error: updateQueue error: null Mar 28 06:28:39 volumio volumio[837]: info: Mar 28 06:28:39 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:39 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:39 volumio volumio[837]: info: ------------------------------ 708ms Mar 28 06:28:39 volumio volumio[837]: info: ------------------------------ 696ms Mar 28 06:28:39 volumio volumio[837]: info: ------------------------------ 685ms Mar 28 06:28:39 volumio volumio[837]: info: ------------------------------ 681ms Mar 28 06:28:39 volumio volumio[837]: info: ------------------------------ 674ms Mar 28 06:28:39 volumio volumio[837]: info: sendMpdCommand add "http://ic7.101.ru:8000/v13_1" took 37 milliseconds Mar 28 06:28:39 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 28 06:28:39 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand play Mar 28 06:28:39 volumio volumio[837]: info: Mar 28 06:28:39 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:39 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:39 volumio volumio[837]: info: Mar 28 06:28:39 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:39 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:39 volumio volumio[837]: info: Mar 28 06:28:39 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:39 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:39 volumio volumio[837]: info: Mar 28 06:28:39 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:39 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:39 volumio volumio[837]: info: Mar 28 06:28:39 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:39 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:39 volumio volumio[837]: info: ------------------------------ 108ms Mar 28 06:28:39 volumio volumio[837]: info: sendMpdCommand play took 82 milliseconds Mar 28 06:28:39 volumio volumio[837]: info: ------------------------------ 78ms Mar 28 06:28:39 volumio volumio[837]: info: ------------------------------ 67ms Mar 28 06:28:39 volumio volumio[837]: info: ------------------------------ 55ms Mar 28 06:28:39 volumio volumio[837]: info: ------------------------------ 43ms Mar 28 06:28:39 volumio volumio[837]: info: ------------------------------ 38ms Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:40 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:40 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand status took 174 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: ------------------------------ 206ms Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand status took 191 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: ------------------------------ 214ms Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand status took 202 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand playlistinfo took 183 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand status took 164 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand status took 140 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand status took 116 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand status took 106 milliseconds Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:40 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:40 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:40 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:40 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:40 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:40 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus stop Mar 28 06:28:40 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:40 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:40 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:40 volumio volumio[837]: info: ------------------------------ 711ms Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:40 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:40 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:40 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:40 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:28:40 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:28:40 volumio volumio[837]: info: Mar 28 06:28:40 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:28:40 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:28:40 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand status took 564 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand playlistinfo took 348 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand playlistinfo took 345 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand playlistinfo took 334 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand playlistinfo took 333 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand playlistinfo took 331 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand playlistinfo took 321 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: ------------------------------ 198ms Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand status took 189 milliseconds Mar 28 06:28:40 volumio volumio[837]: info: ------------------------------ 179ms Mar 28 06:28:40 volumio volumio[837]: info: sendMpdCommand status took 147 milliseconds Mar 28 06:28:41 volumio volumio[837]: info: ------------------------------ 143ms Mar 28 06:28:41 volumio volumio[837]: info: sendMpdCommand status took 136 milliseconds Mar 28 06:28:41 volumio volumio[837]: info: ------------------------------ 131ms Mar 28 06:28:41 volumio volumio[837]: info: sendMpdCommand status took 122 milliseconds Mar 28 06:28:41 volumio volumio[837]: info: ------------------------------ 113ms Mar 28 06:28:41 volumio volumio[837]: info: sendMpdCommand status took 102 milliseconds Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:28:41 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:28:41 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:41 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:41 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":502,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:41 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:41 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:41 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:41 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":502,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:41 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:41 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:41 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:41 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":502,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:41 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:41 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:41 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:41 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":618,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:41 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:41 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:41 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:41 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":618,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:41 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:41 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:41 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:41 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":618,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:41 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:41 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:41 volumio volumio[837]: info: ------------------------------ 1616ms Mar 28 06:28:41 volumio volumio[837]: info: ------------------------------ 1612ms Mar 28 06:28:41 volumio volumio[837]: info: ------------------------------ 1558ms Mar 28 06:28:41 volumio volumio[837]: info: ------------------------------ 1544ms Mar 28 06:28:41 volumio volumio[837]: info: ------------------------------ 1519ms Mar 28 06:28:41 volumio volumio[837]: info: ------------------------------ 1497ms Mar 28 06:28:42 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1237 milliseconds Mar 28 06:28:42 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1221 milliseconds Mar 28 06:28:42 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1223 milliseconds Mar 28 06:28:42 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1222 milliseconds Mar 28 06:28:42 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1226 milliseconds Mar 28 06:28:42 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1220 milliseconds Mar 28 06:28:42 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:42 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:42 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:42 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:42 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:42 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:28:42 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:42 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:42 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":618,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:42 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:42 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:42 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:42 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:42 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:42 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:42 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:42 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:42 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:42 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1117,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:42 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:42 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:42 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:42 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:42 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1117,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:42 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:42 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:42 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:42 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:42 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1117,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:42 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:42 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:42 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:28:42 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:28:42 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1117,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"v13_1","artist":"RelaxFM-MSK","album":null,"uri":"http://ic7.101.ru:8000/v13_1","trackType":""} Mar 28 06:28:42 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:28:42 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:42 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:42 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:43 volumio volumio[837]: info: ------------------------------ 2877ms Mar 28 06:28:43 volumio volumio[837]: info: ------------------------------ 2488ms Mar 28 06:28:43 volumio volumio[837]: info: ------------------------------ 2452ms Mar 28 06:28:43 volumio volumio[837]: info: ------------------------------ 2439ms Mar 28 06:28:43 volumio volumio[837]: info: ------------------------------ 2433ms Mar 28 06:28:43 volumio volumio[837]: info: ------------------------------ 2412ms Mar 28 06:28:43 volumio volumio[837]: info: VolumeController::SetAlsaVolume59 Mar 28 06:28:43 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:43 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:43 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:43 volumio volumio[837]: info: VolumeController::SetAlsaVolume58 Mar 28 06:28:43 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:43 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:43 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:43 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Mar 28 06:28:44 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Mar 28 06:28:45 volumio volumio[837]: info: VolumeController::SetAlsaVolume50 Mar 28 06:28:45 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:46 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:46 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:46 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Mar 28 06:28:46 volumio volumio[837]: info: VolumeController::SetAlsaVolume40 Mar 28 06:28:46 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:46 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:46 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:46 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Mar 28 06:28:50 volumio volumio[837]: info: VolumeController::SetAlsaVolume30 Mar 28 06:28:50 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:50 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:50 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:50 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Mar 28 06:28:50 volumio volumio[837]: info: VolumeController::SetAlsaVolume35 Mar 28 06:28:50 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:50 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:50 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:51 volumio volumio[837]: info: VolumeController::SetAlsaVolume50 Mar 28 06:28:51 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:51 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:51 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:51 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Mar 28 06:28:51 volumio volumio[837]: info: VolumeController::SetAlsaVolume60 Mar 28 06:28:51 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:51 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:51 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:51 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Mar 28 06:28:51 volumio volumio[837]: info: VolumeController::SetAlsaVolume70 Mar 28 06:28:51 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:51 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:51 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:51 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Mar 28 06:28:51 volumio volumio[837]: info: VolumeController::SetAlsaVolume75 Mar 28 06:28:51 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:51 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:51 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:52 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Mar 28 06:28:52 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Mar 28 06:28:54 volumio volumio[837]: info: VolumeController::SetAlsaVolume60 Mar 28 06:28:54 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:54 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:54 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:55 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Mar 28 06:28:55 volumio volumio[837]: info: VolumeController::SetAlsaVolume50 Mar 28 06:28:55 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:28:55 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:28:55 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:28:55 volumio volumio[837]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Mar 28 06:29:01 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::ClearQueue Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::stop Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 06:29:07 volumio volumio[837]: verbose: UNSET VOLATILE Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::stPlaybackTimer Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::updateTrackBlock Mar 28 06:29:07 volumio volumio[837]: info: CorePlayQueue::getTrackBlock Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:07 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::serviceStop Mar 28 06:29:07 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::serviceStop Mar 28 06:29:07 volumio volumio[837]: info: [1774679347440] ControllerWebradio::stop Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand stop Mar 28 06:29:07 volumio volumio[837]: info: CorePlayQueue::clearPlayQueue Mar 28 06:29:07 volumio volumio[837]: info: CorePlayQueue::saveQueue Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::volumioPushQueue Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::addQueueItems Mar 28 06:29:07 volumio volumio[837]: info: CorePlayQueue::addQueueItems Mar 28 06:29:07 volumio volumio[837]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 28 06:29:07 volumio volumio[837]: info: CorePlayQueue::saveQueue Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::volumioPushQueue Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::updateTrackBlock Mar 28 06:29:07 volumio volumio[837]: info: CorePlayQueue::getTrackBlock Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::volumioPlay Mar 28 06:29:07 volumio volumio[837]: verbose: UNSET VOLATILE Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::play index 0 Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::stop Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 06:29:07 volumio volumio[837]: verbose: UNSET VOLATILE Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::play index undefined Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 06:29:07 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::startPlaybackTimer Mar 28 06:29:07 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:07 volumio volumio[837]: info: [1774679347623] ControllerWebradio::clearAddPlayTrack Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand stop Mar 28 06:29:07 volumio volumio[837]: info: Mar 28 06:29:07 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:07 volumio volumio[837]: info: sendMpdCommand stop took 292 milliseconds Mar 28 06:29:07 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:07 volumio volumio[837]: info: sendMpdCommand stop took 118 milliseconds Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand clear Mar 28 06:29:07 volumio volumio[837]: info: Mar 28 06:29:07 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:07 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:07 volumio volumio[837]: info: Mar 28 06:29:07 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:07 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:07 volumio volumio[837]: info: Mar 28 06:29:07 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:07 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:07 volumio volumio[837]: info: Mar 28 06:29:07 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:07 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:07 volumio volumio[837]: info: Mar 28 06:29:07 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:07 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:07 volumio volumio[837]: info: Mar 28 06:29:07 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:07 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:07 volumio volumio[837]: info: sendMpdCommand status took 137 milliseconds Mar 28 06:29:07 volumio volumio[837]: info: sendMpdCommand clear took 127 milliseconds Mar 28 06:29:07 volumio volumio[837]: info: sendMpdCommand status took 113 milliseconds Mar 28 06:29:07 volumio volumio[837]: info: sendMpdCommand status took 103 milliseconds Mar 28 06:29:07 volumio volumio[837]: info: sendMpdCommand status took 94 milliseconds Mar 28 06:29:07 volumio volumio[837]: info: sendMpdCommand status took 83 milliseconds Mar 28 06:29:07 volumio volumio[837]: info: sendMpdCommand status took 72 milliseconds Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:07 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:07 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:07 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:07 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:07 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:08 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:08 volumio volumio[837]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 28 06:29:08 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:08 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:08 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:08 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:08 volumio volumio[837]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 28 06:29:08 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:08 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:08 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:08 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:08 volumio volumio[837]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 28 06:29:08 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:08 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:08 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:08 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:08 volumio volumio[837]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 28 06:29:08 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:08 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:08 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:08 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:08 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:08 volumio volumio[837]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 28 06:29:08 volumio volumio[837]: info: ------------------------------ 426ms Mar 28 06:29:08 volumio volumio[837]: info: ------------------------------ 418ms Mar 28 06:29:08 volumio volumio[837]: info: ------------------------------ 410ms Mar 28 06:29:08 volumio volumio[837]: info: ------------------------------ 401ms Mar 28 06:29:08 volumio volumio[837]: info: ------------------------------ 391ms Mar 28 06:29:08 volumio volumio[837]: info: Mar 28 06:29:08 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:08 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:08 volumio volumio[837]: info: Mar 28 06:29:08 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:08 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:08 volumio volumio[837]: info: Mar 28 06:29:08 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:08 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:08 volumio volumio[837]: info: Mar 28 06:29:08 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:08 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:08 volumio volumio[837]: info: Mar 28 06:29:08 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:08 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:08 volumio volumio[837]: error: updateQueue error: null Mar 28 06:29:08 volumio volumio[837]: info: ------------------------------ 445ms Mar 28 06:29:08 volumio volumio[837]: info: sendMpdCommand playlistinfo took 412 milliseconds Mar 28 06:29:08 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:08 volumio volumio[837]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 28 06:29:08 volumio volumio[837]: info: ------------------------------ 612ms Mar 28 06:29:09 volumio volumio[837]: info: Mar 28 06:29:09 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:09 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:09 volumio volumio[837]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 1196 milliseconds Mar 28 06:29:09 volumio volumio[837]: info: ------------------------------ 886ms Mar 28 06:29:09 volumio volumio[837]: info: ------------------------------ 883ms Mar 28 06:29:09 volumio volumio[837]: info: ------------------------------ 868ms Mar 28 06:29:09 volumio volumio[837]: info: ------------------------------ 862ms Mar 28 06:29:09 volumio volumio[837]: info: ------------------------------ 858ms Mar 28 06:29:09 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 28 06:29:09 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand play Mar 28 06:29:09 volumio volumio[837]: info: Mar 28 06:29:09 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:09 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:09 volumio volumio[837]: info: Mar 28 06:29:09 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:09 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:09 volumio volumio[837]: info: Mar 28 06:29:09 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:09 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:09 volumio volumio[837]: info: Mar 28 06:29:09 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:09 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:09 volumio volumio[837]: info: Mar 28 06:29:09 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:09 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:09 volumio volumio[837]: info: ------------------------------ 126ms Mar 28 06:29:09 volumio volumio[837]: info: sendMpdCommand play took 96 milliseconds Mar 28 06:29:09 volumio volumio[837]: info: ------------------------------ 82ms Mar 28 06:29:09 volumio volumio[837]: info: ------------------------------ 71ms Mar 28 06:29:09 volumio volumio[837]: info: ------------------------------ 66ms Mar 28 06:29:09 volumio volumio[837]: info: ------------------------------ 53ms Mar 28 06:29:09 volumio volumio[837]: info: ------------------------------ 39ms Mar 28 06:29:12 volumio volumio[837]: info: Mar 28 06:29:12 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:13 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand status took 152 milliseconds Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: ------------------------------ 182ms Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand status took 150 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand playlistinfo took 134 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand status took 129 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand status took 118 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand status took 112 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand status took 104 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand status took 96 milliseconds Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:13 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:13 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:13 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"antenne","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:13 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:13 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:13 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus stop Mar 28 06:29:13 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:13 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:13 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:13 volumio volumio[837]: info: ------------------------------ 551ms Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:13 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:13 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:13 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:13 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:13 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:13 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:13 volumio volumio[837]: info: Mar 28 06:29:13 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:13 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:13 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand playlistinfo took 465 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand playlistinfo took 459 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand playlistinfo took 461 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand playlistinfo took 439 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand playlistinfo took 447 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand playlistinfo took 447 milliseconds Mar 28 06:29:13 volumio volumio[837]: info: ------------------------------ 292ms Mar 28 06:29:13 volumio volumio[837]: info: sendMpdCommand status took 283 milliseconds Mar 28 06:29:14 volumio volumio[837]: info: ------------------------------ 263ms Mar 28 06:29:14 volumio volumio[837]: info: sendMpdCommand status took 253 milliseconds Mar 28 06:29:14 volumio volumio[837]: info: ------------------------------ 250ms Mar 28 06:29:14 volumio volumio[837]: info: sendMpdCommand status took 251 milliseconds Mar 28 06:29:14 volumio volumio[837]: info: ------------------------------ 243ms Mar 28 06:29:14 volumio volumio[837]: info: sendMpdCommand status took 233 milliseconds Mar 28 06:29:14 volumio volumio[837]: info: ------------------------------ 238ms Mar 28 06:29:14 volumio volumio[837]: info: sendMpdCommand status took 229 milliseconds Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:14 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:14 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:14 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:14 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":499,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:14 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:14 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:14 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:14 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:14 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":499,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:14 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:14 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:14 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:14 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:14 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":499,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:14 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:14 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:14 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:14 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:14 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":499,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:14 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:14 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:14 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:14 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:14 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":499,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:14 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:14 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:14 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:14 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:14 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":580,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:14 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:14 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:14 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:14 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 2137ms Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 2114ms Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 2107ms Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 2100ms Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 2093ms Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 2084ms Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:15 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:15 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:15 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:15 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:15 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:15 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:15 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:15 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:15 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:15 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:15 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:15 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:15 volumio volumio[837]: info: Mar 28 06:29:15 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 1974ms Mar 28 06:29:15 volumio volumio[837]: info: sendMpdCommand status took 1929 milliseconds Mar 28 06:29:15 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:15 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1790 milliseconds Mar 28 06:29:15 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1780 milliseconds Mar 28 06:29:15 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1780 milliseconds Mar 28 06:29:15 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1760 milliseconds Mar 28 06:29:15 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1759 milliseconds Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 454ms Mar 28 06:29:15 volumio volumio[837]: info: sendMpdCommand status took 446 milliseconds Mar 28 06:29:15 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 443ms Mar 28 06:29:15 volumio volumio[837]: info: sendMpdCommand status took 434 milliseconds Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 409ms Mar 28 06:29:15 volumio volumio[837]: info: sendMpdCommand status took 400 milliseconds Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 392ms Mar 28 06:29:15 volumio volumio[837]: info: sendMpdCommand status took 373 milliseconds Mar 28 06:29:15 volumio volumio[837]: info: ------------------------------ 362ms Mar 28 06:29:15 volumio volumio[837]: info: sendMpdCommand status took 352 milliseconds Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:15 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:15 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:15 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:15 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:15 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":806,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:15 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:15 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:15 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:15 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:15 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:15 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:15 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:15 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:15 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:15 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:15 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:15 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:15 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":934,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:15 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:15 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:16 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:16 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:16 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:16 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":934,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:16 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:16 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:16 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:16 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:16 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":934,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:16 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:16 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:16 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:16 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:16 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":934,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:16 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:16 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:16 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:16 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:16 volumio volumio[837]: info: ------------------------------ 3087ms Mar 28 06:29:16 volumio volumio[837]: info: ------------------------------ 3059ms Mar 28 06:29:16 volumio volumio[837]: info: ------------------------------ 3021ms Mar 28 06:29:16 volumio volumio[837]: info: ------------------------------ 2999ms Mar 28 06:29:16 volumio volumio[837]: info: ------------------------------ 2983ms Mar 28 06:29:16 volumio volumio[837]: info: Mar 28 06:29:16 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:16 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:16 volumio volumio[837]: info: Mar 28 06:29:16 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:16 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:16 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:16 volumio volumio[837]: info: Mar 28 06:29:16 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:16 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:16 volumio volumio[837]: info: Mar 28 06:29:16 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:16 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:16 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:16 volumio volumio[837]: info: Mar 28 06:29:16 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:16 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:16 volumio volumio[837]: info: Mar 28 06:29:16 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:16 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:16 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:16 volumio volumio[837]: info: Mar 28 06:29:16 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:16 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:16 volumio volumio[837]: info: Mar 28 06:29:16 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:16 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:16 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:16 volumio volumio[837]: info: Mar 28 06:29:16 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:16 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:16 volumio volumio[837]: info: Mar 28 06:29:16 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:16 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:16 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 1390ms Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand status took 1338 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 1384ms Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand status took 1316 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1287 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1233 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1241 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1240 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1243 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1239 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 466ms Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand status took 454 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 445ms Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand status took 440 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 430ms Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand status took 427 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 401ms Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand status took 389 milliseconds Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 384ms Mar 28 06:29:17 volumio volumio[837]: info: sendMpdCommand status took 376 milliseconds Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:17 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:17 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:17 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1190,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:17 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:17 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:17 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:17 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2557,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:17 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:17 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:17 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:17 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2684,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:17 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:17 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:17 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:17 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2684,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:17 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:17 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:17 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:17 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2684,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:17 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:17 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:17 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:17 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2684,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:17 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:17 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:17 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 4183ms Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 2626ms Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 2609ms Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 2576ms Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 2564ms Mar 28 06:29:17 volumio volumio[837]: info: ------------------------------ 2539ms Mar 28 06:29:17 volumio volumio[837]: info: Mar 28 06:29:17 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:17 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:17 volumio volumio[837]: info: Mar 28 06:29:17 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:17 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:17 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:18 volumio volumio[837]: info: sendMpdCommand playlistinfo took 929 milliseconds Mar 28 06:29:18 volumio volumio[837]: info: sendMpdCommand playlistinfo took 942 milliseconds Mar 28 06:29:18 volumio volumio[837]: info: sendMpdCommand playlistinfo took 927 milliseconds Mar 28 06:29:18 volumio volumio[837]: info: sendMpdCommand playlistinfo took 926 milliseconds Mar 28 06:29:18 volumio volumio[837]: info: sendMpdCommand playlistinfo took 928 milliseconds Mar 28 06:29:18 volumio volumio[837]: info: sendMpdCommand playlistinfo took 925 milliseconds Mar 28 06:29:18 volumio volumio[837]: info: sendMpdCommand playlistinfo took 929 milliseconds Mar 28 06:29:18 volumio volumio[837]: info: ------------------------------ 141ms Mar 28 06:29:18 volumio volumio[837]: info: sendMpdCommand status took 130 milliseconds Mar 28 06:29:18 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:18 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:18 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:18 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:18 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:18 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:18 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:18 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:18 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:18 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:18 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:18 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3056,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:18 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:18 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:18 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:18 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3184,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:18 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:18 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:18 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:18 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3935,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:18 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:18 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:18 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:18 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3935,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:18 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:18 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:18 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:18 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4063,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:18 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:18 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:18 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:18 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4063,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:18 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:18 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:18 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:18 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4063,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:18 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:18 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:18 volumio volumio[837]: info: ------------------------------ 3257ms Mar 28 06:29:18 volumio volumio[837]: info: ------------------------------ 3251ms Mar 28 06:29:18 volumio volumio[837]: info: ------------------------------ 2291ms Mar 28 06:29:18 volumio volumio[837]: info: ------------------------------ 2278ms Mar 28 06:29:18 volumio volumio[837]: info: ------------------------------ 2279ms Mar 28 06:29:18 volumio volumio[837]: info: ------------------------------ 2246ms Mar 28 06:29:18 volumio volumio[837]: info: ------------------------------ 2228ms Mar 28 06:29:19 volumio volumio[837]: info: sendMpdCommand playlistinfo took 1220 milliseconds Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Mar 28 06:29:19 volumio volumio[837]: info: ControllerMpd::pushState Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::servicePushState Mar 28 06:29:19 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:19 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5305,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Mar 28 06:29:19 volumio volumio[837]: verbose: CURRENT POSITION 0 Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Mar 28 06:29:19 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:19 volumio volumio[837]: info: ------------------------------ 1498ms Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::ClearQueue Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::stop Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 06:29:19 volumio volumio[837]: verbose: UNSET VOLATILE Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::stPlaybackTimer Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::updateTrackBlock Mar 28 06:29:19 volumio volumio[837]: info: CorePlayQueue::getTrackBlock Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::pushState Mar 28 06:29:19 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::serviceStop Mar 28 06:29:19 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::serviceStop Mar 28 06:29:19 volumio volumio[837]: info: [1774679359554] ControllerWebradio::stop Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand stop Mar 28 06:29:19 volumio volumio[837]: info: CorePlayQueue::clearPlayQueue Mar 28 06:29:19 volumio volumio[837]: info: CorePlayQueue::saveQueue Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::volumioPushQueue Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::addQueueItems Mar 28 06:29:19 volumio volumio[837]: info: CorePlayQueue::addQueueItems Mar 28 06:29:19 volumio volumio[837]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 28 06:29:19 volumio volumio[837]: info: CorePlayQueue::saveQueue Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::volumioPushQueue Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::updateTrackBlock Mar 28 06:29:19 volumio volumio[837]: info: CorePlayQueue::getTrackBlock Mar 28 06:29:19 volumio volumio[837]: info: CoreCommandRouter::volumioPlay Mar 28 06:29:19 volumio volumio[837]: verbose: UNSET VOLATILE Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::play index 0 Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::stop Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 06:29:19 volumio volumio[837]: verbose: UNSET VOLATILE Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::play index undefined Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 06:29:19 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:19 volumio volumio[837]: info: CoreStateMachine::startPlaybackTimer Mar 28 06:29:19 volumio volumio[837]: info: CorePlayQueue::getTrack 0 Mar 28 06:29:19 volumio volumio[837]: info: [1774679359704] ControllerWebradio::clearAddPlayTrack Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand stop Mar 28 06:29:19 volumio volumio[837]: info: Mar 28 06:29:19 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:19 volumio volumio[837]: info: sendMpdCommand stop took 231 milliseconds Mar 28 06:29:19 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:19 volumio volumio[837]: info: sendMpdCommand stop took 83 milliseconds Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand clear Mar 28 06:29:19 volumio volumio[837]: info: Mar 28 06:29:19 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:19 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:19 volumio volumio[837]: info: Mar 28 06:29:19 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:19 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:19 volumio volumio[837]: info: Mar 28 06:29:19 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:19 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:19 volumio volumio[837]: info: Mar 28 06:29:19 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:19 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:19 volumio volumio[837]: info: Mar 28 06:29:19 volumio volumio[837]: ---------------------------- MPD announces state update: player Mar 28 06:29:19 volumio volumio[837]: info: ControllerMpd::getState Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Mar 28 06:29:19 volumio volumio[837]: info: Mar 28 06:29:19 volumio volumio[837]: ---------------------------- MPD announces system playlist update Mar 28 06:29:19 volumio volumio[837]: info: Ignoring MPD Status Update Mar 28 06:29:19 volumio volumio[837]: info: sendMpdCommand status took 110 milliseconds Mar 28 06:29:19 volumio volumio[837]: info: sendMpdCommand clear took 102 milliseconds Mar 28 06:29:19 volumio volumio[837]: info: sendMpdCommand status took 87 milliseconds Mar 28 06:29:19 volumio volumio[837]: info: sendMpdCommand status took 77 milliseconds Mar 28 06:29:19 volumio volumio[837]: info: sendMpdCommand status took 68 milliseconds Mar 28 06:29:19 volumio volumio[837]: info: sendMpdCommand status took 58 milliseconds Mar 28 06:29:19 volumio volumio[837]: info: sendMpdCommand status took 47 milliseconds Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::parseState Mar 28 06:29:19 volumio volumio[837]: verbose: ControllerMpd::parseState PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"