-- Logs begin at Sun 2024-04-21 11:22:59 CEST, end at Tue 2024-04-23 17:33:20 CEST. -- Apr 23 17:32:00 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume- Apr 23 17:32:00 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 50 Apr 23 17:32:00 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:00 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:00 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:00 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:00 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume- Apr 23 17:32:00 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 46 Apr 23 17:32:00 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:00 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:00 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:00 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:00 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:00 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:01 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume- Apr 23 17:32:01 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 42 Apr 23 17:32:01 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:01 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:01 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:01 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:01 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:01 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:01 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume- Apr 23 17:32:01 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 38 Apr 23 17:32:01 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:01 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:01 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:01 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:02 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume- Apr 23 17:32:02 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 34 Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:02 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume- Apr 23 17:32:02 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 30 Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:02 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume- Apr 23 17:32:02 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 26 Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:02 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:03 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 23 17:32:03 poland-bedroom volumio[15588]: info: Received Get System Info Apr 23 17:32:03 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 17:32:03 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 17:32:03 poland-bedroom volumio[15588]: info: Discovery: Getting this device information Apr 23 17:32:03 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:03 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:03 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 17:32:07 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume0 Apr 23 17:32:07 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 0 Apr 23 17:32:07 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:07 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:07 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:07 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:07 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:07 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:10 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 23 17:32:10 poland-bedroom volumio[15588]: info: Preload queue cleared Apr 23 17:32:11 poland-bedroom volumiologrotate[544]: ls: cannot access '/var/log/samba/log.wb-POLAND': No such file or directory Apr 23 17:32:11 poland-bedroom volumiologrotate[544]: ls: cannot access 'BEDROOM': No such file or directory Apr 23 17:32:12 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 23 17:32:12 poland-bedroom volumio[15588]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 23 17:32:12 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 23 17:32:12 poland-bedroom volumio[15588]: info: Received Get System Version Apr 23 17:32:12 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 23 17:32:12 poland-bedroom volumio[15588]: info: Received Get System Info Apr 23 17:32:12 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 17:32:12 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 17:32:12 poland-bedroom volumio[15588]: info: Discovery: Getting this device information Apr 23 17:32:12 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:12 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:12 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 17:32:12 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 23 17:32:13 poland-bedroom volumio[15588]: info: Preload queue cleared Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Preload queue cleared Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::ClearQueue Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::stop Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::clearPlayQueue Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::saveQueue Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushQueue Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::addQueueItems Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::addQueueItems Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Preload queue cleared Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Adding Item to queue: http://media-ice.musicradio.com/ClassicFMMP3 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushQueue Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::saveQueue Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::updateTrackBlock Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrackBlock Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPlay Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::play index 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::stop Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::play index undefined Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::startPlaybackTimer Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: [1713886335214] ControllerWebradio::clearAddPlayTrack Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand stop Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand stop took 12 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand clear Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand clear took 1 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand load "http://media-ice.musicradio.com/ClassicFMMP3" Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand add "http://media-ice.musicradio.com/ClassicFMMP3" Apr 23 17:32:15 poland-bedroom volumio[15588]: error: updateQueue error: null Apr 23 17:32:15 poland-bedroom volumio[15588]: error: updateQueue error: null Apr 23 17:32:15 poland-bedroom volumio[15588]: error: updateQueue error: null Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ------------------------------ 446ms Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ------------------------------ 443ms Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ------------------------------ 441ms Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand add "http://media-ice.musicradio.com/ClassicFMMP3" took 9 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand play Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ------------------------------ 13ms Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand play took 8 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ------------------------------ 7ms Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ------------------------------ 4ms Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:15 poland-bedroom kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand status took 31 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand status took 29 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand status took 27 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand status took 7 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ClassicFMMP3","artist":null,"album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus stop Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ClassicFMMP3","artist":null,"album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ClassicFMMP3","artist":null,"album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ------------------------------ 82ms Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ------------------------------ 122ms Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ------------------------------ 121ms Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Apr 23 17:32:15 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 90 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand status took 8 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:15 poland-bedroom volumio[15588]: info: sendMpdCommand status took 7 milliseconds Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:15 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ClassicFMMP3","artist":null,"album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:15 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:15 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:15 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 154ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Apr 23 17:32:16 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Apr 23 17:32:16 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Apr 23 17:32:16 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Apr 23 17:32:16 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 108ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand status took 105 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 108ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand status took 105 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 102 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 102 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 58ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand status took 56 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 55ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand status took 53 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 184ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 183ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 70 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 70 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 67 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 67 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 307ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 307ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 255ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 252ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Apr 23 17:32:16 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Apr 23 17:32:16 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Apr 23 17:32:16 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Apr 23 17:32:16 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Apr 23 17:32:16 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Apr 23 17:32:16 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 10ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand status took 7 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 7ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand status took 6 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 5ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand status took 4 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1583,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1583,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1583,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:16 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:16 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 93ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 91ms Apr 23 17:32:16 poland-bedroom volumio[15588]: info: ------------------------------ 89ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 6ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand status took 4 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 5ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand status took 3 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 4ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand status took 3 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2177,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2177,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 83ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 82ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 70 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2177,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 110ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Apr 23 17:32:17 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 11ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand status took 9 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 8ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand status took 6 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 6ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand status took 4 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2481,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2481,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2481,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:17 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:17 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 92ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 89ms Apr 23 17:32:17 poland-bedroom volumio[15588]: info: ------------------------------ 87ms Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Apr 23 17:32:18 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Apr 23 17:32:18 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Apr 23 17:32:18 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Apr 23 17:32:18 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Apr 23 17:32:18 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Apr 23 17:32:18 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ------------------------------ 11ms Apr 23 17:32:18 poland-bedroom volumio[15588]: info: sendMpdCommand status took 10 milliseconds Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ------------------------------ 8ms Apr 23 17:32:18 poland-bedroom volumio[15588]: info: sendMpdCommand status took 7 milliseconds Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ------------------------------ 6ms Apr 23 17:32:18 poland-bedroom volumio[15588]: info: sendMpdCommand status took 5 milliseconds Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:18 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:18 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 23 17:32:18 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3686,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3686,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3686,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:18 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:18 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ------------------------------ 93ms Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ------------------------------ 91ms Apr 23 17:32:18 poland-bedroom volumio[15588]: info: ------------------------------ 88ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 9ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand status took 8 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 7ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand status took 6 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 5ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand status took 3 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5087,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5087,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5087,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 88ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 86ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 84ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 7ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 5ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand status took 5 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand status took 4 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 3ms Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand status took 2 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5384,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5384,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 66ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 63ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 52 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5384,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 84ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 6ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand status took 4 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 5ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand status took 3 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Apr 23 17:32:20 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 4ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand status took 3 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5887,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5887,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 63ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ------------------------------ 61ms Apr 23 17:32:20 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 51 milliseconds Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5887,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:20 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:20 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:20 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:21 poland-bedroom volumio[15588]: info: ------------------------------ 98ms Apr 23 17:32:21 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume+ Apr 23 17:32:21 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 4 Apr 23 17:32:21 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:21 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:21 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:22 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:22 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume+ Apr 23 17:32:22 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 8 Apr 23 17:32:22 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:22 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:22 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:22 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Apr 23 17:32:23 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Apr 23 17:32:23 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Apr 23 17:32:23 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Apr 23 17:32:23 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ------------------------------ 7ms Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ------------------------------ 5ms Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ------------------------------ 4ms Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Apr 23 17:32:23 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Apr 23 17:32:23 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:23 poland-bedroom volumio[15588]: info: sendMpdCommand status took 6 milliseconds Apr 23 17:32:23 poland-bedroom volumio[15588]: info: sendMpdCommand status took 5 milliseconds Apr 23 17:32:23 poland-bedroom volumio[15588]: info: sendMpdCommand status took 3 milliseconds Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:23 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 23 17:32:23 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:23 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8083,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8083,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8083,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:23 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:23 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ------------------------------ 107ms Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ------------------------------ 105ms Apr 23 17:32:23 poland-bedroom volumio[15588]: info: ------------------------------ 104ms Apr 23 17:32:23 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume+ Apr 23 17:32:23 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 12 Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume+ Apr 23 17:32:23 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 16 Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:23 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:24 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:24 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:24 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume+ Apr 23 17:32:24 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 20 Apr 23 17:32:24 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:24 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:24 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume+ Apr 23 17:32:25 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 24 Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume+ Apr 23 17:32:25 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 28 Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Apr 23 17:32:25 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Apr 23 17:32:25 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Apr 23 17:32:25 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Apr 23 17:32:25 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Apr 23 17:32:25 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Apr 23 17:32:25 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ------------------------------ 13ms Apr 23 17:32:25 poland-bedroom volumio[15588]: info: sendMpdCommand status took 12 milliseconds Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ------------------------------ 10ms Apr 23 17:32:25 poland-bedroom volumio[15588]: info: sendMpdCommand status took 8 milliseconds Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ------------------------------ 7ms Apr 23 17:32:25 poland-bedroom volumio[15588]: info: sendMpdCommand status took 4 milliseconds Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:25 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 23 17:32:25 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:25 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10377,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10377,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10377,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:25 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:25 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ------------------------------ 93ms Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ------------------------------ 91ms Apr 23 17:32:25 poland-bedroom volumio[15588]: info: ------------------------------ 87ms Apr 23 17:32:25 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume+ Apr 23 17:32:25 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 32 Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: VolumeController::SetAlsaVolume+ Apr 23 17:32:25 poland-bedroom volumio[15588]: info: [squeezelite_mc] Setting Squeezelite volume to 36 Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:25 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:26 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Apr 23 17:32:28 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Apr 23 17:32:28 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Apr 23 17:32:28 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Apr 23 17:32:28 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Apr 23 17:32:28 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Apr 23 17:32:28 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ------------------------------ 16ms Apr 23 17:32:28 poland-bedroom volumio[15588]: info: sendMpdCommand status took 15 milliseconds Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ------------------------------ 15ms Apr 23 17:32:28 poland-bedroom volumio[15588]: info: sendMpdCommand status took 14 milliseconds Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ------------------------------ 13ms Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:28 poland-bedroom volumio[15588]: info: sendMpdCommand status took 7 milliseconds Apr 23 17:32:28 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 23 17:32:28 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13182,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13182,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ------------------------------ 80ms Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ------------------------------ 79ms Apr 23 17:32:28 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 61 milliseconds Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13182,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:28 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:28 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:28 poland-bedroom volumio[15588]: info: ------------------------------ 105ms Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Apr 23 17:32:30 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Apr 23 17:32:30 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Apr 23 17:32:30 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Apr 23 17:32:30 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ------------------------------ 7ms Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand status took 5 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ------------------------------ 4ms Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand status took 3 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Apr 23 17:32:30 poland-bedroom volumio[15588]: ---------------------------- MPD announces system playlist update Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Ignoring MPD Status Update Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Apr 23 17:32:30 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 18 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 19 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ------------------------------ 4ms Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand status took 3 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15381,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15381,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ------------------------------ 84ms Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ------------------------------ 82ms Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 57 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15381,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hector Berlioz - Symphonie Fantastique Opus 14 (2)","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: CURRENT POSITION 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState stateService play Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::syncState currentStatus play Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Received an update from plugin. extracting info from payload Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ------------------------------ 89ms Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioStop Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::stop Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::stPlaybackTimer Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::updateTrackBlock Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrackBlock Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::serviceStop Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::serviceStop Apr 23 17:32:30 poland-bedroom volumio[15588]: info: [1713886350867] ControllerWebradio::stop Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand stop Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Apr 23 17:32:30 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand stop took 15 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand status took 1 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Apr 23 17:32:30 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Apr 23 17:32:30 poland-bedroom volumio[15588]: ---------------------------- MPD announces state update: player Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::getState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand status Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand status took 3 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand status took 2 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseState Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ------------------------------ 47ms Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 36 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: info: sendMpdCommand playlistinfo took 36 milliseconds Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:30 poland-bedroom volumio[15588]: verbose: ControllerMpd::parseTrackInfo Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ControllerMpd::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::servicePushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreStateMachine::pushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioPushState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:30 poland-bedroom volumio[15588]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ------------------------------ 86ms Apr 23 17:32:30 poland-bedroom volumio[15588]: info: ------------------------------ 88ms Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:32:30 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:32:51 poland-bedroom dhcpcd[789]: wlan0: carrier lost Apr 23 17:32:51 poland-bedroom wpa_supplicant[777]: wlan0: Associated with 14:59:c0:30:a2:f3 Apr 23 17:32:51 poland-bedroom wpa_supplicant[777]: wlan0: CTRL-EVENT-CONNECTED - Connection to 14:59:c0:30:a2:f3 completed [id=0 id_str=] Apr 23 17:32:51 poland-bedroom wpa_supplicant[777]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 23 17:32:51 poland-bedroom avahi-daemon[556]: Withdrawing address record for 10.0.0.88 on wlan0. Apr 23 17:32:51 poland-bedroom avahi-daemon[556]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.88. Apr 23 17:32:51 poland-bedroom avahi-daemon[556]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 23 17:32:51 poland-bedroom dhcpcd[789]: wlan0: deleting route to 10.0.0.0/24 Apr 23 17:32:51 poland-bedroom dhcpcd[789]: wlan0: deleting default route via 10.0.0.1 Apr 23 17:32:51 poland-bedroom volumio[15588]: info: Discovery: A device disappeared from network Apr 23 17:32:51 poland-bedroom volumio[15588]: info: Discovery: A device disappeared from network Apr 23 17:32:51 poland-bedroom dhcpcd[789]: wlan0: carrier acquired Apr 23 17:32:51 poland-bedroom dhcpcd[789]: wlan0: IAID eb:4c:0e:da Apr 23 17:32:52 poland-bedroom dhcpcd[789]: wlan0: soliciting an IPv6 router Apr 23 17:32:52 poland-bedroom dhcpcd[789]: wlan0: rebinding lease of 10.0.0.88 Apr 23 17:32:52 poland-bedroom dhcpcd[789]: wlan0: NAK: from 192.168.1.250 Apr 23 17:32:53 poland-bedroom dhcpcd[789]: wlan0: soliciting a DHCP lease Apr 23 17:32:53 poland-bedroom dhcpcd[789]: wlan0: offered 10.0.0.88 from 10.0.0.1 Apr 23 17:32:53 poland-bedroom dhcpcd[789]: wlan0: probing address 10.0.0.88/24 Apr 23 17:32:53 poland-bedroom ntpd[669]: Deleting interface #34 wlan0, 10.0.0.88#123, interface stats: received=70, sent=70, dropped=0, active_time=122 secs Apr 23 17:32:53 poland-bedroom ntpd[669]: 188.165.17.91 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 80.50.102.126 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 79.110.198.245 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 150.254.65.62 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 195.46.37.22 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 178.215.228.24 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 91.212.242.20 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 162.159.200.123 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 91.210.128.220 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 213.135.57.60 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 109.205.50.68 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 193.25.222.136 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 193.70.94.182 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 212.127.78.21 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 185.23.20.212 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 162.159.200.1 local addr 10.0.0.88 -> Apr 23 17:32:53 poland-bedroom ntpd[669]: 212.160.106.226 local addr 10.0.0.88 -> Apr 23 17:32:59 poland-bedroom dhcpcd[789]: wlan0: leased 10.0.0.88 for 86400 seconds Apr 23 17:32:59 poland-bedroom avahi-daemon[556]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.88. Apr 23 17:32:59 poland-bedroom avahi-daemon[556]: New relevant interface wlan0.IPv4 for mDNS. Apr 23 17:32:59 poland-bedroom dhcpcd[789]: wlan0: adding route to 10.0.0.0/24 Apr 23 17:32:59 poland-bedroom avahi-daemon[556]: Registering new address record for 10.0.0.88 on wlan0.IPv4. Apr 23 17:32:59 poland-bedroom dhcpcd[789]: wlan0: adding default route via 10.0.0.1 Apr 23 17:33:00 poland-bedroom ntpd[669]: Listen normally on 35 wlan0 10.0.0.88:123 Apr 23 17:33:00 poland-bedroom ntpd[669]: new interface(s) found: waking up resolver Apr 23 17:33:01 poland-bedroom volumio[15588]: info: Discovery: adding dec352e2-0ed4-4d5b-9e3c-f97614598bbd Apr 23 17:33:01 poland-bedroom volumio[15588]: info: Discovery: Found device Poland Bedroom Apr 23 17:33:01 poland-bedroom volumio[15588]: info: CoreCommandRouter::volumioGetState Apr 23 17:33:01 poland-bedroom volumio[15588]: info: CorePlayQueue::getTrack 0 Apr 23 17:33:02 poland-bedroom volumio[15588]: info: Discovery: adding 838fe215-ef00-41cb-bfb0-92ff35f222db Apr 23 17:33:02 poland-bedroom volumio[15588]: info: Discovery: Found device Poland Lounge Apr 23 17:33:10 poland-bedroom wpa_supplicant[777]: wlan0: CTRL-EVENT-DISCONNECTED bssid=14:59:c0:30:a2:f3 reason=8 Apr 23 17:33:10 poland-bedroom dhcpcd[789]: wlan0: carrier lost Apr 23 17:33:10 poland-bedroom wpa_supplicant[777]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 23 17:33:10 poland-bedroom wpa_supplicant[777]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=DE Apr 23 17:33:10 poland-bedroom avahi-daemon[556]: Withdrawing address record for 10.0.0.88 on wlan0. Apr 23 17:33:10 poland-bedroom avahi-daemon[556]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.88. Apr 23 17:33:10 poland-bedroom avahi-daemon[556]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 23 17:33:10 poland-bedroom dhcpcd[789]: wlan0: deleting route to 10.0.0.0/24 Apr 23 17:33:10 poland-bedroom dhcpcd[789]: wlan0: deleting default route via 10.0.0.1 Apr 23 17:33:10 poland-bedroom volumio[15588]: info: Discovery: A device disappeared from network Apr 23 17:33:10 poland-bedroom volumio[15588]: info: Discovery: A device disappeared from network Apr 23 17:33:10 poland-bedroom wpa_supplicant[777]: wlan0: Trying to associate with SSID 'VM9148716' Apr 23 17:33:10 poland-bedroom dhcpcd[789]: wlan0: carrier acquired Apr 23 17:33:10 poland-bedroom wpa_supplicant[777]: wlan0: Associated with 04:d4:c4:3b:0e:e0 Apr 23 17:33:10 poland-bedroom wpa_supplicant[777]: wlan0: CTRL-EVENT-CONNECTED - Connection to 04:d4:c4:3b:0e:e0 completed [id=0 id_str=] Apr 23 17:33:10 poland-bedroom wpa_supplicant[777]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 23 17:33:10 poland-bedroom wpa_supplicant[777]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Apr 23 17:33:10 poland-bedroom dhcpcd[789]: wlan0: IAID eb:4c:0e:da Apr 23 17:33:10 poland-bedroom dhcpcd[789]: wlan0: carrier lost Apr 23 17:33:10 poland-bedroom dhcpcd[789]: wlan0: carrier acquired Apr 23 17:33:10 poland-bedroom dhcpcd[789]: wlan0: IAID eb:4c:0e:da Apr 23 17:33:10 poland-bedroom dhcpcd[789]: wlan0: soliciting an IPv6 router Apr 23 17:33:11 poland-bedroom dhcpcd[789]: wlan0: rebinding lease of 10.0.0.88 Apr 23 17:33:11 poland-bedroom volumiologrotate[544]: ls: cannot access '/var/log/samba/log.wb-POLAND': No such file or directory Apr 23 17:33:11 poland-bedroom volumiologrotate[544]: ls: cannot access 'BEDROOM': No such file or directory Apr 23 17:33:12 poland-bedroom ntpd[669]: Deleting interface #35 wlan0, 10.0.0.88#123, interface stats: received=19, sent=20, dropped=0, active_time=12 secs Apr 23 17:33:12 poland-bedroom ntpd[669]: 150.254.65.62 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 195.46.37.22 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 178.215.228.24 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 91.212.242.20 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 162.159.200.123 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 91.210.128.220 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 213.135.57.60 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 109.205.50.68 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 193.25.222.136 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 193.70.94.182 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 212.127.78.21 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 185.23.20.212 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 162.159.200.1 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 212.160.106.226 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 79.110.198.245 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 80.50.102.126 local addr 10.0.0.88 -> Apr 23 17:33:12 poland-bedroom ntpd[669]: 188.165.17.91 local addr 10.0.0.88 -> Apr 23 17:33:16 poland-bedroom dhcpcd[789]: wlan0: probing for an IPv4LL address Apr 23 17:33:16 poland-bedroom dhcpcd[789]: wlan0: DHCP lease expired Apr 23 17:33:16 poland-bedroom dhcpcd[789]: wlan0: soliciting a DHCP lease Apr 23 17:33:16 poland-bedroom dhcpcd[789]: wlan0: offered 10.0.0.88 from 10.0.0.1 Apr 23 17:33:16 poland-bedroom dhcpcd[789]: wlan0: probing address 10.0.0.88/24 Apr 23 17:33:17 poland-bedroom nmbd[11055]: [2024/04/23 17:33:17.916572, 0] ../source3/libsmb/nmblib.c:917(send_udp) Apr 23 17:33:17 poland-bedroom nmbd[11055]: Packet send failed to 10.0.0.255(137) ERRNO=Network is unreachable Apr 23 17:33:17 poland-bedroom nmbd[11055]: [2024/04/23 17:33:17.916802, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Apr 23 17:33:17 poland-bedroom nmbd[11055]: send_netbios_packet: send_packet() to IP 10.0.0.255 port 137 failed Apr 23 17:33:17 poland-bedroom nmbd[11055]: [2024/04/23 17:33:17.916902, 0] ../source3/nmbd/nmbd_namequery.c:245(query_name) Apr 23 17:33:17 poland-bedroom nmbd[11055]: query_name: Failed to send packet trying to query name WORKGROUP<1d> Apr 23 17:33:20 poland-bedroom volumio[15588]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 17:33:20 poland-bedroom volumio[15588]: Error: send ENETUNREACH 255.255.255.255:3483 Apr 23 17:33:20 poland-bedroom volumio[15588]: at doSend (dgram.js:692:16) Apr 23 17:33:20 poland-bedroom volumio[15588]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Apr 23 17:33:20 poland-bedroom volumio[15588]: at afterDns (dgram.js:638:5) Apr 23 17:33:20 poland-bedroom volumio[15588]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Apr 23 17:33:20 poland-bedroom volumio[15588]: errno: -101, Apr 23 17:33:20 poland-bedroom volumio[15588]: code: 'ENETUNREACH', Apr 23 17:33:20 poland-bedroom volumio[15588]: syscall: 'send', Apr 23 17:33:20 poland-bedroom volumio[15588]: address: '255.255.255.255', Apr 23 17:33:20 poland-bedroom volumio[15588]: port: 3483 Apr 23 17:33:20 poland-bedroom volumio[15588]: } Apr 23 17:33:20 poland-bedroom volumio[15588]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 17:33:20 poland-bedroom dhcpcd[789]: wlan0: leased 10.0.0.88 for 86400 seconds Apr 23 17:33:20 poland-bedroom avahi-daemon[556]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.88. Apr 23 17:33:20 poland-bedroom dhcpcd[789]: wlan0: adding route to 10.0.0.0/24 Apr 23 17:33:20 poland-bedroom dhcpcd[789]: wlan0: adding default route via 10.0.0.1 Apr 23 17:33:20 poland-bedroom avahi-daemon[556]: New relevant interface wlan0.IPv4 for mDNS. Apr 23 17:33:20 poland-bedroom avahi-daemon[556]: Registering new address record for 10.0.0.88 on wlan0.IPv4. Apr 23 17:33:20 poland-bedroom sudo[16222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-23 17:32 Apr 23 17:33:20 poland-bedroom sudo[16222]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"