-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Fri 2025-01-17 16:26:09 UTC. -- Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 17 16:25:00 volumio volumio[761]: info: Jan 17 16:25:00 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:00 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:00 volumio volumio[761]: info: Jan 17 16:25:00 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:00 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:00 volumio volumio[761]: info: Jan 17 16:25:00 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:00 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:00 volumio volumio[761]: info: Jan 17 16:25:00 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:00 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:00 volumio volumio[761]: info: Jan 17 16:25:00 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:00 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:00 volumio volumio[761]: info: Jan 17 16:25:00 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:00 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:00 volumio volumio[761]: info: ------------------------------ 5ms Jan 17 16:25:00 volumio volumio[761]: info: sendMpdCommand status took 4 milliseconds Jan 17 16:25:00 volumio volumio[761]: info: ------------------------------ 4ms Jan 17 16:25:00 volumio volumio[761]: info: sendMpdCommand status took 3 milliseconds Jan 17 16:25:00 volumio volumio[761]: info: ------------------------------ 3ms Jan 17 16:25:00 volumio volumio[761]: info: sendMpdCommand status took 2 milliseconds Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:00 volumio volumio[761]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 17 16:25:00 volumio volumio[761]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 17 16:25:00 volumio volumio[761]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:00 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:00 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:00 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:00 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":16476,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:00 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:00 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:00 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:00 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:00 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":16476,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:00 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:00 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:00 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:00 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:00 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":16476,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:00 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:00 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:00 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:00 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:00 volumio volumio[761]: info: ------------------------------ 50ms Jan 17 16:25:00 volumio volumio[761]: info: ------------------------------ 48ms Jan 17 16:25:00 volumio volumio[761]: info: ------------------------------ 48ms Jan 17 16:25:02 volumio volumio[761]: info: CoreCommandRouter::volumioStop Jan 17 16:25:02 volumio volumio[761]: info: CoreStateMachine::stop Jan 17 16:25:02 volumio volumio[761]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 17 16:25:02 volumio volumio[761]: verbose: UNSET VOLATILE Jan 17 16:25:02 volumio volumio[761]: info: CoreStateMachine::stPlaybackTimer Jan 17 16:25:02 volumio volumio[761]: info: CoreStateMachine::updateTrackBlock Jan 17 16:25:02 volumio volumio[761]: info: CorePlayQueue::getTrackBlock Jan 17 16:25:02 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:02 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:02 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 16:25:02 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:02 volumio volumio[761]: info: CoreStateMachine::serviceStop Jan 17 16:25:02 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:02 volumio volumio[761]: info: CoreCommandRouter::serviceStop Jan 17 16:25:02 volumio volumio[761]: info: [1737131102460] ControllerWebradio::stop Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand stop Jan 17 16:25:02 volumio volumio[761]: info: Jan 17 16:25:02 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:02 volumio volumio[761]: info: sendMpdCommand stop took 27 milliseconds Jan 17 16:25:02 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:02 volumio volumio[761]: info: sendMpdCommand status took 1 milliseconds Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:02 volumio volumio[761]: info: Jan 17 16:25:02 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:02 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:02 volumio volumio[761]: info: Jan 17 16:25:02 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:02 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:02 volumio volumio[761]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 17 16:25:02 volumio volumio[761]: info: sendMpdCommand status took 2 milliseconds Jan 17 16:25:02 volumio volumio[761]: info: sendMpdCommand status took 1 milliseconds Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:02 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:02 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:02 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:02 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:02 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:02 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:02 volumio volumio[761]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 17 16:25:02 volumio volumio[761]: info: ------------------------------ 15ms Jan 17 16:25:02 volumio volumio[761]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 17 16:25:02 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:02 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:02 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:02 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:02 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:02 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:02 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:02 volumio volumio[761]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 17 16:25:02 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:02 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:02 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:02 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:02 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:02 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:02 volumio volumio[761]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 17 16:25:02 volumio volumio[761]: info: ------------------------------ 27ms Jan 17 16:25:02 volumio volumio[761]: info: ------------------------------ 27ms Jan 17 16:25:03 volumio volumio[761]: info: CoreCommandRouter::volumioPlay Jan 17 16:25:03 volumio volumio[761]: verbose: UNSET VOLATILE Jan 17 16:25:03 volumio volumio[761]: info: CoreStateMachine::play index undefined Jan 17 16:25:03 volumio volumio[761]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 17 16:25:03 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:03 volumio volumio[761]: info: CoreStateMachine::startPlaybackTimer Jan 17 16:25:03 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:03 volumio volumio[761]: info: [1737131103699] ControllerWebradio::clearAddPlayTrack Jan 17 16:25:03 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand stop Jan 17 16:25:03 volumio volumio[761]: info: sendMpdCommand stop took 1 milliseconds Jan 17 16:25:03 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand clear Jan 17 16:25:03 volumio volumio[761]: info: Jan 17 16:25:03 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:03 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:03 volumio volumio[761]: info: sendMpdCommand clear took 1 milliseconds Jan 17 16:25:03 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand load "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Jan 17 16:25:03 volumio volumio[761]: info: Jan 17 16:25:03 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:03 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:03 volumio volumio[761]: info: Jan 17 16:25:03 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:03 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:03 volumio volumio[761]: error: updateQueue error: null Jan 17 16:25:03 volumio volumio[761]: info: ------------------------------ 3ms Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Jan 17 16:25:04 volumio volumio[761]: error: updateQueue error: null Jan 17 16:25:04 volumio volumio[761]: error: updateQueue error: null Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:04 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 612ms Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 611ms Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" took 1 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand play Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:04 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:04 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 3ms Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand play took 2 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 2ms Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 1ms Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand status took 11 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand status took 8 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand status took 6 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand status took 5 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand status took 3 milliseconds Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:04 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:04 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:04 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:04 volumio volumio[761]: info: Jan 17 16:25:04 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand status took 10 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 6ms Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand status took 5 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 4ms Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand status took 4 milliseconds Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:04 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:04 volumio volumio[761]: 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":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:04 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus stop Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:04 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:04 volumio volumio[761]: 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":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:04 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:04 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:04 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:04 volumio volumio[761]: 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":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:04 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:04 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:04 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:04 volumio volumio[761]: 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":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:04 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:04 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:04 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:04 volumio volumio[761]: 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":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:04 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:04 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 88ms Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 87ms Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 84ms Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 84ms Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 83ms Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 72ms Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand status took 71 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand playlistinfo took 69 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand playlistinfo took 65 milliseconds Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand playlistinfo took 66 milliseconds Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:04 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:04 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:04 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:04 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:04 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:04 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:04 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:04 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:04 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:04 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:04 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:04 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 119ms Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 112ms Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 111ms Jan 17 16:25:04 volumio volumio[761]: info: sendMpdCommand playlistinfo took 63 milliseconds Jan 17 16:25:04 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:04 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:04 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:04 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:04 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:04 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:04 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:04 volumio volumio[761]: info: ------------------------------ 149ms Jan 17 16:25:05 volumio volumio[761]: info: Jan 17 16:25:05 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:05 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:05 volumio volumio[761]: info: Jan 17 16:25:05 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:05 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:05 volumio volumio[761]: info: Jan 17 16:25:05 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:05 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:05 volumio volumio[761]: info: Jan 17 16:25:05 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:05 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:05 volumio volumio[761]: info: Jan 17 16:25:05 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:05 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:05 volumio volumio[761]: info: Jan 17 16:25:05 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:05 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:05 volumio volumio[761]: info: ------------------------------ 4ms Jan 17 16:25:05 volumio volumio[761]: info: sendMpdCommand status took 4 milliseconds Jan 17 16:25:05 volumio volumio[761]: info: ------------------------------ 4ms Jan 17 16:25:05 volumio volumio[761]: info: sendMpdCommand status took 3 milliseconds Jan 17 16:25:05 volumio volumio[761]: info: ------------------------------ 3ms Jan 17 16:25:05 volumio volumio[761]: info: sendMpdCommand status took 2 milliseconds Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:05 volumio volumio[761]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 17 16:25:05 volumio volumio[761]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 17 16:25:05 volumio volumio[761]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:05 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:05 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:05 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:05 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:05 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1484,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:05 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:05 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:05 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 16:25:05 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:05 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:05 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:05 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:05 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:05 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1484,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:05 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:05 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:05 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:05 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:05 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:05 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:05 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:05 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1484,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:05 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:05 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:05 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:05 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:05 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:05 volumio volumio[761]: info: ------------------------------ 51ms Jan 17 16:25:05 volumio volumio[761]: info: ------------------------------ 50ms Jan 17 16:25:05 volumio volumio[761]: info: ------------------------------ 49ms Jan 17 16:25:06 volumio volumio[761]: info: CoreCommandRouter::volumioGetState Jan 17 16:25:06 volumio volumio[761]: info: Listing playlists Jan 17 16:25:06 volumio volumio[761]: info: Listing playlists Jan 17 16:25:06 volumio volumio[761]: info: Jan 17 16:25:06 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:06 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:06 volumio volumio[761]: info: Jan 17 16:25:06 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:06 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:06 volumio volumio[761]: info: Jan 17 16:25:06 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:06 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:06 volumio volumio[761]: info: Jan 17 16:25:06 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:06 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:06 volumio volumio[761]: info: Jan 17 16:25:06 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:06 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:06 volumio volumio[761]: info: Jan 17 16:25:06 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:06 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:06 volumio volumio[761]: info: ------------------------------ 9ms Jan 17 16:25:06 volumio volumio[761]: info: sendMpdCommand status took 6 milliseconds Jan 17 16:25:06 volumio volumio[761]: info: ------------------------------ 6ms Jan 17 16:25:06 volumio volumio[761]: info: sendMpdCommand status took 5 milliseconds Jan 17 16:25:06 volumio volumio[761]: info: ------------------------------ 4ms Jan 17 16:25:06 volumio volumio[761]: info: sendMpdCommand status took 2 milliseconds Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:06 volumio volumio[761]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 17 16:25:06 volumio volumio[761]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 17 16:25:06 volumio volumio[761]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:06 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:06 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:06 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:06 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:06 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:06 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:06 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:06 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 16:25:06 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:06 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:06 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:06 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:06 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:06 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:06 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:06 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:06 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:06 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:06 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:06 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:06 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:06 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:06 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:06 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:06 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:06 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:06 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:06 volumio volumio[761]: info: ------------------------------ 55ms Jan 17 16:25:06 volumio volumio[761]: info: ------------------------------ 53ms Jan 17 16:25:06 volumio volumio[761]: info: ------------------------------ 51ms Jan 17 16:25:07 volumio volumio[761]: info: Jan 17 16:25:07 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:07 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:07 volumio volumio[761]: info: Jan 17 16:25:07 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:07 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:07 volumio volumio[761]: info: Jan 17 16:25:07 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:07 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:07 volumio volumio[761]: info: Jan 17 16:25:07 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:07 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:07 volumio volumio[761]: info: Jan 17 16:25:07 volumio volumio[761]: ---------------------------- MPD announces system playlist update Jan 17 16:25:07 volumio volumio[761]: info: Ignoring MPD Status Update Jan 17 16:25:07 volumio volumio[761]: info: Jan 17 16:25:07 volumio volumio[761]: ---------------------------- MPD announces state update: player Jan 17 16:25:07 volumio volumio[761]: info: ControllerMpd::getState Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand status Jan 17 16:25:07 volumio volumio[761]: info: ------------------------------ 9ms Jan 17 16:25:07 volumio volumio[761]: info: sendMpdCommand status took 7 milliseconds Jan 17 16:25:07 volumio volumio[761]: info: ------------------------------ 6ms Jan 17 16:25:07 volumio volumio[761]: info: sendMpdCommand status took 5 milliseconds Jan 17 16:25:07 volumio volumio[761]: info: ------------------------------ 4ms Jan 17 16:25:07 volumio volumio[761]: info: sendMpdCommand status took 3 milliseconds Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::parseState Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 16:25:07 volumio volumio[761]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 17 16:25:07 volumio volumio[761]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 17 16:25:07 volumio volumio[761]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:07 volumio volumio[761]: verbose: ControllerMpd::parseTrackInfo Jan 17 16:25:07 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:07 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:07 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3735,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:07 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:07 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:07 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:07 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:07 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3735,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:07 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:07 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:07 volumio volumio[761]: info: ControllerMpd::pushState Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::servicePushState Jan 17 16:25:07 volumio volumio[761]: info: CorePlayQueue::getTrack 0 Jan 17 16:25:07 volumio volumio[761]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3735,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HARRY STYLES - ADORE YOU","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Jan 17 16:25:07 volumio volumio[761]: verbose: CURRENT POSITION 0 Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::syncState stateService play Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::syncState currentStatus play Jan 17 16:25:07 volumio volumio[761]: info: Received an update from plugin. extracting info from payload Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:07 volumio volumio[761]: info: CoreStateMachine::pushState Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::volumioPushState Jan 17 16:25:07 volumio volumio[761]: info: ------------------------------ 52ms Jan 17 16:25:07 volumio volumio[761]: info: ------------------------------ 50ms Jan 17 16:25:07 volumio volumio[761]: info: ------------------------------ 48ms Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 17 16:25:07 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 17 16:25:11 volumio volumio[761]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 16:25:11 volumio volumio[761]: info: Discoverable: true Jan 17 16:25:11 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:25:11 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:25:11 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:11 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:11 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:11 volumio volumio[761]: "payload": { Jan 17 16:25:11 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:11 volumio volumio[761]: "devices": [ Jan 17 16:25:11 volumio volumio[761]: { Jan 17 16:25:11 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:11 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:11 volumio volumio[761]: "signal": 65, Jan 17 16:25:11 volumio volumio[761]: "paired": "", Jan 17 16:25:11 volumio volumio[761]: "trusted": "", Jan 17 16:25:11 volumio volumio[761]: "icon": "", Jan 17 16:25:11 volumio volumio[761]: "class": "", Jan 17 16:25:11 volumio volumio[761]: "blocked": "", Jan 17 16:25:11 volumio volumio[761]: "connected": "", Jan 17 16:25:11 volumio volumio[761]: "trycount": 4 Jan 17 16:25:11 volumio volumio[761]: }, Jan 17 16:25:11 volumio volumio[761]: { Jan 17 16:25:11 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:11 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:11 volumio volumio[761]: "signal": 48, Jan 17 16:25:11 volumio volumio[761]: "paired": "", Jan 17 16:25:11 volumio volumio[761]: "trusted": "", Jan 17 16:25:11 volumio volumio[761]: "icon": "", Jan 17 16:25:11 volumio volumio[761]: "class": "", Jan 17 16:25:11 volumio volumio[761]: "blocked": "", Jan 17 16:25:11 volumio volumio[761]: "connected": "", Jan 17 16:25:11 volumio volumio[761]: "trycount": 4 Jan 17 16:25:11 volumio volumio[761]: }, Jan 17 16:25:11 volumio volumio[761]: { Jan 17 16:25:11 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:11 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:11 volumio volumio[761]: "signal": 0, Jan 17 16:25:11 volumio volumio[761]: "paired": "", Jan 17 16:25:11 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:11 volumio volumio[761]: "icon": "", Jan 17 16:25:11 volumio volumio[761]: "class": "", Jan 17 16:25:11 volumio volumio[761]: "blocked": "", Jan 17 16:25:11 volumio volumio[761]: "connected": "no", Jan 17 16:25:11 volumio volumio[761]: "trycount": 4 Jan 17 16:25:11 volumio volumio[761]: } Jan 17 16:25:11 volumio volumio[761]: ] Jan 17 16:25:11 volumio volumio[761]: } Jan 17 16:25:11 volumio volumio[761]: } Jan 17 16:25:15 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller connectBluetoothDevice [object Object] Jan 17 16:25:15 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , connectBluetoothDevice Jan 17 16:25:15 volumio volumio[761]: info: Connecting bluetooth device: 68:B6:91:A3:45:2A Jan 17 16:25:15 volumio volumio[761]: info: AVRCP: adding device: 68:B6:91:A3:45:2A Jan 17 16:25:15 volumio volumio[761]: info: known: { Jan 17 16:25:15 volumio volumio[761]: "F8:54:B8:4A:66:9A": { Jan 17 16:25:15 volumio volumio[761]: "virtualPath": "", Jan 17 16:25:15 volumio volumio[761]: "devicePath": "", Jan 17 16:25:15 volumio volumio[761]: "inputEvent": null, Jan 17 16:25:15 volumio volumio[761]: "keyboard": null Jan 17 16:25:15 volumio volumio[761]: }, Jan 17 16:25:15 volumio volumio[761]: "68:B6:91:A3:45:2A": { Jan 17 16:25:15 volumio volumio[761]: "virtualPath": "", Jan 17 16:25:15 volumio volumio[761]: "devicePath": "", Jan 17 16:25:15 volumio volumio[761]: "inputEvent": null, Jan 17 16:25:15 volumio volumio[761]: "keyboard": null Jan 17 16:25:15 volumio volumio[761]: } Jan 17 16:25:15 volumio volumio[761]: } Jan 17 16:25:15 volumio volumio[761]: info: known: true Jan 17 16:25:15 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:15 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:15 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:15 volumio volumio[761]: "payload": { Jan 17 16:25:15 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:15 volumio volumio[761]: "devices": [ Jan 17 16:25:15 volumio volumio[761]: { Jan 17 16:25:15 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:15 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:15 volumio volumio[761]: "signal": 65, Jan 17 16:25:15 volumio volumio[761]: "paired": "", Jan 17 16:25:15 volumio volumio[761]: "trusted": "", Jan 17 16:25:15 volumio volumio[761]: "icon": "", Jan 17 16:25:15 volumio volumio[761]: "class": "", Jan 17 16:25:15 volumio volumio[761]: "blocked": "", Jan 17 16:25:15 volumio volumio[761]: "connected": "", Jan 17 16:25:15 volumio volumio[761]: "trycount": 4 Jan 17 16:25:15 volumio volumio[761]: }, Jan 17 16:25:15 volumio volumio[761]: { Jan 17 16:25:15 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:15 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:15 volumio volumio[761]: "signal": 48, Jan 17 16:25:15 volumio volumio[761]: "paired": "", Jan 17 16:25:15 volumio volumio[761]: "trusted": "", Jan 17 16:25:15 volumio volumio[761]: "icon": "", Jan 17 16:25:15 volumio volumio[761]: "class": "", Jan 17 16:25:15 volumio volumio[761]: "blocked": "", Jan 17 16:25:15 volumio volumio[761]: "connected": "", Jan 17 16:25:15 volumio volumio[761]: "trycount": 4 Jan 17 16:25:15 volumio volumio[761]: }, Jan 17 16:25:15 volumio volumio[761]: { Jan 17 16:25:15 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:15 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:15 volumio volumio[761]: "signal": 0, Jan 17 16:25:15 volumio volumio[761]: "paired": "", Jan 17 16:25:15 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:15 volumio volumio[761]: "icon": "", Jan 17 16:25:15 volumio volumio[761]: "class": "", Jan 17 16:25:15 volumio volumio[761]: "blocked": "", Jan 17 16:25:15 volumio volumio[761]: "connected": "no", Jan 17 16:25:15 volumio volumio[761]: "trycount": 4 Jan 17 16:25:15 volumio volumio[761]: } Jan 17 16:25:15 volumio volumio[761]: ] Jan 17 16:25:15 volumio volumio[761]: } Jan 17 16:25:15 volumio volumio[761]: } Jan 17 16:25:15 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:25:15 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:25:15 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:15 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:15 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:15 volumio volumio[761]: "payload": { Jan 17 16:25:15 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:15 volumio volumio[761]: "devices": [ Jan 17 16:25:15 volumio volumio[761]: { Jan 17 16:25:15 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:15 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:15 volumio volumio[761]: "signal": 65, Jan 17 16:25:15 volumio volumio[761]: "paired": "", Jan 17 16:25:15 volumio volumio[761]: "trusted": "", Jan 17 16:25:15 volumio volumio[761]: "icon": "", Jan 17 16:25:15 volumio volumio[761]: "class": "", Jan 17 16:25:15 volumio volumio[761]: "blocked": "", Jan 17 16:25:15 volumio volumio[761]: "connected": "", Jan 17 16:25:15 volumio volumio[761]: "trycount": 4 Jan 17 16:25:15 volumio volumio[761]: }, Jan 17 16:25:15 volumio volumio[761]: { Jan 17 16:25:15 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:15 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:15 volumio volumio[761]: "signal": 48, Jan 17 16:25:15 volumio volumio[761]: "paired": "", Jan 17 16:25:15 volumio volumio[761]: "trusted": "", Jan 17 16:25:15 volumio volumio[761]: "icon": "", Jan 17 16:25:15 volumio volumio[761]: "class": "", Jan 17 16:25:15 volumio volumio[761]: "blocked": "", Jan 17 16:25:15 volumio volumio[761]: "connected": "", Jan 17 16:25:15 volumio volumio[761]: "trycount": 4 Jan 17 16:25:15 volumio volumio[761]: }, Jan 17 16:25:15 volumio volumio[761]: { Jan 17 16:25:15 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:15 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:15 volumio volumio[761]: "signal": 0, Jan 17 16:25:15 volumio volumio[761]: "paired": "", Jan 17 16:25:15 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:15 volumio volumio[761]: "icon": "", Jan 17 16:25:15 volumio volumio[761]: "class": "", Jan 17 16:25:15 volumio volumio[761]: "blocked": "", Jan 17 16:25:15 volumio volumio[761]: "connected": "no", Jan 17 16:25:15 volumio volumio[761]: "trycount": 4 Jan 17 16:25:15 volumio volumio[761]: } Jan 17 16:25:15 volumio volumio[761]: ] Jan 17 16:25:15 volumio volumio[761]: } Jan 17 16:25:15 volumio volumio[761]: } Jan 17 16:25:15 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 17 16:25:15 volumio volumio[761]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 17 16:25:15 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 17 16:25:15 volumio volumio[761]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Jan 17 16:25:15 volumio volumio[761]: info: Received Get System Version Jan 17 16:25:15 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 16:25:16 volumio bluetoothd[558]: 68:B6:91:A3:45:2A: error updating services: Connection refused (111) Jan 17 16:25:16 volumio volumio[761]: info: CoreCommandRouter::volumioGetState Jan 17 16:25:19 volumio ntpd[611]: Soliciting pool server 2001:ba0:20d:4200::1 Jan 17 16:25:20 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:25:20 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:25:20 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:20 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:20 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:20 volumio volumio[761]: "payload": { Jan 17 16:25:20 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:20 volumio volumio[761]: "devices": [ Jan 17 16:25:20 volumio volumio[761]: { Jan 17 16:25:20 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:20 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:20 volumio volumio[761]: "signal": 65, Jan 17 16:25:20 volumio volumio[761]: "paired": "", Jan 17 16:25:20 volumio volumio[761]: "trusted": "", Jan 17 16:25:20 volumio volumio[761]: "icon": "", Jan 17 16:25:20 volumio volumio[761]: "class": "", Jan 17 16:25:20 volumio volumio[761]: "blocked": "", Jan 17 16:25:20 volumio volumio[761]: "connected": "", Jan 17 16:25:20 volumio volumio[761]: "trycount": 4 Jan 17 16:25:20 volumio volumio[761]: }, Jan 17 16:25:20 volumio volumio[761]: { Jan 17 16:25:20 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:20 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:20 volumio volumio[761]: "signal": 48, Jan 17 16:25:20 volumio volumio[761]: "paired": "", Jan 17 16:25:20 volumio volumio[761]: "trusted": "", Jan 17 16:25:20 volumio volumio[761]: "icon": "", Jan 17 16:25:20 volumio volumio[761]: "class": "", Jan 17 16:25:20 volumio volumio[761]: "blocked": "", Jan 17 16:25:20 volumio volumio[761]: "connected": "", Jan 17 16:25:20 volumio volumio[761]: "trycount": 4 Jan 17 16:25:20 volumio volumio[761]: }, Jan 17 16:25:20 volumio volumio[761]: { Jan 17 16:25:20 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:20 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:20 volumio volumio[761]: "signal": 0, Jan 17 16:25:20 volumio volumio[761]: "paired": "", Jan 17 16:25:20 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:20 volumio volumio[761]: "icon": "", Jan 17 16:25:20 volumio volumio[761]: "class": "", Jan 17 16:25:20 volumio volumio[761]: "blocked": "", Jan 17 16:25:20 volumio volumio[761]: "connected": "no", Jan 17 16:25:20 volumio volumio[761]: "trycount": 4 Jan 17 16:25:20 volumio volumio[761]: } Jan 17 16:25:20 volumio volumio[761]: ] Jan 17 16:25:20 volumio volumio[761]: } Jan 17 16:25:20 volumio volumio[761]: } Jan 17 16:25:21 volumio ntpd[611]: Soliciting pool server 85.209.96.20 Jan 17 16:25:23 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller connectBluetoothDevice [object Object] Jan 17 16:25:23 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , connectBluetoothDevice Jan 17 16:25:23 volumio volumio[761]: info: Connecting bluetooth device: 68:B6:91:A3:45:2A Jan 17 16:25:23 volumio volumio[761]: info: AVRCP: adding device: 68:B6:91:A3:45:2A Jan 17 16:25:23 volumio volumio[761]: info: known: { Jan 17 16:25:23 volumio volumio[761]: "F8:54:B8:4A:66:9A": { Jan 17 16:25:23 volumio volumio[761]: "virtualPath": "", Jan 17 16:25:23 volumio volumio[761]: "devicePath": "", Jan 17 16:25:23 volumio volumio[761]: "inputEvent": null, Jan 17 16:25:23 volumio volumio[761]: "keyboard": null Jan 17 16:25:23 volumio volumio[761]: }, Jan 17 16:25:23 volumio volumio[761]: "68:B6:91:A3:45:2A": { Jan 17 16:25:23 volumio volumio[761]: "virtualPath": "", Jan 17 16:25:23 volumio volumio[761]: "devicePath": "", Jan 17 16:25:23 volumio volumio[761]: "inputEvent": null, Jan 17 16:25:23 volumio volumio[761]: "keyboard": null Jan 17 16:25:23 volumio volumio[761]: } Jan 17 16:25:23 volumio volumio[761]: } Jan 17 16:25:23 volumio volumio[761]: info: known: true Jan 17 16:25:23 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:23 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:23 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:23 volumio volumio[761]: "payload": { Jan 17 16:25:23 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:23 volumio volumio[761]: "devices": [ Jan 17 16:25:23 volumio volumio[761]: { Jan 17 16:25:23 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:23 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:23 volumio volumio[761]: "signal": 65, Jan 17 16:25:23 volumio volumio[761]: "paired": "", Jan 17 16:25:23 volumio volumio[761]: "trusted": "", Jan 17 16:25:23 volumio volumio[761]: "icon": "", Jan 17 16:25:23 volumio volumio[761]: "class": "", Jan 17 16:25:23 volumio volumio[761]: "blocked": "", Jan 17 16:25:23 volumio volumio[761]: "connected": "", Jan 17 16:25:23 volumio volumio[761]: "trycount": 4 Jan 17 16:25:23 volumio volumio[761]: }, Jan 17 16:25:23 volumio volumio[761]: { Jan 17 16:25:23 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:23 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:23 volumio volumio[761]: "signal": 48, Jan 17 16:25:23 volumio volumio[761]: "paired": "", Jan 17 16:25:23 volumio volumio[761]: "trusted": "", Jan 17 16:25:23 volumio volumio[761]: "icon": "", Jan 17 16:25:23 volumio volumio[761]: "class": "", Jan 17 16:25:23 volumio volumio[761]: "blocked": "", Jan 17 16:25:23 volumio volumio[761]: "connected": "", Jan 17 16:25:23 volumio volumio[761]: "trycount": 4 Jan 17 16:25:23 volumio volumio[761]: }, Jan 17 16:25:23 volumio volumio[761]: { Jan 17 16:25:23 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:23 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:23 volumio volumio[761]: "signal": 0, Jan 17 16:25:23 volumio volumio[761]: "paired": "", Jan 17 16:25:23 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:23 volumio volumio[761]: "icon": "", Jan 17 16:25:23 volumio volumio[761]: "class": "", Jan 17 16:25:23 volumio volumio[761]: "blocked": "", Jan 17 16:25:23 volumio volumio[761]: "connected": "no", Jan 17 16:25:23 volumio volumio[761]: "trycount": 4 Jan 17 16:25:23 volumio volumio[761]: } Jan 17 16:25:23 volumio volumio[761]: ] Jan 17 16:25:23 volumio volumio[761]: } Jan 17 16:25:23 volumio volumio[761]: } Jan 17 16:25:23 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:25:23 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:25:23 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:23 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:23 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:23 volumio volumio[761]: "payload": { Jan 17 16:25:23 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:23 volumio volumio[761]: "devices": [ Jan 17 16:25:23 volumio volumio[761]: { Jan 17 16:25:23 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:23 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:23 volumio volumio[761]: "signal": 65, Jan 17 16:25:23 volumio volumio[761]: "paired": "", Jan 17 16:25:23 volumio volumio[761]: "trusted": "", Jan 17 16:25:23 volumio volumio[761]: "icon": "", Jan 17 16:25:23 volumio volumio[761]: "class": "", Jan 17 16:25:23 volumio volumio[761]: "blocked": "", Jan 17 16:25:23 volumio volumio[761]: "connected": "", Jan 17 16:25:23 volumio volumio[761]: "trycount": 4 Jan 17 16:25:23 volumio volumio[761]: }, Jan 17 16:25:23 volumio volumio[761]: { Jan 17 16:25:23 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:23 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:23 volumio volumio[761]: "signal": 48, Jan 17 16:25:23 volumio volumio[761]: "paired": "", Jan 17 16:25:23 volumio volumio[761]: "trusted": "", Jan 17 16:25:23 volumio volumio[761]: "icon": "", Jan 17 16:25:23 volumio volumio[761]: "class": "", Jan 17 16:25:23 volumio volumio[761]: "blocked": "", Jan 17 16:25:23 volumio volumio[761]: "connected": "", Jan 17 16:25:23 volumio volumio[761]: "trycount": 4 Jan 17 16:25:23 volumio volumio[761]: }, Jan 17 16:25:23 volumio volumio[761]: { Jan 17 16:25:23 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:23 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:23 volumio volumio[761]: "signal": 0, Jan 17 16:25:23 volumio volumio[761]: "paired": "", Jan 17 16:25:23 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:23 volumio volumio[761]: "icon": "", Jan 17 16:25:23 volumio volumio[761]: "class": "", Jan 17 16:25:23 volumio volumio[761]: "blocked": "", Jan 17 16:25:23 volumio volumio[761]: "connected": "no", Jan 17 16:25:23 volumio volumio[761]: "trycount": 4 Jan 17 16:25:23 volumio volumio[761]: } Jan 17 16:25:23 volumio volumio[761]: ] Jan 17 16:25:23 volumio volumio[761]: } Jan 17 16:25:23 volumio volumio[761]: } Jan 17 16:25:23 volumio bluetoothd[558]: 68:B6:91:A3:45:2A: error updating services: Connection refused (111) Jan 17 16:25:26 volumio volumio[761]: info: CoreCommandRouter::volumioGetState Jan 17 16:25:26 volumio volumio[761]: info: Listing playlists Jan 17 16:25:29 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:25:29 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:25:29 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:29 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:29 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:29 volumio volumio[761]: "payload": { Jan 17 16:25:29 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:29 volumio volumio[761]: "devices": [ Jan 17 16:25:29 volumio volumio[761]: { Jan 17 16:25:29 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:29 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:29 volumio volumio[761]: "signal": 65, Jan 17 16:25:29 volumio volumio[761]: "paired": "", Jan 17 16:25:29 volumio volumio[761]: "trusted": "", Jan 17 16:25:29 volumio volumio[761]: "icon": "", Jan 17 16:25:29 volumio volumio[761]: "class": "", Jan 17 16:25:29 volumio volumio[761]: "blocked": "", Jan 17 16:25:29 volumio volumio[761]: "connected": "", Jan 17 16:25:29 volumio volumio[761]: "trycount": 4 Jan 17 16:25:29 volumio volumio[761]: }, Jan 17 16:25:29 volumio volumio[761]: { Jan 17 16:25:29 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:29 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:29 volumio volumio[761]: "signal": 48, Jan 17 16:25:29 volumio volumio[761]: "paired": "", Jan 17 16:25:29 volumio volumio[761]: "trusted": "", Jan 17 16:25:29 volumio volumio[761]: "icon": "", Jan 17 16:25:29 volumio volumio[761]: "class": "", Jan 17 16:25:29 volumio volumio[761]: "blocked": "", Jan 17 16:25:29 volumio volumio[761]: "connected": "", Jan 17 16:25:29 volumio volumio[761]: "trycount": 4 Jan 17 16:25:29 volumio volumio[761]: }, Jan 17 16:25:29 volumio volumio[761]: { Jan 17 16:25:29 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:29 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:29 volumio volumio[761]: "signal": 0, Jan 17 16:25:29 volumio volumio[761]: "paired": "", Jan 17 16:25:29 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:29 volumio volumio[761]: "icon": "", Jan 17 16:25:29 volumio volumio[761]: "class": "", Jan 17 16:25:29 volumio volumio[761]: "blocked": "", Jan 17 16:25:29 volumio volumio[761]: "connected": "no", Jan 17 16:25:29 volumio volumio[761]: "trycount": 4 Jan 17 16:25:29 volumio volumio[761]: } Jan 17 16:25:29 volumio volumio[761]: ] Jan 17 16:25:29 volumio volumio[761]: } Jan 17 16:25:29 volumio volumio[761]: } Jan 17 16:25:31 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:32 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller connectBluetoothDevice [object Object] Jan 17 16:25:32 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , connectBluetoothDevice Jan 17 16:25:32 volumio volumio[761]: info: Connecting bluetooth device: 68:B6:91:A3:45:2A Jan 17 16:25:32 volumio volumio[761]: info: AVRCP: adding device: 68:B6:91:A3:45:2A Jan 17 16:25:32 volumio volumio[761]: info: known: { Jan 17 16:25:32 volumio volumio[761]: "F8:54:B8:4A:66:9A": { Jan 17 16:25:32 volumio volumio[761]: "virtualPath": "", Jan 17 16:25:32 volumio volumio[761]: "devicePath": "", Jan 17 16:25:32 volumio volumio[761]: "inputEvent": null, Jan 17 16:25:32 volumio volumio[761]: "keyboard": null Jan 17 16:25:32 volumio volumio[761]: }, Jan 17 16:25:32 volumio volumio[761]: "68:B6:91:A3:45:2A": { Jan 17 16:25:32 volumio volumio[761]: "virtualPath": "", Jan 17 16:25:32 volumio volumio[761]: "devicePath": "", Jan 17 16:25:32 volumio volumio[761]: "inputEvent": null, Jan 17 16:25:32 volumio volumio[761]: "keyboard": null Jan 17 16:25:32 volumio volumio[761]: } Jan 17 16:25:32 volumio volumio[761]: } Jan 17 16:25:32 volumio volumio[761]: info: known: true Jan 17 16:25:32 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:32 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:32 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:32 volumio volumio[761]: "payload": { Jan 17 16:25:32 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:32 volumio volumio[761]: "devices": [ Jan 17 16:25:32 volumio volumio[761]: { Jan 17 16:25:32 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:32 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:32 volumio volumio[761]: "signal": 65, Jan 17 16:25:32 volumio volumio[761]: "paired": "", Jan 17 16:25:32 volumio volumio[761]: "trusted": "", Jan 17 16:25:32 volumio volumio[761]: "icon": "", Jan 17 16:25:32 volumio volumio[761]: "class": "", Jan 17 16:25:32 volumio volumio[761]: "blocked": "", Jan 17 16:25:32 volumio volumio[761]: "connected": "", Jan 17 16:25:32 volumio volumio[761]: "trycount": 4 Jan 17 16:25:32 volumio volumio[761]: }, Jan 17 16:25:32 volumio volumio[761]: { Jan 17 16:25:32 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:32 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:32 volumio volumio[761]: "signal": 48, Jan 17 16:25:32 volumio volumio[761]: "paired": "", Jan 17 16:25:32 volumio volumio[761]: "trusted": "", Jan 17 16:25:32 volumio volumio[761]: "icon": "", Jan 17 16:25:32 volumio volumio[761]: "class": "", Jan 17 16:25:32 volumio volumio[761]: "blocked": "", Jan 17 16:25:32 volumio volumio[761]: "connected": "", Jan 17 16:25:32 volumio volumio[761]: "trycount": 4 Jan 17 16:25:32 volumio volumio[761]: }, Jan 17 16:25:32 volumio volumio[761]: { Jan 17 16:25:32 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:32 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:32 volumio volumio[761]: "signal": 0, Jan 17 16:25:32 volumio volumio[761]: "paired": "", Jan 17 16:25:32 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:32 volumio volumio[761]: "icon": "", Jan 17 16:25:32 volumio volumio[761]: "class": "", Jan 17 16:25:32 volumio volumio[761]: "blocked": "", Jan 17 16:25:32 volumio volumio[761]: "connected": "no", Jan 17 16:25:32 volumio volumio[761]: "trycount": 4 Jan 17 16:25:32 volumio volumio[761]: } Jan 17 16:25:32 volumio volumio[761]: ] Jan 17 16:25:32 volumio volumio[761]: } Jan 17 16:25:32 volumio volumio[761]: } Jan 17 16:25:32 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:25:32 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:25:32 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:32 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:32 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:32 volumio volumio[761]: "payload": { Jan 17 16:25:32 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:32 volumio volumio[761]: "devices": [ Jan 17 16:25:32 volumio volumio[761]: { Jan 17 16:25:32 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:32 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:32 volumio volumio[761]: "signal": 65, Jan 17 16:25:32 volumio volumio[761]: "paired": "", Jan 17 16:25:32 volumio volumio[761]: "trusted": "", Jan 17 16:25:32 volumio volumio[761]: "icon": "", Jan 17 16:25:32 volumio volumio[761]: "class": "", Jan 17 16:25:32 volumio volumio[761]: "blocked": "", Jan 17 16:25:32 volumio volumio[761]: "connected": "", Jan 17 16:25:32 volumio volumio[761]: "trycount": 4 Jan 17 16:25:32 volumio volumio[761]: }, Jan 17 16:25:32 volumio volumio[761]: { Jan 17 16:25:32 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:32 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:32 volumio volumio[761]: "signal": 48, Jan 17 16:25:32 volumio volumio[761]: "paired": "", Jan 17 16:25:32 volumio volumio[761]: "trusted": "", Jan 17 16:25:32 volumio volumio[761]: "icon": "", Jan 17 16:25:32 volumio volumio[761]: "class": "", Jan 17 16:25:32 volumio volumio[761]: "blocked": "", Jan 17 16:25:32 volumio volumio[761]: "connected": "", Jan 17 16:25:32 volumio volumio[761]: "trycount": 4 Jan 17 16:25:32 volumio volumio[761]: }, Jan 17 16:25:32 volumio volumio[761]: { Jan 17 16:25:32 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:32 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:32 volumio volumio[761]: "signal": 0, Jan 17 16:25:32 volumio volumio[761]: "paired": "", Jan 17 16:25:32 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:32 volumio volumio[761]: "icon": "", Jan 17 16:25:32 volumio volumio[761]: "class": "", Jan 17 16:25:32 volumio volumio[761]: "blocked": "", Jan 17 16:25:32 volumio volumio[761]: "connected": "no", Jan 17 16:25:32 volumio volumio[761]: "trycount": 4 Jan 17 16:25:32 volumio volumio[761]: } Jan 17 16:25:32 volumio volumio[761]: ] Jan 17 16:25:32 volumio volumio[761]: } Jan 17 16:25:32 volumio volumio[761]: } Jan 17 16:25:32 volumio bluetoothd[558]: 68:B6:91:A3:45:2A: error updating services: Connection refused (111) Jan 17 16:25:35 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:35 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:35 volumio sudo[2002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 16:25:35 volumio sudo[2002]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 16:25:35 volumio sudo[2002]: pam_unix(sudo:session): session closed for user root Jan 17 16:25:35 volumio sudo[2004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 16:25:35 volumio sudo[2004]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 16:25:35 volumio sudo[2004]: pam_unix(sudo:session): session closed for user root Jan 17 16:25:35 volumio volumio[761]: verbose: New Socket.io Connection to 192.168.0.2 from 192.168.0.30 UA: Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 OPR/95.0.0.0 Total Clients: 4 Jan 17 16:25:35 volumio volumio[761]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 16:25:35 volumio volumio[761]: info: Discoverable: true Jan 17 16:25:35 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 17 16:25:35 volumio volumio[761]: info: CoreCommandRouter::volumioGetState Jan 17 16:25:35 volumio volumio[761]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 16:25:35 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 16:25:35 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 17 16:25:35 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 17 16:25:35 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 17 16:25:35 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 17 16:25:35 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:25:35 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:25:35 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:35 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:35 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:35 volumio volumio[761]: "payload": { Jan 17 16:25:35 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:35 volumio volumio[761]: "devices": [ Jan 17 16:25:35 volumio volumio[761]: { Jan 17 16:25:35 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:35 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:35 volumio volumio[761]: "signal": 65, Jan 17 16:25:35 volumio volumio[761]: "paired": "", Jan 17 16:25:35 volumio volumio[761]: "trusted": "", Jan 17 16:25:35 volumio volumio[761]: "icon": "", Jan 17 16:25:35 volumio volumio[761]: "class": "", Jan 17 16:25:35 volumio volumio[761]: "blocked": "", Jan 17 16:25:35 volumio volumio[761]: "connected": "", Jan 17 16:25:35 volumio volumio[761]: "trycount": 4 Jan 17 16:25:35 volumio volumio[761]: }, Jan 17 16:25:35 volumio volumio[761]: { Jan 17 16:25:35 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:35 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:35 volumio volumio[761]: "signal": 48, Jan 17 16:25:35 volumio volumio[761]: "paired": "", Jan 17 16:25:35 volumio volumio[761]: "trusted": "", Jan 17 16:25:35 volumio volumio[761]: "icon": "", Jan 17 16:25:35 volumio volumio[761]: "class": "", Jan 17 16:25:35 volumio volumio[761]: "blocked": "", Jan 17 16:25:35 volumio volumio[761]: "connected": "", Jan 17 16:25:35 volumio volumio[761]: "trycount": 4 Jan 17 16:25:35 volumio volumio[761]: }, Jan 17 16:25:35 volumio volumio[761]: { Jan 17 16:25:35 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:35 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:35 volumio volumio[761]: "signal": 0, Jan 17 16:25:35 volumio volumio[761]: "paired": "", Jan 17 16:25:35 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:35 volumio volumio[761]: "icon": "", Jan 17 16:25:35 volumio volumio[761]: "class": "", Jan 17 16:25:35 volumio volumio[761]: "blocked": "", Jan 17 16:25:35 volumio volumio[761]: "connected": "no", Jan 17 16:25:35 volumio volumio[761]: "trycount": 4 Jan 17 16:25:35 volumio volumio[761]: } Jan 17 16:25:35 volumio volumio[761]: ] Jan 17 16:25:35 volumio volumio[761]: } Jan 17 16:25:35 volumio volumio[761]: } Jan 17 16:25:36 volumio volumio[761]: info: CoreCommandRouter::volumioGetState Jan 17 16:25:38 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 17 16:25:38 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller connectBluetoothDevice [object Object] Jan 17 16:25:38 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , connectBluetoothDevice Jan 17 16:25:38 volumio volumio[761]: info: Connecting bluetooth device: 68:B6:91:A3:45:2A Jan 17 16:25:38 volumio volumio[761]: info: AVRCP: adding device: 68:B6:91:A3:45:2A Jan 17 16:25:38 volumio volumio[761]: info: known: { Jan 17 16:25:38 volumio volumio[761]: "F8:54:B8:4A:66:9A": { Jan 17 16:25:38 volumio volumio[761]: "virtualPath": "", Jan 17 16:25:38 volumio volumio[761]: "devicePath": "", Jan 17 16:25:38 volumio volumio[761]: "inputEvent": null, Jan 17 16:25:38 volumio volumio[761]: "keyboard": null Jan 17 16:25:38 volumio volumio[761]: }, Jan 17 16:25:38 volumio volumio[761]: "68:B6:91:A3:45:2A": { Jan 17 16:25:38 volumio volumio[761]: "virtualPath": "", Jan 17 16:25:38 volumio volumio[761]: "devicePath": "", Jan 17 16:25:38 volumio volumio[761]: "inputEvent": null, Jan 17 16:25:38 volumio volumio[761]: "keyboard": null Jan 17 16:25:38 volumio volumio[761]: } Jan 17 16:25:38 volumio volumio[761]: } Jan 17 16:25:38 volumio volumio[761]: info: known: true Jan 17 16:25:38 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:38 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:38 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:38 volumio volumio[761]: "payload": { Jan 17 16:25:38 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:38 volumio volumio[761]: "devices": [ Jan 17 16:25:38 volumio volumio[761]: { Jan 17 16:25:38 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:38 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:38 volumio volumio[761]: "signal": 65, Jan 17 16:25:38 volumio volumio[761]: "paired": "", Jan 17 16:25:38 volumio volumio[761]: "trusted": "", Jan 17 16:25:38 volumio volumio[761]: "icon": "", Jan 17 16:25:38 volumio volumio[761]: "class": "", Jan 17 16:25:38 volumio volumio[761]: "blocked": "", Jan 17 16:25:38 volumio volumio[761]: "connected": "", Jan 17 16:25:38 volumio volumio[761]: "trycount": 4 Jan 17 16:25:38 volumio volumio[761]: }, Jan 17 16:25:38 volumio volumio[761]: { Jan 17 16:25:38 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:38 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:38 volumio volumio[761]: "signal": 48, Jan 17 16:25:38 volumio volumio[761]: "paired": "", Jan 17 16:25:38 volumio volumio[761]: "trusted": "", Jan 17 16:25:38 volumio volumio[761]: "icon": "", Jan 17 16:25:38 volumio volumio[761]: "class": "", Jan 17 16:25:38 volumio volumio[761]: "blocked": "", Jan 17 16:25:38 volumio volumio[761]: "connected": "", Jan 17 16:25:38 volumio volumio[761]: "trycount": 4 Jan 17 16:25:38 volumio volumio[761]: }, Jan 17 16:25:38 volumio volumio[761]: { Jan 17 16:25:38 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:38 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:38 volumio volumio[761]: "signal": 0, Jan 17 16:25:38 volumio volumio[761]: "paired": "", Jan 17 16:25:38 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:38 volumio volumio[761]: "icon": "", Jan 17 16:25:38 volumio volumio[761]: "class": "", Jan 17 16:25:38 volumio volumio[761]: "blocked": "", Jan 17 16:25:38 volumio volumio[761]: "connected": "no", Jan 17 16:25:38 volumio volumio[761]: "trycount": 4 Jan 17 16:25:38 volumio volumio[761]: } Jan 17 16:25:38 volumio volumio[761]: ] Jan 17 16:25:38 volumio volumio[761]: } Jan 17 16:25:38 volumio volumio[761]: } Jan 17 16:25:38 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:25:38 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:25:38 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:38 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:38 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:38 volumio volumio[761]: "payload": { Jan 17 16:25:38 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:38 volumio volumio[761]: "devices": [ Jan 17 16:25:38 volumio volumio[761]: { Jan 17 16:25:38 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:38 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:38 volumio volumio[761]: "signal": 65, Jan 17 16:25:38 volumio volumio[761]: "paired": "", Jan 17 16:25:38 volumio volumio[761]: "trusted": "", Jan 17 16:25:38 volumio volumio[761]: "icon": "", Jan 17 16:25:38 volumio volumio[761]: "class": "", Jan 17 16:25:38 volumio volumio[761]: "blocked": "", Jan 17 16:25:38 volumio volumio[761]: "connected": "", Jan 17 16:25:38 volumio volumio[761]: "trycount": 4 Jan 17 16:25:38 volumio volumio[761]: }, Jan 17 16:25:38 volumio volumio[761]: { Jan 17 16:25:38 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:38 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:38 volumio volumio[761]: "signal": 48, Jan 17 16:25:38 volumio volumio[761]: "paired": "", Jan 17 16:25:38 volumio volumio[761]: "trusted": "", Jan 17 16:25:38 volumio volumio[761]: "icon": "", Jan 17 16:25:38 volumio volumio[761]: "class": "", Jan 17 16:25:38 volumio volumio[761]: "blocked": "", Jan 17 16:25:38 volumio volumio[761]: "connected": "", Jan 17 16:25:38 volumio volumio[761]: "trycount": 4 Jan 17 16:25:38 volumio volumio[761]: }, Jan 17 16:25:38 volumio volumio[761]: { Jan 17 16:25:38 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:38 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:38 volumio volumio[761]: "signal": 0, Jan 17 16:25:38 volumio volumio[761]: "paired": "", Jan 17 16:25:38 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:38 volumio volumio[761]: "icon": "", Jan 17 16:25:38 volumio volumio[761]: "class": "", Jan 17 16:25:38 volumio volumio[761]: "blocked": "", Jan 17 16:25:38 volumio volumio[761]: "connected": "no", Jan 17 16:25:38 volumio volumio[761]: "trycount": 4 Jan 17 16:25:38 volumio volumio[761]: } Jan 17 16:25:38 volumio volumio[761]: ] Jan 17 16:25:38 volumio volumio[761]: } Jan 17 16:25:38 volumio volumio[761]: } Jan 17 16:25:38 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 17 16:25:40 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:25:40 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:25:40 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:40 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:40 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:40 volumio volumio[761]: "payload": { Jan 17 16:25:40 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:40 volumio volumio[761]: "devices": [ Jan 17 16:25:40 volumio volumio[761]: { Jan 17 16:25:40 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:40 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:40 volumio volumio[761]: "signal": 65, Jan 17 16:25:40 volumio volumio[761]: "paired": "", Jan 17 16:25:40 volumio volumio[761]: "trusted": "", Jan 17 16:25:40 volumio volumio[761]: "icon": "", Jan 17 16:25:40 volumio volumio[761]: "class": "", Jan 17 16:25:40 volumio volumio[761]: "blocked": "", Jan 17 16:25:40 volumio volumio[761]: "connected": "", Jan 17 16:25:40 volumio volumio[761]: "trycount": 4 Jan 17 16:25:40 volumio volumio[761]: }, Jan 17 16:25:40 volumio volumio[761]: { Jan 17 16:25:40 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:40 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:40 volumio volumio[761]: "signal": 48, Jan 17 16:25:40 volumio volumio[761]: "paired": "", Jan 17 16:25:40 volumio volumio[761]: "trusted": "", Jan 17 16:25:40 volumio volumio[761]: "icon": "", Jan 17 16:25:40 volumio volumio[761]: "class": "", Jan 17 16:25:40 volumio volumio[761]: "blocked": "", Jan 17 16:25:40 volumio volumio[761]: "connected": "", Jan 17 16:25:40 volumio volumio[761]: "trycount": 4 Jan 17 16:25:40 volumio volumio[761]: }, Jan 17 16:25:40 volumio volumio[761]: { Jan 17 16:25:40 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:40 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:40 volumio volumio[761]: "signal": 0, Jan 17 16:25:40 volumio volumio[761]: "paired": "", Jan 17 16:25:40 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:40 volumio volumio[761]: "icon": "", Jan 17 16:25:40 volumio volumio[761]: "class": "", Jan 17 16:25:40 volumio volumio[761]: "blocked": "", Jan 17 16:25:40 volumio volumio[761]: "connected": "no", Jan 17 16:25:40 volumio volumio[761]: "trycount": 4 Jan 17 16:25:40 volumio volumio[761]: } Jan 17 16:25:40 volumio volumio[761]: ] Jan 17 16:25:40 volumio volumio[761]: } Jan 17 16:25:40 volumio volumio[761]: } Jan 17 16:25:40 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:41 volumio bluetoothd[558]: 68:B6:91:A3:45:2A: error updating services: Connection refused (111) Jan 17 16:25:43 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:43 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:46 volumio volumio[761]: info: CoreCommandRouter::volumioGetState Jan 17 16:25:46 volumio volumio[761]: info: Listing playlists Jan 17 16:25:46 volumio volumio[761]: info: Listing playlists Jan 17 16:25:49 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:52 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:52 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:52 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 17 16:25:52 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 17 16:25:53 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 17 16:25:53 volumio volumio[761]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 17 16:25:53 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 17 16:25:53 volumio volumio[761]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Jan 17 16:25:53 volumio volumio[761]: info: Received Get System Version Jan 17 16:25:53 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 16:25:55 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:56 volumio volumio[761]: info: CoreCommandRouter::volumioGetState Jan 17 16:25:58 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:58 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:25:59 volumio volumio[761]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 16:25:59 volumio volumio[761]: info: Discoverable: true Jan 17 16:25:59 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:25:59 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:25:59 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:25:59 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:25:59 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:25:59 volumio volumio[761]: "payload": { Jan 17 16:25:59 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:25:59 volumio volumio[761]: "devices": [ Jan 17 16:25:59 volumio volumio[761]: { Jan 17 16:25:59 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:25:59 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:25:59 volumio volumio[761]: "signal": 65, Jan 17 16:25:59 volumio volumio[761]: "paired": "", Jan 17 16:25:59 volumio volumio[761]: "trusted": "", Jan 17 16:25:59 volumio volumio[761]: "icon": "", Jan 17 16:25:59 volumio volumio[761]: "class": "", Jan 17 16:25:59 volumio volumio[761]: "blocked": "", Jan 17 16:25:59 volumio volumio[761]: "connected": "", Jan 17 16:25:59 volumio volumio[761]: "trycount": 4 Jan 17 16:25:59 volumio volumio[761]: }, Jan 17 16:25:59 volumio volumio[761]: { Jan 17 16:25:59 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:25:59 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:25:59 volumio volumio[761]: "signal": 48, Jan 17 16:25:59 volumio volumio[761]: "paired": "", Jan 17 16:25:59 volumio volumio[761]: "trusted": "", Jan 17 16:25:59 volumio volumio[761]: "icon": "", Jan 17 16:25:59 volumio volumio[761]: "class": "", Jan 17 16:25:59 volumio volumio[761]: "blocked": "", Jan 17 16:25:59 volumio volumio[761]: "connected": "", Jan 17 16:25:59 volumio volumio[761]: "trycount": 4 Jan 17 16:25:59 volumio volumio[761]: }, Jan 17 16:25:59 volumio volumio[761]: { Jan 17 16:25:59 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:25:59 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:25:59 volumio volumio[761]: "signal": 0, Jan 17 16:25:59 volumio volumio[761]: "paired": "", Jan 17 16:25:59 volumio volumio[761]: "trusted": "yes", Jan 17 16:25:59 volumio volumio[761]: "icon": "", Jan 17 16:25:59 volumio volumio[761]: "class": "", Jan 17 16:25:59 volumio volumio[761]: "blocked": "", Jan 17 16:25:59 volumio volumio[761]: "connected": "no", Jan 17 16:25:59 volumio volumio[761]: "trycount": 4 Jan 17 16:25:59 volumio volumio[761]: } Jan 17 16:25:59 volumio volumio[761]: ] Jan 17 16:25:59 volumio volumio[761]: } Jan 17 16:25:59 volumio volumio[761]: } Jan 17 16:26:00 volumio volumio[761]: info: Stopping bluetooth device scan Jan 17 16:26:02 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller connectBluetoothDevice [object Object] Jan 17 16:26:02 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , connectBluetoothDevice Jan 17 16:26:02 volumio volumio[761]: info: Connecting bluetooth device: 68:B6:91:A3:45:2A Jan 17 16:26:02 volumio volumio[761]: error: Failed callmethod call: TypeError: Cannot read property 'addDevice' of undefined Jan 17 16:26:02 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:26:02 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:26:02 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:26:02 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:26:02 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:26:02 volumio volumio[761]: "payload": { Jan 17 16:26:02 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:26:02 volumio volumio[761]: "devices": [ Jan 17 16:26:02 volumio volumio[761]: { Jan 17 16:26:02 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:26:02 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:26:02 volumio volumio[761]: "signal": 65, Jan 17 16:26:02 volumio volumio[761]: "paired": "", Jan 17 16:26:02 volumio volumio[761]: "trusted": "", Jan 17 16:26:02 volumio volumio[761]: "icon": "", Jan 17 16:26:02 volumio volumio[761]: "class": "", Jan 17 16:26:02 volumio volumio[761]: "blocked": "", Jan 17 16:26:02 volumio volumio[761]: "connected": "", Jan 17 16:26:02 volumio volumio[761]: "trycount": 4 Jan 17 16:26:02 volumio volumio[761]: }, Jan 17 16:26:02 volumio volumio[761]: { Jan 17 16:26:02 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:26:02 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:26:02 volumio volumio[761]: "signal": 48, Jan 17 16:26:02 volumio volumio[761]: "paired": "", Jan 17 16:26:02 volumio volumio[761]: "trusted": "", Jan 17 16:26:02 volumio volumio[761]: "icon": "", Jan 17 16:26:02 volumio volumio[761]: "class": "", Jan 17 16:26:02 volumio volumio[761]: "blocked": "", Jan 17 16:26:02 volumio volumio[761]: "connected": "", Jan 17 16:26:02 volumio volumio[761]: "trycount": 4 Jan 17 16:26:02 volumio volumio[761]: }, Jan 17 16:26:02 volumio volumio[761]: { Jan 17 16:26:02 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:26:02 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:26:02 volumio volumio[761]: "signal": 0, Jan 17 16:26:02 volumio volumio[761]: "paired": "", Jan 17 16:26:02 volumio volumio[761]: "trusted": "yes", Jan 17 16:26:02 volumio volumio[761]: "icon": "", Jan 17 16:26:02 volumio volumio[761]: "class": "", Jan 17 16:26:02 volumio volumio[761]: "blocked": "", Jan 17 16:26:02 volumio volumio[761]: "connected": "no", Jan 17 16:26:02 volumio volumio[761]: "trycount": 4 Jan 17 16:26:02 volumio volumio[761]: } Jan 17 16:26:02 volumio volumio[761]: ] Jan 17 16:26:02 volumio volumio[761]: } Jan 17 16:26:02 volumio volumio[761]: } Jan 17 16:26:03 volumio bluetoothd[558]: 68:B6:91:A3:45:2A: error updating services: Connection refused (111) Jan 17 16:26:03 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:26:03 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:26:03 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:26:03 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:26:03 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:26:03 volumio volumio[761]: "payload": { Jan 17 16:26:03 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:26:03 volumio volumio[761]: "devices": [ Jan 17 16:26:03 volumio volumio[761]: { Jan 17 16:26:03 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:26:03 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:26:03 volumio volumio[761]: "signal": 65, Jan 17 16:26:03 volumio volumio[761]: "paired": "", Jan 17 16:26:03 volumio volumio[761]: "trusted": "", Jan 17 16:26:03 volumio volumio[761]: "icon": "", Jan 17 16:26:03 volumio volumio[761]: "class": "", Jan 17 16:26:03 volumio volumio[761]: "blocked": "", Jan 17 16:26:03 volumio volumio[761]: "connected": "", Jan 17 16:26:03 volumio volumio[761]: "trycount": 4 Jan 17 16:26:03 volumio volumio[761]: }, Jan 17 16:26:03 volumio volumio[761]: { Jan 17 16:26:03 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:26:03 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:26:03 volumio volumio[761]: "signal": 48, Jan 17 16:26:03 volumio volumio[761]: "paired": "", Jan 17 16:26:03 volumio volumio[761]: "trusted": "", Jan 17 16:26:03 volumio volumio[761]: "icon": "", Jan 17 16:26:03 volumio volumio[761]: "class": "", Jan 17 16:26:03 volumio volumio[761]: "blocked": "", Jan 17 16:26:03 volumio volumio[761]: "connected": "", Jan 17 16:26:03 volumio volumio[761]: "trycount": 4 Jan 17 16:26:03 volumio volumio[761]: }, Jan 17 16:26:03 volumio volumio[761]: { Jan 17 16:26:03 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:26:03 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:26:03 volumio volumio[761]: "signal": 0, Jan 17 16:26:03 volumio volumio[761]: "paired": "", Jan 17 16:26:03 volumio volumio[761]: "trusted": "yes", Jan 17 16:26:03 volumio volumio[761]: "icon": "", Jan 17 16:26:03 volumio volumio[761]: "class": "", Jan 17 16:26:03 volumio volumio[761]: "blocked": "", Jan 17 16:26:03 volumio volumio[761]: "connected": "no", Jan 17 16:26:03 volumio volumio[761]: "trycount": 4 Jan 17 16:26:03 volumio volumio[761]: } Jan 17 16:26:03 volumio volumio[761]: ] Jan 17 16:26:03 volumio volumio[761]: } Jan 17 16:26:03 volumio volumio[761]: } Jan 17 16:26:06 volumio volumio[761]: info: CoreCommandRouter::volumioGetState Jan 17 16:26:06 volumio volumio[761]: info: Listing playlists Jan 17 16:26:06 volumio volumio[761]: info: Listing playlists Jan 17 16:26:06 volumio volumio[761]: info: CALLMETHOD: audio_interface bluetooth_controller getBluetoothDevices [object Object] Jan 17 16:26:06 volumio volumio[761]: info: CoreCommandRouter::executeOnPlugin: bluetooth_controller , getBluetoothDevices Jan 17 16:26:06 volumio volumio[761]: info: Starting bluetooth device scan Jan 17 16:26:06 volumio volumio[761]: info: Found bluetooth devices: { Jan 17 16:26:06 volumio volumio[761]: "message": "pushBluetoothDevices", Jan 17 16:26:06 volumio volumio[761]: "payload": { Jan 17 16:26:06 volumio volumio[761]: "hasBluetooth": true, Jan 17 16:26:06 volumio volumio[761]: "devices": [ Jan 17 16:26:06 volumio volumio[761]: { Jan 17 16:26:06 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:26:06 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:26:06 volumio volumio[761]: "signal": 65, Jan 17 16:26:06 volumio volumio[761]: "paired": "", Jan 17 16:26:06 volumio volumio[761]: "trusted": "", Jan 17 16:26:06 volumio volumio[761]: "icon": "", Jan 17 16:26:06 volumio volumio[761]: "class": "", Jan 17 16:26:06 volumio volumio[761]: "blocked": "", Jan 17 16:26:06 volumio volumio[761]: "connected": "", Jan 17 16:26:06 volumio volumio[761]: "trycount": 4 Jan 17 16:26:06 volumio volumio[761]: }, Jan 17 16:26:06 volumio volumio[761]: { Jan 17 16:26:06 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:26:06 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:26:06 volumio volumio[761]: "signal": 48, Jan 17 16:26:06 volumio volumio[761]: "paired": "", Jan 17 16:26:06 volumio volumio[761]: "trusted": "", Jan 17 16:26:06 volumio volumio[761]: "icon": "", Jan 17 16:26:06 volumio volumio[761]: "class": "", Jan 17 16:26:06 volumio volumio[761]: "blocked": "", Jan 17 16:26:06 volumio volumio[761]: "connected": "", Jan 17 16:26:06 volumio volumio[761]: "trycount": 4 Jan 17 16:26:06 volumio volumio[761]: }, Jan 17 16:26:06 volumio volumio[761]: { Jan 17 16:26:06 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:26:06 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:26:06 volumio volumio[761]: "signal": 0, Jan 17 16:26:06 volumio volumio[761]: "paired": "", Jan 17 16:26:06 volumio volumio[761]: "trusted": "yes", Jan 17 16:26:06 volumio volumio[761]: "icon": "", Jan 17 16:26:06 volumio volumio[761]: "class": "", Jan 17 16:26:06 volumio volumio[761]: "blocked": "", Jan 17 16:26:06 volumio volumio[761]: "connected": "no", Jan 17 16:26:06 volumio volumio[761]: "trycount": 4 Jan 17 16:26:06 volumio volumio[761]: } Jan 17 16:26:06 volumio volumio[761]: ] Jan 17 16:26:06 volumio volumio[761]: } Jan 17 16:26:06 volumio volumio[761]: } Jan 17 16:26:09 volumio volumio[761]: info: Device list changed: Jan 17 16:26:09 volumio volumio[761]: info: { Jan 17 16:26:09 volumio volumio[761]: "mac": "60:FB:00:E5:52:B5", Jan 17 16:26:09 volumio volumio[761]: "name": "TV u dnevnom boravku", Jan 17 16:26:09 volumio volumio[761]: "signal": 64, Jan 17 16:26:09 volumio volumio[761]: "paired": "", Jan 17 16:26:09 volumio volumio[761]: "trusted": "", Jan 17 16:26:09 volumio volumio[761]: "icon": "", Jan 17 16:26:09 volumio volumio[761]: "class": "", Jan 17 16:26:09 volumio volumio[761]: "blocked": "", Jan 17 16:26:09 volumio volumio[761]: "connected": "", Jan 17 16:26:09 volumio volumio[761]: "trycount": 4 Jan 17 16:26:09 volumio volumio[761]: } Jan 17 16:26:09 volumio volumio[761]: info: { Jan 17 16:26:09 volumio volumio[761]: "mac": "F8:54:B8:4A:66:9A", Jan 17 16:26:09 volumio volumio[761]: "name": "Echo Show 8-7G8", Jan 17 16:26:09 volumio volumio[761]: "signal": 48, Jan 17 16:26:09 volumio volumio[761]: "paired": "", Jan 17 16:26:09 volumio volumio[761]: "trusted": "", Jan 17 16:26:09 volumio volumio[761]: "icon": "", Jan 17 16:26:09 volumio volumio[761]: "class": "", Jan 17 16:26:09 volumio volumio[761]: "blocked": "", Jan 17 16:26:09 volumio volumio[761]: "connected": "", Jan 17 16:26:09 volumio volumio[761]: "trycount": 4 Jan 17 16:26:09 volumio volumio[761]: } Jan 17 16:26:09 volumio volumio[761]: info: { Jan 17 16:26:09 volumio volumio[761]: "mac": "68:B6:91:A3:45:2A", Jan 17 16:26:09 volumio volumio[761]: "name": "Echo Dot-SEU", Jan 17 16:26:09 volumio volumio[761]: "signal": 0, Jan 17 16:26:09 volumio volumio[761]: "paired": "", Jan 17 16:26:09 volumio volumio[761]: "trusted": "yes", Jan 17 16:26:09 volumio volumio[761]: "icon": "", Jan 17 16:26:09 volumio volumio[761]: "class": "", Jan 17 16:26:09 volumio volumio[761]: "blocked": "", Jan 17 16:26:09 volumio volumio[761]: "connected": "no", Jan 17 16:26:09 volumio volumio[761]: "trycount": 4 Jan 17 16:26:09 volumio volumio[761]: } Jan 17 16:26:09 volumio volumio[761]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 16:26:09 volumio volumio[761]: TypeError: Cannot read property 'addDevice' of undefined Jan 17 16:26:09 volumio volumio[761]: at BluetoothController.deviceListChanged (/data/plugins/audio_interface/bluetooth_controller/index.js:222:35) Jan 17 16:26:09 volumio volumio[761]: at EventEmitter. (/data/plugins/audio_interface/bluetooth_controller/index.js:98:18) Jan 17 16:26:09 volumio volumio[761]: at EventEmitter.emit (events.js:315:20) Jan 17 16:26:09 volumio volumio[761]: at checkSignal (/data/plugins/audio_interface/bluetooth_controller/node_modules/bluetoothctlwe/index.js:326:30) Jan 17 16:26:09 volumio volumio[761]: at ReadStream. (/data/plugins/audio_interface/bluetooth_controller/node_modules/bluetoothctlwe/index.js:169:9) Jan 17 16:26:09 volumio volumio[761]: at ReadStream.emit (events.js:315:20) Jan 17 16:26:09 volumio volumio[761]: at addChunk (internal/streams/readable.js:309:12) Jan 17 16:26:09 volumio volumio[761]: at readableAddChunk (internal/streams/readable.js:280:11) Jan 17 16:26:09 volumio volumio[761]: at ReadStream.Readable.push (internal/streams/readable.js:223:10) Jan 17 16:26:09 volumio volumio[761]: at TTY.onStreamRead (internal/stream_base_commons.js:188:23) Jan 17 16:26:09 volumio volumio[761]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 16:26:09 volumio sudo[2078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 16:25 Jan 17 16:26:09 volumio sudo[2078]: 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="0ef53a257739d15464cfa4592fcaf32ccc0b6e28" VOLUMIO_FE_VERSION="526f18193daa22b87c3dc68dd5fbc40204c6f254" VOLUMIO_FE3_VERSION="510828e23342af781e037ee54f4963743bd09395" VOLUMIO_BE_VERSION="8b3e6f24b6d055dc597c25250dded8bef566af7b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 06 Dec 2021 02:23:55 PM CET" VOLUMIO_VERSION="3.165" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cd16ba110d0f71c93668de9f654c7866"