-- Logs begin at Fri 2024-10-11 18:16:29 CST, end at Fri 2024-10-11 18:20:38 CST. -- Oct 11 18:19:01 volumio volumio[965]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Oct 11 18:19:01 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Oct 11 18:19:01 volumio volumio[965]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 18:19:01 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 18:19:05 volumio volumio[965]: info: CoreCommandRouter::volumioGetState Oct 11 18:19:05 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:07 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 11 18:19:07 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 11 18:19:10 volumio volumio[965]: info: CoreCommandRouter::volumioGetState Oct 11 18:19:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:11 volumio volumio[965]: info: CoreCommandRouter::volumioPlay Oct 11 18:19:11 volumio volumio[965]: info: CoreStateMachine::play index undefined Oct 11 18:19:11 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 18:19:11 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:11 volumio volumio[965]: info: CoreStateMachine::startPlaybackTimer Oct 11 18:19:11 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:11 volumio volumio[965]: info: [1728641951960] ControllerWebradio::clearAddPlayTrack Oct 11 18:19:11 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Oct 11 18:19:11 volumio volumio[965]: info: sendMpdCommand stop took 6 milliseconds Oct 11 18:19:11 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Oct 11 18:19:11 volumio volumio[965]: info: Oct 11 18:19:11 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:11 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:11 volumio volumio[965]: info: sendMpdCommand clear took 8 milliseconds Oct 11 18:19:11 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1454276" Oct 11 18:19:11 volumio volumio[965]: info: Oct 11 18:19:11 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:11 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:11 volumio volumio[965]: info: Oct 11 18:19:11 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:11 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:11 volumio volumio[965]: info: Oct 11 18:19:11 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:11 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:11 volumio volumio[965]: error: updateQueue error: null Oct 11 18:19:11 volumio volumio[965]: info: ------------------------------ 22ms Oct 11 18:19:11 volumio volumio[965]: error: Upnp client error: Error: This socket has been ended by the other party Oct 11 18:19:12 volumio volumio[965]: info: Oct 11 18:19:12 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:12 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:12 volumio volumio[965]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1454276" took 820 milliseconds Oct 11 18:19:12 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 11 18:19:12 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand play Oct 11 18:19:12 volumio volumio[965]: info: ------------------------------ 830ms Oct 11 18:19:12 volumio volumio[965]: info: ------------------------------ 828ms Oct 11 18:19:12 volumio volumio[965]: info: ------------------------------ 825ms Oct 11 18:19:12 volumio volumio[965]: info: ------------------------------ 17ms Oct 11 18:19:12 volumio volumio[965]: info: Oct 11 18:19:12 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:12 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:12 volumio volumio[965]: info: Oct 11 18:19:12 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:12 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:12 volumio volumio[965]: info: Oct 11 18:19:12 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:12 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:12 volumio volumio[965]: info: sendMpdCommand play took 27 milliseconds Oct 11 18:19:12 volumio volumio[965]: info: ------------------------------ 15ms Oct 11 18:19:12 volumio volumio[965]: info: ------------------------------ 11ms Oct 11 18:19:12 volumio volumio[965]: info: ------------------------------ 9ms Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 297 milliseconds Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:13 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 301 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 296 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 291 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: 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":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus stop Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 321ms Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:13 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:13 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:13 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 28ms Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 27 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 25 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 24 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 25 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 16ms Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 15 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 15ms Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 12 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 12ms Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 9 milliseconds Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":250,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:13 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":341,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:13 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":352,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:13 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 416ms Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 413ms Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 408ms Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 86 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 83 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 82 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 81 milliseconds Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":443,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:13 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":637,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:13 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:13 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:13 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 223ms Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 210ms Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 209ms Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 206ms Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:13 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:13 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:13 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:13 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:13 volumio volumio[965]: info: Oct 11 18:19:13 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 17ms Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 14 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 13ms Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 10 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 9ms Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 7 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 6ms Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand status took 8 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1001,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"GINA GUSATU - IN VIATA AM TRECUT PRIN MULTE @ bY Profu","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:13 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1001,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"GINA GUSATU - IN VIATA AM TRECUT PRIN MULTE @ bY Profu","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:13 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1001,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"GINA GUSATU - IN VIATA AM TRECUT PRIN MULTE @ bY Profu","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:13 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 91ms Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 87ms Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 84ms Oct 11 18:19:13 volumio volumio[965]: info: sendMpdCommand playlistinfo took 71 milliseconds Oct 11 18:19:13 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:13 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:13 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:13 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1001,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"GINA GUSATU - IN VIATA AM TRECUT PRIN MULTE @ bY Profu","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://51.222.46.25:8123/stream","trackType":""} Oct 11 18:19:13 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:13 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:13 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:13 volumio volumio[965]: info: ------------------------------ 118ms Oct 11 18:19:19 volumio volumio[965]: info: CoreCommandRouter::volumioNext Oct 11 18:19:19 volumio volumio[965]: info: CoreStateMachine::next Oct 11 18:19:19 volumio volumio[965]: info: CoreStateMachine::stop Oct 11 18:19:19 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 18:19:19 volumio volumio[965]: info: CoreStateMachine::stPlaybackTimer Oct 11 18:19:19 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Oct 11 18:19:19 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Oct 11 18:19:19 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:19 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:19 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 18:19:19 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:19 volumio volumio[965]: info: CoreStateMachine::serviceStop Oct 11 18:19:19 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:19 volumio volumio[965]: info: CoreCommandRouter::serviceStop Oct 11 18:19:19 volumio volumio[965]: info: [1728641959998] ControllerWebradio::stop Oct 11 18:19:19 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Oct 11 18:19:20 volumio volumio[965]: info: Oct 11 18:19:20 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:20 volumio volumio[965]: info: sendMpdCommand stop took 138 milliseconds Oct 11 18:19:20 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:20 volumio volumio[965]: info: CoreStateMachine::play index undefined Oct 11 18:19:20 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 18:19:20 volumio volumio[965]: info: CorePlayQueue::getTrack 1 Oct 11 18:19:20 volumio volumio[965]: info: Oct 11 18:19:20 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:20 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:20 volumio volumio[965]: info: Oct 11 18:19:20 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:20 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:20 volumio volumio[965]: info: Oct 11 18:19:20 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:20 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:20 volumio volumio[965]: info: sendMpdCommand status took 13 milliseconds Oct 11 18:19:20 volumio volumio[965]: info: sendMpdCommand status took 8 milliseconds Oct 11 18:19:20 volumio volumio[965]: info: sendMpdCommand status took 6 milliseconds Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:20 volumio volumio[965]: info: sendMpdCommand status took 9 milliseconds Oct 11 18:19:20 volumio volumio[965]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 11 18:19:20 volumio volumio[965]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 11 18:19:20 volumio volumio[965]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:20 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:20 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:20 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:20 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:20 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 18:19:20 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:20 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:20 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 11 18:19:20 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:20 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:20 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:20 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:20 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:20 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:20 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 11 18:19:20 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:20 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:20 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:20 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:20 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:20 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:20 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 11 18:19:20 volumio volumio[965]: info: ------------------------------ 73ms Oct 11 18:19:20 volumio volumio[965]: info: ------------------------------ 67ms Oct 11 18:19:20 volumio volumio[965]: info: ------------------------------ 65ms Oct 11 18:19:20 volumio volumio[965]: info: sendMpdCommand playlistinfo took 51 milliseconds Oct 11 18:19:20 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:20 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:20 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:20 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:20 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:20 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:20 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:20 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 11 18:19:20 volumio volumio[965]: info: ------------------------------ 86ms Oct 11 18:19:21 volumio volumio[965]: info: CoreCommandRouter::volumioGetState Oct 11 18:19:21 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:32 volumio volumio[965]: info: CoreCommandRouter::volumioGetState Oct 11 18:19:32 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:35 volumio volumio[965]: info: CoreCommandRouter::volumioGetState Oct 11 18:19:35 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:40 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 11 18:19:41 volumio volumio[965]: info: Preload queue cleared Oct 11 18:19:43 volumio volumio[965]: info: CoreCommandRouter::volumioGetState Oct 11 18:19:43 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:45 volumio volumio[965]: info: Preload queue cleared Oct 11 18:19:45 volumio volumio[965]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::ClearQueue Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::stop Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 18:19:45 volumio volumio[965]: info: CorePlayQueue::clearPlayQueue Oct 11 18:19:45 volumio volumio[965]: info: CorePlayQueue::saveQueue Oct 11 18:19:45 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::addQueueItems Oct 11 18:19:45 volumio volumio[965]: info: CorePlayQueue::addQueueItems Oct 11 18:19:45 volumio volumio[965]: info: Preload queue cleared Oct 11 18:19:45 volumio volumio[965]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Oct 11 18:19:45 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 11 18:19:45 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Oct 11 18:19:45 volumio volumio[965]: info: CorePlayQueue::saveQueue Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Oct 11 18:19:45 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Oct 11 18:19:45 volumio volumio[965]: info: CoreCommandRouter::volumioPlay Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::play index 0 Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::stop Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::play index undefined Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 18:19:45 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::startPlaybackTimer Oct 11 18:19:45 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:45 volumio volumio[965]: info: [1728641985301] ControllerWebradio::clearAddPlayTrack Oct 11 18:19:45 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Oct 11 18:19:45 volumio volumio[965]: info: sendMpdCommand stop took 7 milliseconds Oct 11 18:19:45 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Oct 11 18:19:45 volumio volumio[965]: info: sendMpdCommand clear took 1 milliseconds Oct 11 18:19:45 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Oct 11 18:19:45 volumio volumio[965]: info: Oct 11 18:19:45 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:45 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:45 volumio volumio[965]: info: Oct 11 18:19:45 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:45 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:45 volumio volumio[965]: info: Oct 11 18:19:45 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:45 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:45 volumio volumio[965]: info: Oct 11 18:19:45 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:45 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:45 volumio volumio[965]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 208 milliseconds Oct 11 18:19:45 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 11 18:19:45 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand play Oct 11 18:19:45 volumio volumio[965]: info: Oct 11 18:19:45 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:45 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:45 volumio volumio[965]: info: ------------------------------ 215ms Oct 11 18:19:45 volumio volumio[965]: info: ------------------------------ 214ms Oct 11 18:19:45 volumio volumio[965]: info: ------------------------------ 212ms Oct 11 18:19:45 volumio volumio[965]: info: ------------------------------ 207ms Oct 11 18:19:45 volumio volumio[965]: info: sendMpdCommand play took 9 milliseconds Oct 11 18:19:45 volumio volumio[965]: info: Oct 11 18:19:45 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:45 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:45 volumio volumio[965]: info: Oct 11 18:19:45 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:45 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:45 volumio volumio[965]: info: Oct 11 18:19:45 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:45 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:45 volumio volumio[965]: info: ------------------------------ 21ms Oct 11 18:19:45 volumio volumio[965]: info: ------------------------------ 13ms Oct 11 18:19:45 volumio volumio[965]: info: ------------------------------ 10ms Oct 11 18:19:45 volumio volumio[965]: info: ------------------------------ 8ms Oct 11 18:19:48 volumio volumio[965]: info: Oct 11 18:19:48 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:48 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:48 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:48 volumio volumio[965]: info: Oct 11 18:19:48 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:48 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:48 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:48 volumio volumio[965]: info: Oct 11 18:19:48 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:48 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:48 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:48 volumio volumio[965]: info: Oct 11 18:19:48 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:48 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:48 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 255 milliseconds Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:49 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 260 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 255 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 251 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: 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":"128 Kbps","isStreaming":false,"title":"antenne","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus stop Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 273ms Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:49 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:49 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:49 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:49 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 22ms Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 18 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 16 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 16 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 16 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 13ms Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 11 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 10ms Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 10 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 9ms Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 7 milliseconds Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: 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":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:49 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:49 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:49 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 346ms Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 343ms Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 340ms Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:49 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:49 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:49 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:49 volumio volumio[965]: info: Oct 11 18:19:49 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 82ms Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 80 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 76 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 75 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 74 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 75 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 13ms Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 13 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 12ms Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 10 milliseconds Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:49 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:49 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:49 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:49 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 220ms Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 211ms Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 210ms Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 208ms Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 164ms Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand status took 163 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 154 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 153 milliseconds Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 152 milliseconds Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:49 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":815,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:49 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":815,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:49 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 299ms Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 229ms Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 227ms Oct 11 18:19:49 volumio volumio[965]: info: sendMpdCommand playlistinfo took 61 milliseconds Oct 11 18:19:49 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:49 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:49 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:49 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":815,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:49 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:49 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:49 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:49 volumio volumio[965]: info: ------------------------------ 251ms Oct 11 18:19:50 volumio volumio[965]: info: Oct 11 18:19:50 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:50 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:50 volumio volumio[965]: info: Oct 11 18:19:50 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:50 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:50 volumio volumio[965]: info: Oct 11 18:19:50 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:50 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:50 volumio volumio[965]: info: Oct 11 18:19:50 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:50 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:50 volumio volumio[965]: info: Oct 11 18:19:50 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:50 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:50 volumio volumio[965]: info: Oct 11 18:19:50 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:50 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:50 volumio volumio[965]: info: Oct 11 18:19:50 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:19:50 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:19:50 volumio volumio[965]: info: Oct 11 18:19:50 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:19:50 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:19:50 volumio volumio[965]: info: ------------------------------ 18ms Oct 11 18:19:50 volumio volumio[965]: info: sendMpdCommand status took 14 milliseconds Oct 11 18:19:50 volumio volumio[965]: info: ------------------------------ 12ms Oct 11 18:19:50 volumio volumio[965]: info: sendMpdCommand status took 9 milliseconds Oct 11 18:19:50 volumio volumio[965]: info: ------------------------------ 8ms Oct 11 18:19:50 volumio volumio[965]: info: sendMpdCommand status took 6 milliseconds Oct 11 18:19:50 volumio volumio[965]: info: ------------------------------ 5ms Oct 11 18:19:50 volumio volumio[965]: info: sendMpdCommand status took 4 milliseconds Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:19:50 volumio volumio[965]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 11 18:19:50 volumio volumio[965]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:50 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:50 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:50 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2022,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:50 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:50 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:50 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:50 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:50 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2113,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:50 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:50 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:50 volumio volumio[965]: info: ------------------------------ 62ms Oct 11 18:19:50 volumio volumio[965]: info: ------------------------------ 58ms Oct 11 18:19:50 volumio volumio[965]: info: sendMpdCommand playlistinfo took 45 milliseconds Oct 11 18:19:50 volumio volumio[965]: info: sendMpdCommand playlistinfo took 46 milliseconds Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:50 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:19:50 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:50 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:50 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2113,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:50 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:50 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:50 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:19:50 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:19:50 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2113,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:19:50 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:19:50 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:50 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:19:50 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:19:50 volumio volumio[965]: info: ------------------------------ 107ms Oct 11 18:19:50 volumio volumio[965]: info: ------------------------------ 105ms Oct 11 18:19:54 volumio volumio[965]: info: CoreCommandRouter::volumioGetState Oct 11 18:19:54 volumio sudo[2183]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Oct 11 18:19:54 volumio sudo[2183]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 18:19:58 volumio volumio[965]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Oct 11 18:19:58 volumio volumio[965]: info: CoreCommandRouter::volumioGetState Oct 11 18:20:05 volumio volumio[965]: info: CoreCommandRouter::volumioGetState Oct 11 18:20:06 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 11 18:20:06 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 11 18:20:07 volumio volumio[965]: info: Oct 11 18:20:07 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:20:07 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:20:07 volumio volumio[965]: info: Oct 11 18:20:07 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:20:07 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:20:07 volumio volumio[965]: info: Oct 11 18:20:07 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:20:07 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:20:07 volumio volumio[965]: info: Oct 11 18:20:07 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:20:07 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:20:07 volumio volumio[965]: info: Oct 11 18:20:07 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:20:07 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:20:07 volumio volumio[965]: info: Oct 11 18:20:07 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:20:07 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:20:07 volumio volumio[965]: info: Oct 11 18:20:07 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:20:07 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:20:07 volumio volumio[965]: info: Oct 11 18:20:07 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:20:07 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:20:07 volumio volumio[965]: info: ------------------------------ 10ms Oct 11 18:20:07 volumio volumio[965]: info: sendMpdCommand status took 9 milliseconds Oct 11 18:20:07 volumio volumio[965]: info: ------------------------------ 8ms Oct 11 18:20:07 volumio volumio[965]: info: sendMpdCommand status took 7 milliseconds Oct 11 18:20:07 volumio volumio[965]: info: ------------------------------ 6ms Oct 11 18:20:07 volumio volumio[965]: info: sendMpdCommand status took 6 milliseconds Oct 11 18:20:07 volumio volumio[965]: info: ------------------------------ 5ms Oct 11 18:20:07 volumio volumio[965]: info: sendMpdCommand status took 4 milliseconds Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:20:07 volumio volumio[965]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 11 18:20:07 volumio volumio[965]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 11 18:20:07 volumio volumio[965]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 11 18:20:07 volumio volumio[965]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:20:07 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:20:07 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:20:07 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:20:07 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":18657,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Katy Perry - Woman's World","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:20:07 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:20:07 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:07 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:20:07 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:20:07 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":18657,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Katy Perry - Woman's World","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:20:07 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:20:07 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:07 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:20:07 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:20:07 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":18657,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Katy Perry - Woman's World","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:20:07 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:20:07 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:07 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:20:07 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:20:07 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":18657,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Katy Perry - Woman's World","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:20:07 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:20:07 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:07 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:07 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:07 volumio volumio[965]: info: ------------------------------ 131ms Oct 11 18:20:07 volumio volumio[965]: info: ------------------------------ 130ms Oct 11 18:20:07 volumio volumio[965]: info: ------------------------------ 129ms Oct 11 18:20:07 volumio volumio[965]: info: ------------------------------ 131ms Oct 11 18:20:09 volumio volumio[965]: info: Oct 11 18:20:09 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:20:09 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:20:09 volumio volumio[965]: info: Oct 11 18:20:09 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:20:09 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:20:09 volumio volumio[965]: info: Oct 11 18:20:09 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:20:09 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:20:09 volumio volumio[965]: info: Oct 11 18:20:09 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:20:09 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:20:09 volumio volumio[965]: info: Oct 11 18:20:09 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:20:09 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:20:09 volumio volumio[965]: info: Oct 11 18:20:09 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:20:09 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:20:09 volumio volumio[965]: info: Oct 11 18:20:09 volumio volumio[965]: ---------------------------- MPD announces system playlist update Oct 11 18:20:09 volumio volumio[965]: info: Ignoring MPD Status Update Oct 11 18:20:09 volumio volumio[965]: info: Oct 11 18:20:09 volumio volumio[965]: ---------------------------- MPD announces state update: player Oct 11 18:20:09 volumio volumio[965]: info: ControllerMpd::getState Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Oct 11 18:20:09 volumio volumio[965]: info: ------------------------------ 19ms Oct 11 18:20:09 volumio volumio[965]: info: sendMpdCommand status took 17 milliseconds Oct 11 18:20:09 volumio volumio[965]: info: ------------------------------ 16ms Oct 11 18:20:09 volumio volumio[965]: info: sendMpdCommand status took 15 milliseconds Oct 11 18:20:09 volumio volumio[965]: info: ------------------------------ 14ms Oct 11 18:20:09 volumio volumio[965]: info: sendMpdCommand status took 12 milliseconds Oct 11 18:20:09 volumio volumio[965]: info: ------------------------------ 11ms Oct 11 18:20:09 volumio volumio[965]: info: sendMpdCommand status took 9 milliseconds Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::parseState Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 18:20:09 volumio volumio[965]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 11 18:20:09 volumio volumio[965]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 11 18:20:09 volumio volumio[965]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 11 18:20:09 volumio volumio[965]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:20:09 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Oct 11 18:20:09 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:20:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:20:09 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":21155,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Katy Perry - Woman's World","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:20:09 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:20:09 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:09 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:20:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:20:09 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":21155,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Katy Perry - Woman's World","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:20:09 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:20:09 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:09 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:20:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:20:09 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":21155,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Katy Perry - Woman's World","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:20:09 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:20:09 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:09 volumio volumio[965]: info: ControllerMpd::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::servicePushState Oct 11 18:20:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:20:09 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":21155,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Katy Perry - Woman's World","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Oct 11 18:20:09 volumio volumio[965]: verbose: CURRENT POSITION 0 Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Oct 11 18:20:09 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:09 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:09 volumio volumio[965]: info: ------------------------------ 144ms Oct 11 18:20:09 volumio volumio[965]: info: ------------------------------ 143ms Oct 11 18:20:09 volumio volumio[965]: info: ------------------------------ 139ms Oct 11 18:20:09 volumio volumio[965]: info: ------------------------------ 136ms Oct 11 18:20:10 volumio volumio[965]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 18:20:10 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 18:20:24 volumio volumio[965]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Oct 11 18:20:24 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Oct 11 18:20:24 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 18:20:24 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 18:20:24 volumio volumio[965]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 18:20:24 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 18:20:32 volumio volumio[965]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Oct 11 18:20:32 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Oct 11 18:20:32 volumio volumio[965]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 18:20:32 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 18:20:37 volumio volumio[965]: info: CoreCommandRouter::volumioNext Oct 11 18:20:37 volumio volumio[965]: info: CoreStateMachine::next Oct 11 18:20:37 volumio volumio[965]: info: CoreStateMachine::stop Oct 11 18:20:37 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 18:20:37 volumio volumio[965]: info: CoreStateMachine::stPlaybackTimer Oct 11 18:20:37 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Oct 11 18:20:37 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Oct 11 18:20:37 volumio volumio[965]: info: CoreStateMachine::pushState Oct 11 18:20:37 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:20:37 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 18:20:37 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Oct 11 18:20:37 volumio volumio[965]: info: CoreStateMachine::serviceStop Oct 11 18:20:37 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Oct 11 18:20:37 volumio volumio[965]: info: CoreCommandRouter::serviceStop Oct 11 18:20:37 volumio volumio[965]: info: [1728642037603] ControllerWebradio::stop Oct 11 18:20:37 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Oct 11 18:20:37 volumio volumio[965]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 18:20:37 volumio volumio[965]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Oct 11 18:20:37 volumio volumio[965]: at Object.readdirSync (fs.js:1048:3) Oct 11 18:20:37 volumio volumio[965]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Oct 11 18:20:37 volumio volumio[965]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Oct 11 18:20:37 volumio volumio[965]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Oct 11 18:20:37 volumio volumio[965]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Oct 11 18:20:37 volumio volumio[965]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Oct 11 18:20:37 volumio volumio[965]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 11 18:20:37 volumio volumio[965]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Oct 11 18:20:37 volumio volumio[965]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Oct 11 18:20:37 volumio volumio[965]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 11 18:20:37 volumio volumio[965]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 11 18:20:37 volumio volumio[965]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Oct 11 18:20:37 volumio volumio[965]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 11 18:20:37 volumio volumio[965]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 11 18:20:37 volumio volumio[965]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Oct 11 18:20:37 volumio volumio[965]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Oct 11 18:20:37 volumio volumio[965]: errno: -20, Oct 11 18:20:37 volumio volumio[965]: syscall: 'scandir', Oct 11 18:20:37 volumio volumio[965]: code: 'ENOTDIR', Oct 11 18:20:37 volumio volumio[965]: path: '/tmp/peppyrunning' Oct 11 18:20:37 volumio volumio[965]: } Oct 11 18:20:37 volumio volumio[965]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 18:20:38 volumio sudo[2398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-11 18:19 Oct 11 18:20:38 volumio sudo[2398]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"