-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2025-02-19 10:42:03 CET. -- Feb 19 10:41:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:01 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:01 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:01 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:01 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:01 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:01 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:02 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:02 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:02 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:02 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:02 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:02 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:03 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:03 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:03 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:03 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::volumioPlay Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::play index 1 Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::stop Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::stPlaybackTimer Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::updateTrackBlock Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrackBlock Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 0 Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::serviceStop Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 0 Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::serviceStop Feb 19 10:41:04 apen volumio[1026]: info: [1739958064579] ControllerWebradio::stop Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand stop Feb 19 10:41:04 apen volumio[1026]: info: [GPIO_Control] Status changed: stop Feb 19 10:41:04 apen volumio[1026]: info: [GPIO_Control] Handling event: musicStop Feb 19 10:41:04 apen volumio[1026]: info: Feb 19 10:41:04 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:04 apen volumio[1026]: info: sendMpdCommand stop took 18 milliseconds Feb 19 10:41:04 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::play index undefined Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::startPlaybackTimer Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:04 apen volumio[1026]: info: [1739958064600] ControllerWebradio::clearAddPlayTrack Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand stop Feb 19 10:41:04 apen volumio[1026]: info: sendMpdCommand status took 4 milliseconds Feb 19 10:41:04 apen volumio[1026]: info: sendMpdCommand stop took 2 milliseconds Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand clear Feb 19 10:41:04 apen volumio[1026]: info: Feb 19 10:41:04 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:04 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:04 apen volumio[1026]: info: Feb 19 10:41:04 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:04 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:04 apen volumio[1026]: info: Feb 19 10:41:04 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:04 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:04 apen volumio[1026]: info: Feb 19 10:41:04 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:04 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:04 apen volumio[1026]: info: sendMpdCommand playlistinfo took 15 milliseconds Feb 19 10:41:04 apen volumio[1026]: info: sendMpdCommand clear took 16 milliseconds Feb 19 10:41:04 apen volumio[1026]: info: sendMpdCommand status took 9 milliseconds Feb 19 10:41:04 apen volumio[1026]: info: sendMpdCommand status took 7 milliseconds Feb 19 10:41:04 apen volumio[1026]: info: sendMpdCommand status took 6 milliseconds Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand load "https://stream.radio357.pl/" Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:04 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:04 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:04 apen volumio[1026]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 19 10:41:04 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:04 apen volumio[1026]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 19 10:41:04 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:04 apen volumio[1026]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 19 10:41:04 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:04 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:04 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:04 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:04 apen volumio[1026]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 19 10:41:04 apen volumio[1026]: info: ------------------------------ 89ms Feb 19 10:41:04 apen volumio[1026]: info: ------------------------------ 81ms Feb 19 10:41:04 apen volumio[1026]: info: ------------------------------ 75ms Feb 19 10:41:04 apen volumio[1026]: info: ------------------------------ 73ms Feb 19 10:41:04 apen volumio[1026]: info: Feb 19 10:41:04 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:04 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:04 apen volumio[1026]: info: Feb 19 10:41:04 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:04 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:04 apen volumio[1026]: info: Feb 19 10:41:04 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:04 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:04 apen volumio[1026]: error: updateQueue error: null Feb 19 10:41:04 apen volumio[1026]: info: ------------------------------ 88ms Feb 19 10:41:04 apen volumio[1026]: info: [GPIO_Control] Status changed: stop Feb 19 10:41:04 apen volumio[1026]: info: [GPIO_Control] Status changed: stop Feb 19 10:41:04 apen volumio[1026]: info: [GPIO_Control] Status changed: stop Feb 19 10:41:04 apen volumio[1026]: info: [GPIO_Control] Status changed: stop Feb 19 10:41:08 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radio357.pl/" Feb 19 10:41:08 apen volumio[1026]: error: updateQueue error: null Feb 19 10:41:08 apen volumio[1026]: error: updateQueue error: null Feb 19 10:41:08 apen volumio[1026]: error: updateQueue error: null Feb 19 10:41:08 apen volumio[1026]: info: Feb 19 10:41:08 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:08 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:08 apen volumio[1026]: info: ------------------------------ 3607ms Feb 19 10:41:08 apen volumio[1026]: info: ------------------------------ 3606ms Feb 19 10:41:08 apen volumio[1026]: info: ------------------------------ 3607ms Feb 19 10:41:08 apen volumio[1026]: info: sendMpdCommand add "https://stream.radio357.pl/" took 7 milliseconds Feb 19 10:41:08 apen volumio[1026]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 19 10:41:08 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand play Feb 19 10:41:08 apen volumio[1026]: Upnp client error: Error: This socket has been ended by the other party Feb 19 10:41:08 apen volumio[1026]: info: Feb 19 10:41:08 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:08 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:08 apen volumio[1026]: info: Feb 19 10:41:08 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:08 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:08 apen volumio[1026]: info: Feb 19 10:41:08 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:08 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:08 apen volumio[1026]: info: ------------------------------ 13ms Feb 19 10:41:08 apen volumio[1026]: info: sendMpdCommand play took 9 milliseconds Feb 19 10:41:08 apen volumio[1026]: info: ------------------------------ 6ms Feb 19 10:41:08 apen volumio[1026]: info: ------------------------------ 4ms Feb 19 10:41:08 apen volumio[1026]: info: ------------------------------ 3ms Feb 19 10:41:08 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:08 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:08 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:08 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:09 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:09 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:09 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:09 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:09 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:09 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 24 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 28 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 27 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 26 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 10 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 7 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 6 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 4 milliseconds Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus stop Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:10 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:10 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:10 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 86ms Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 160ms Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 159ms Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 158ms Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:10 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 124 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 122 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 122 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 121 milliseconds Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:10 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Zuzanna Malisz - Morze łez","artist":"-","album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:10 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Zuzanna Malisz - Morze łez","artist":"-","album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:10 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Zuzanna Malisz - Morze łez","artist":"-","album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:10 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 255ms Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 243ms Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 243ms Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 242ms Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Handling event: musicPlay Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:10 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:10 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:10 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:10 apen volumio[1026]: info: Feb 19 10:41:10 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 193ms Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 190 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 11ms Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 10 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 9ms Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 8 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 7ms Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand status took 6 milliseconds Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 19 10:41:10 apen volumio[1026]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Zuzanna Malisz - Morze łez","artist":"-","album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:10 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1077,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Zuzanna Malisz - Morze łez","artist":"-","album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:10 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1077,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Zuzanna Malisz - Morze łez","artist":"-","album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:10 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:10 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:10 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1077,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Zuzanna Malisz - Morze łez","artist":"-","album":null,"uri":"https://stream.radio357.pl/","trackType":"pl/"} Feb 19 10:41:10 apen volumio[1026]: verbose: CURRENT POSITION 1 Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:10 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 320ms Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 138ms Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 137ms Feb 19 10:41:10 apen volumio[1026]: info: ------------------------------ 136ms Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:10 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:11 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:11 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:11 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:11 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:11 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 19 10:41:11 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 19 10:41:11 apen volumio[1026]: info: Discovery: Getting this device information Feb 19 10:41:11 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:11 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 19 10:41:11 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:11 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:12 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:12 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:12 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:12 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:13 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:13 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:13 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:13 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:13 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:13 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::volumioPlay Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::play index 2 Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::stop Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::stPlaybackTimer Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::updateTrackBlock Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrackBlock Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::serviceStop Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrack 1 Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::serviceStop Feb 19 10:41:14 apen volumio[1026]: info: [1739958074494] ControllerWebradio::stop Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand stop Feb 19 10:41:14 apen volumio[1026]: info: [GPIO_Control] Status changed: stop Feb 19 10:41:14 apen volumio[1026]: info: [GPIO_Control] Handling event: musicStop Feb 19 10:41:14 apen volumio[1026]: info: sendMpdCommand stop took 22 milliseconds Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::play index undefined Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::startPlaybackTimer Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:14 apen volumio[1026]: info: [1739958074518] ControllerWebradio::clearAddPlayTrack Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand stop Feb 19 10:41:14 apen volumio[1026]: info: Feb 19 10:41:14 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:14 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:14 apen volumio[1026]: info: sendMpdCommand stop took 2 milliseconds Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand clear Feb 19 10:41:14 apen volumio[1026]: info: Feb 19 10:41:14 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:14 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:14 apen volumio[1026]: info: Feb 19 10:41:14 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:14 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:14 apen volumio[1026]: info: Feb 19 10:41:14 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:14 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:14 apen volumio[1026]: info: Feb 19 10:41:14 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:14 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:14 apen volumio[1026]: info: sendMpdCommand status took 10 milliseconds Feb 19 10:41:14 apen volumio[1026]: info: sendMpdCommand clear took 10 milliseconds Feb 19 10:41:14 apen volumio[1026]: info: sendMpdCommand status took 8 milliseconds Feb 19 10:41:14 apen volumio[1026]: info: sendMpdCommand status took 5 milliseconds Feb 19 10:41:14 apen volumio[1026]: info: sendMpdCommand status took 4 milliseconds Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand load "http://stream.rcs.revma.com/ypqt40u0x1zuv" Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:14 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:14 apen volumio[1026]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 19 10:41:14 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:14 apen volumio[1026]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 19 10:41:14 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:14 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:14 apen volumio[1026]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 19 10:41:14 apen volumio[1026]: info: ------------------------------ 60ms Feb 19 10:41:14 apen volumio[1026]: info: ------------------------------ 59ms Feb 19 10:41:14 apen volumio[1026]: info: ------------------------------ 57ms Feb 19 10:41:14 apen volumio[1026]: info: Feb 19 10:41:14 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:14 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:14 apen volumio[1026]: info: Feb 19 10:41:14 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:14 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:14 apen volumio[1026]: info: Feb 19 10:41:14 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:14 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:14 apen volumio[1026]: error: updateQueue error: null Feb 19 10:41:14 apen volumio[1026]: info: ------------------------------ 62ms Feb 19 10:41:14 apen volumio[1026]: info: sendMpdCommand playlistinfo took 58 milliseconds Feb 19 10:41:14 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:14 apen volumio[1026]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 19 10:41:14 apen volumio[1026]: info: ------------------------------ 74ms Feb 19 10:41:14 apen volumio[1026]: info: [GPIO_Control] Status changed: stop Feb 19 10:41:14 apen volumio[1026]: info: [GPIO_Control] Status changed: stop Feb 19 10:41:14 apen volumio[1026]: info: [GPIO_Control] Status changed: stop Feb 19 10:41:14 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:14 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:15 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand add "http://stream.rcs.revma.com/ypqt40u0x1zuv" Feb 19 10:41:15 apen volumio[1026]: error: updateQueue error: null Feb 19 10:41:15 apen volumio[1026]: error: updateQueue error: null Feb 19 10:41:15 apen volumio[1026]: error: updateQueue error: null Feb 19 10:41:15 apen volumio[1026]: info: Feb 19 10:41:15 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:15 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:15 apen volumio[1026]: info: ------------------------------ 1236ms Feb 19 10:41:15 apen volumio[1026]: info: ------------------------------ 1235ms Feb 19 10:41:15 apen volumio[1026]: info: ------------------------------ 1233ms Feb 19 10:41:15 apen volumio[1026]: info: sendMpdCommand add "http://stream.rcs.revma.com/ypqt40u0x1zuv" took 4 milliseconds Feb 19 10:41:15 apen volumio[1026]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 19 10:41:15 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand play Feb 19 10:41:15 apen volumio[1026]: info: Feb 19 10:41:15 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:15 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:15 apen volumio[1026]: info: Feb 19 10:41:15 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:15 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:15 apen volumio[1026]: info: Feb 19 10:41:15 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:15 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:15 apen volumio[1026]: info: ------------------------------ 13ms Feb 19 10:41:15 apen volumio[1026]: info: sendMpdCommand play took 11 milliseconds Feb 19 10:41:15 apen volumio[1026]: info: ------------------------------ 9ms Feb 19 10:41:15 apen volumio[1026]: info: ------------------------------ 6ms Feb 19 10:41:15 apen volumio[1026]: info: ------------------------------ 7ms Feb 19 10:41:15 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:16 apen volumio[1026]: info: Feb 19 10:41:16 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:16 apen volumio[1026]: info: Feb 19 10:41:16 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:16 apen volumio[1026]: info: Feb 19 10:41:16 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:16 apen volumio[1026]: info: Feb 19 10:41:16 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand status took 23 milliseconds Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:16 apen volumio[1026]: info: Feb 19 10:41:16 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand status took 24 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand status took 24 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand status took 22 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:16 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:16 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:16 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus stop Feb 19 10:41:16 apen volumio[1026]: info: ------------------------------ 34ms Feb 19 10:41:16 apen volumio[1026]: info: Feb 19 10:41:16 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:16 apen volumio[1026]: info: Feb 19 10:41:16 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:16 apen volumio[1026]: info: Feb 19 10:41:16 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand status took 13 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand playlistinfo took 12 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand status took 7 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand status took 5 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand status took 3 milliseconds Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:16 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:16 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:16 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:16 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:16 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:16 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:16 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:16 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:16 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:16 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:16 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:16 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:16 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:16 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:16 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:16 apen volumio[1026]: info: ------------------------------ 152ms Feb 19 10:41:16 apen volumio[1026]: info: ------------------------------ 151ms Feb 19 10:41:16 apen volumio[1026]: info: ------------------------------ 150ms Feb 19 10:41:16 apen volumio[1026]: info: Feb 19 10:41:16 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:16 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:16 apen volumio[1026]: info: Feb 19 10:41:16 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand playlistinfo took 117 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand playlistinfo took 115 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand playlistinfo took 116 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: sendMpdCommand playlistinfo took 115 milliseconds Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:16 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:16 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:16 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:16 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:16 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:16 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:16 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:16 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:16 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:16 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:16 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:16 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:16 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:16 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:17 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:17 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:17 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:17 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 260ms Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 255ms Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 255ms Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 253ms Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Handling event: musicPlay Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:17 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:17 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:17 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:17 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 223ms Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand status took 219 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 18ms Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand status took 18 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 17ms Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand status took 16 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 16ms Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand status took 14 milliseconds Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:17 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:17 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces system playlist update Feb 19 10:41:17 apen volumio[1026]: info: Ignoring MPD Status Update Feb 19 10:41:17 apen volumio[1026]: info: Feb 19 10:41:17 apen volumio[1026]: ---------------------------- MPD announces state update: player Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::getState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand status Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 27ms Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand status took 25 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand playlistinfo took 21 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand playlistinfo took 21 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand playlistinfo took 20 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand playlistinfo took 20 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 19ms Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand status took 18 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 16ms Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand status took 15 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 15ms Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand status took 13 milliseconds Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseState Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Massive Attack - Psyche (Flash Treatment) (feat. Martina Topley-Bird)","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:17 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:17 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1079,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Massive Attack - Psyche (Flash Treatment) (feat. Martina Topley-Bird)","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:17 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:17 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1079,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Massive Attack - Psyche (Flash Treatment) (feat. Martina Topley-Bird)","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:17 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:17 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1079,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Massive Attack - Psyche (Flash Treatment) (feat. Martina Topley-Bird)","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:17 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:17 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 390ms Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 187ms Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 187ms Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 187ms Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand playlistinfo took 153 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand playlistinfo took 151 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand playlistinfo took 152 milliseconds Feb 19 10:41:17 apen volumio[1026]: info: sendMpdCommand playlistinfo took 151 milliseconds Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:17 apen volumio[1026]: verbose: ControllerMpd::parseTrackInfo Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1079,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Massive Attack - Psyche (Flash Treatment) (feat. Martina Topley-Bird)","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:17 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:17 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1079,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Massive Attack - Psyche (Flash Treatment) (feat. Martina Topley-Bird)","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:17 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:17 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1079,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Massive Attack - Psyche (Flash Treatment) (feat. Martina Topley-Bird)","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:17 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:17 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: ControllerMpd::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::servicePushState Feb 19 10:41:17 apen volumio[1026]: info: CorePlayQueue::getTrack 2 Feb 19 10:41:17 apen volumio[1026]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1079,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Massive Attack - Psyche (Flash Treatment) (feat. Martina Topley-Bird)","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Feb 19 10:41:17 apen volumio[1026]: verbose: CURRENT POSITION 2 Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState stateService play Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::syncState currentStatus play Feb 19 10:41:17 apen volumio[1026]: info: Received an update from plugin. extracting info from payload Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: CoreStateMachine::pushState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioPushState Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 334ms Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 324ms Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 322ms Feb 19 10:41:17 apen volumio[1026]: info: ------------------------------ 320ms Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: [GPIO_Control] Status changed: play Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:17 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:18 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:18 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:18 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:18 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:19 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:19 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:19 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:19 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:19 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:19 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:20 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:20 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:20 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:20 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:20 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:20 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:21 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:21 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:21 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:21 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:21 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:21 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:22 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:22 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:22 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:22 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:23 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:23 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:23 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:23 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:23 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:23 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:24 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:24 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:24 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:24 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:24 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:24 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:25 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:25 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:25 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:25 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:26 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:26 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:26 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:26 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:26 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:26 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:27 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:27 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:27 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:27 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:27 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:27 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:28 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:28 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:28 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:28 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:28 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:28 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:29 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:29 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:29 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:29 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:30 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:30 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:30 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:30 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:30 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:30 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:31 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:31 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:31 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:31 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:31 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:31 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:32 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:32 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:32 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:32 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:32 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:32 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:33 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:33 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:33 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:33 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:34 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:34 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:34 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:34 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:34 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:34 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:35 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:35 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:35 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:35 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:35 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:35 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:36 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:36 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:36 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:36 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:36 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:36 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:37 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:37 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:37 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:37 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:38 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:38 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:38 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:38 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:38 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:38 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:39 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:39 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:39 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:39 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:39 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:39 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:40 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:40 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:40 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:40 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:40 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:40 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:41 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:41 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:41 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:41 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:41 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 19 10:41:41 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 19 10:41:41 apen volumio[1026]: info: Discovery: Getting this device information Feb 19 10:41:41 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:41 apen volumio[1026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 19 10:41:42 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:42 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:42 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:42 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:42 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:42 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:43 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:43 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:43 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:43 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:43 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:43 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:44 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:44 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:44 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:44 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:44 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:44 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:45 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:45 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:45 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:45 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:46 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:46 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:46 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:46 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:46 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:46 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:47 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:47 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:47 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:47 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:47 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:47 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:48 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:48 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:48 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:48 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:48 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:48 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:49 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:49 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:49 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:49 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:50 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:50 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:50 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:50 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:50 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:50 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:51 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:51 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:51 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:51 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:51 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:51 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:52 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:52 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:52 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:52 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:52 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:52 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:53 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:53 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:53 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:53 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:54 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:54 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:54 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:54 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:54 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:54 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:55 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:55 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:55 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:55 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:55 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:55 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:56 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:56 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:56 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:56 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:56 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:56 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:57 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:57 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:57 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:57 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:58 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:58 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:58 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:58 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:58 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:58 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:59 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:59 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:59 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:59 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:59 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:41:59 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:00 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:01 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:01 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:01 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:01 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:02 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:02 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:02 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:02 apen volumio[1026]: info: CoreCommandRouter::volumioGetState Feb 19 10:42:02 apen volumio[1026]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Feb 19 10:42:02 apen volumio[1026]: info: PLUGIN onReboot : networkfs Feb 19 10:42:02 apen volumio[1026]: info: PLUGIN onReboot : audiophonicsonoff Feb 19 10:42:02 apen volumio[1026]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 19 10:42:02 apen volumio[1026]: TypeError: Cannot read property 'writeSync' of undefined Feb 19 10:42:02 apen volumio[1026]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_hardware/audiophonicsonoff/index.js:40:25) Feb 19 10:42:02 apen volumio[1026]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Feb 19 10:42:02 apen volumio[1026]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Feb 19 10:42:02 apen volumio[1026]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 19 10:42:02 apen volumio[1026]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 19 10:42:02 apen volumio[1026]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Feb 19 10:42:02 apen volumio[1026]: at CoreCommandRouter.reboot (/volumio/app/index.js:1344:22) Feb 19 10:42:02 apen volumio[1026]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Feb 19 10:42:02 apen volumio[1026]: at Socket.emit (events.js:315:20) Feb 19 10:42:02 apen volumio[1026]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Feb 19 10:42:02 apen volumio[1026]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Feb 19 10:42:02 apen volumio[1026]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 19 10:42:03 apen sudo[4620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-19 10:41 Feb 19 10:42:03 apen sudo[4620]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"