-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2025-01-18 17:36:52 UTC. -- Jan 18 17:35:13 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:35:13 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:13 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:13 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:35:13 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:13 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:13 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:35:13 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:13 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:13 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:35:13 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:35:13 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:13 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:13 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:13 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:13 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:35:13 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:13 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:13 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:35:13 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:13 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:13 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:35:13 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:13 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:13 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:35:13 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:13 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:13 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:35:13 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:13 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:13 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:14 volumio volumio[926]: info: CoreCommandRouter::volumioPlay Jan 18 17:35:14 volumio volumio[926]: verbose: UNSET VOLATILE Jan 18 17:35:14 volumio volumio[926]: info: CoreStateMachine::play index undefined Jan 18 17:35:14 volumio volumio[926]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 17:35:14 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:14 volumio volumio[926]: info: CoreStateMachine::startPlaybackTimer Jan 18 17:35:14 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:14 volumio volumio[926]: info: [1737221714551] ControllerWebradio::clearAddPlayTrack Jan 18 17:35:14 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 17:35:14 volumio volumio[926]: info: sendMpdCommand stop took 5 milliseconds Jan 18 17:35:14 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand clear Jan 18 17:35:14 volumio volumio[926]: info: sendMpdCommand clear took 1 milliseconds Jan 18 17:35:14 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand load "http://stream.antenne.de:80/chillout" Jan 18 17:35:14 volumio volumio[926]: info: Jan 18 17:35:14 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:14 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:14 volumio volumio[926]: info: Jan 18 17:35:14 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:14 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:14 volumio volumio[926]: error: Upnp client error: Error: This socket has been ended by the other party Jan 18 17:35:14 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand add "http://stream.antenne.de:80/chillout" Jan 18 17:35:14 volumio volumio[926]: error: updateQueue error: null Jan 18 17:35:14 volumio volumio[926]: error: updateQueue error: null Jan 18 17:35:14 volumio volumio[926]: info: Jan 18 17:35:14 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:14 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:14 volumio volumio[926]: info: ------------------------------ 423ms Jan 18 17:35:14 volumio volumio[926]: info: ------------------------------ 419ms Jan 18 17:35:14 volumio volumio[926]: info: sendMpdCommand add "http://stream.antenne.de:80/chillout" took 8 milliseconds Jan 18 17:35:14 volumio volumio[926]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 18 17:35:14 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand play Jan 18 17:35:14 volumio volumio[926]: info: Jan 18 17:35:14 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:14 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 13ms Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand play took 7 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 7ms Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:15 volumio volumio[926]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 18 17:35:15 volumio volumio[926]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 18 17:35:15 volumio volumio[926]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 17:35:15 volumio volumio[926]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 18 17:35:15 volumio volumio[926]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 18 17:35:15 volumio volumio[926]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand status took 42 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand status took 40 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:15 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand status took 16 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand playlistinfo took 13 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand playlistinfo took 13 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand status took 9 milliseconds Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:15 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:15 volumio volumio[926]: 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":"Derrick - Love away","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:15 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus stop Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:15 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:15 volumio volumio[926]: 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":"Derrick - Love away","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:15 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:15 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 145ms Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 141ms Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:15 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:15 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 100ms Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand status took 98 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand playlistinfo took 93 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand playlistinfo took 90 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 18ms Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand status took 14 milliseconds Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:15 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:15 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1606,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Derrick - Love away","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:15 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:15 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:15 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:15 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1606,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Derrick - Love away","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:15 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:15 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 242ms Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 231ms Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:15 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:15 volumio volumio[926]: info: Jan 18 17:35:15 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 232ms Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand status took 227 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand playlistinfo took 220 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand playlistinfo took 218 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 99ms Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand status took 96 milliseconds Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:15 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:15 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1606,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Derrick - Love away","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:15 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:15 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:15 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:15 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Derrick - Love away","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:15 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:15 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 413ms Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 328ms Jan 18 17:35:15 volumio volumio[926]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 18 17:35:15 volumio volumio[926]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand playlistinfo took 98 milliseconds Jan 18 17:35:15 volumio volumio[926]: info: sendMpdCommand playlistinfo took 97 milliseconds Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:15 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:15 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:15 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Derrick - Love away","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:15 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:15 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:15 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:15 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2104,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Derrick - Love away","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:15 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:15 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:15 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 396ms Jan 18 17:35:15 volumio volumio[926]: info: ------------------------------ 263ms Jan 18 17:35:15 volumio volumio[926]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 18 17:35:16 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:35:16 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:16 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:16 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:16 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:35:16 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:16 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:16 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:17 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:35:17 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:17 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:35:17 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:17 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:35:17 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:17 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:35:17 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:17 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:35:17 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:17 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:35:17 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:17 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:25 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 18 17:35:25 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 18 17:35:27 volumio volumio[926]: info: Jan 18 17:35:27 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:27 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:27 volumio volumio[926]: info: Jan 18 17:35:27 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:27 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:27 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:27 volumio volumio[926]: info: Jan 18 17:35:27 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:27 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:27 volumio volumio[926]: info: Jan 18 17:35:27 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:27 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:27 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:27 volumio volumio[926]: info: ------------------------------ 14ms Jan 18 17:35:27 volumio volumio[926]: info: sendMpdCommand status took 9 milliseconds Jan 18 17:35:27 volumio volumio[926]: info: ------------------------------ 7ms Jan 18 17:35:27 volumio volumio[926]: info: sendMpdCommand status took 5 milliseconds Jan 18 17:35:27 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:27 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:27 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:27 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:27 volumio volumio[926]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 18 17:35:27 volumio volumio[926]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 18 17:35:27 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:27 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:27 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:27 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:27 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:27 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14104,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Blank & Jones - Alone in This Rhythm (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:27 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:27 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:27 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:27 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:27 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:27 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:27 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:27 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:27 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:27 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:27 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:27 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:27 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:27 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14104,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Blank & Jones - Alone in This Rhythm (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:27 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:27 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:27 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:27 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:27 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:27 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:27 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:27 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:27 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:27 volumio volumio[926]: info: ------------------------------ 82ms Jan 18 17:35:27 volumio volumio[926]: info: ------------------------------ 78ms Jan 18 17:35:29 volumio volumio[926]: info: Jan 18 17:35:29 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:29 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:29 volumio volumio[926]: info: Jan 18 17:35:29 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:29 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:29 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:29 volumio volumio[926]: info: Jan 18 17:35:29 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:29 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:29 volumio volumio[926]: info: Jan 18 17:35:29 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:29 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:29 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:29 volumio volumio[926]: info: ------------------------------ 8ms Jan 18 17:35:29 volumio volumio[926]: info: sendMpdCommand status took 6 milliseconds Jan 18 17:35:29 volumio volumio[926]: info: ------------------------------ 5ms Jan 18 17:35:29 volumio volumio[926]: info: sendMpdCommand status took 4 milliseconds Jan 18 17:35:29 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:29 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:29 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:29 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:29 volumio volumio[926]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 18 17:35:29 volumio volumio[926]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 18 17:35:29 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:29 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:29 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:29 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:29 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:29 volumio volumio[926]: 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":"Blank & Jones - Alone in This Rhythm (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:29 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:29 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:29 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:29 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:29 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:29 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:29 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:29 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:29 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:29 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:29 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:29 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:29 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:29 volumio volumio[926]: 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":"Blank & Jones - Alone in This Rhythm (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:29 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:29 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:29 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:29 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:29 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:29 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:29 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:29 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:29 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:30 volumio volumio[926]: info: ------------------------------ 85ms Jan 18 17:35:30 volumio volumio[926]: info: ------------------------------ 82ms Jan 18 17:35:32 volumio volumio[926]: info: Jan 18 17:35:32 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:32 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:32 volumio volumio[926]: info: Jan 18 17:35:32 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:32 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:32 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:32 volumio volumio[926]: info: Jan 18 17:35:32 volumio volumio[926]: ---------------------------- MPD announces system playlist update Jan 18 17:35:32 volumio volumio[926]: info: Ignoring MPD Status Update Jan 18 17:35:32 volumio volumio[926]: info: Jan 18 17:35:32 volumio volumio[926]: ---------------------------- MPD announces state update: player Jan 18 17:35:32 volumio volumio[926]: info: ControllerMpd::getState Jan 18 17:35:32 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Jan 18 17:35:32 volumio volumio[926]: info: ------------------------------ 8ms Jan 18 17:35:32 volumio volumio[926]: info: sendMpdCommand status took 7 milliseconds Jan 18 17:35:32 volumio volumio[926]: info: ------------------------------ 5ms Jan 18 17:35:32 volumio volumio[926]: info: sendMpdCommand status took 4 milliseconds Jan 18 17:35:32 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:32 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:32 volumio volumio[926]: verbose: ControllerMpd::parseState Jan 18 17:35:32 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 17:35:32 volumio volumio[926]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 18 17:35:32 volumio volumio[926]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 18 17:35:32 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Jan 18 17:35:32 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:32 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:32 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:32 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19353,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Blank & Jones - Alone in This Rhythm (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:32 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:32 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:32 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:32 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:32 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:32 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:32 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:35:32 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:32 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:32 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:32 volumio volumio[926]: info: ControllerMpd::pushState Jan 18 17:35:32 volumio volumio[926]: info: CoreCommandRouter::servicePushState Jan 18 17:35:32 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Jan 18 17:35:32 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19353,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Blank & Jones - Alone in This Rhythm (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Jan 18 17:35:32 volumio volumio[926]: verbose: CURRENT POSITION 0 Jan 18 17:35:32 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Jan 18 17:35:32 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Jan 18 17:35:32 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Jan 18 17:35:32 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 18 17:35:32 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:32 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:32 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:35:32 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:35:33 volumio volumio[926]: info: ------------------------------ 167ms Jan 18 17:35:33 volumio volumio[926]: info: ------------------------------ 167ms Jan 18 17:35:35 volumio volumio[926]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 17:36:30 volumio volumio[926]: info: CALLMETHOD: system_hardware rotaryencoder2 updateEncoder [object Object] Jan 18 17:36:30 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: rotaryencoder2 , updateEncoder Jan 18 17:36:30 volumio sudo[1972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:30 volumio sudo[1972]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:30 volumio sudo[1972]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:30 volumio sudo[1975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Jan 18 17:36:30 volumio sudo[1975]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:30 volumio kernel: input: button@f as /devices/platform/button@f/input/input11 Jan 18 17:36:30 volumio sudo[1975]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:30 volumio sudo[1988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:30 volumio sudo[1988]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:30 volumio sudo[1988]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:30 volumio sudo[1991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:30 volumio sudo[1991]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:30 volumio sudo[1991]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:31 volumio systemd-udevd[1980]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 18 17:36:32 volumio sudo[1994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Jan 18 17:36:32 volumio sudo[1994]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:32 volumio sudo[1994]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:32 volumio sudo[2009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:32 volumio sudo[2009]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:32 volumio sudo[2009]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:32 volumio sudo[2012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=8 pin_b=7 relative_axis=true steps-per-period=1 Jan 18 17:36:32 volumio sudo[2012]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:32 volumio kernel: rotary-encoder rotary@8: gray Jan 18 17:36:32 volumio kernel: input: rotary@8 as /devices/platform/rotary@8/input/input12 Jan 18 17:36:32 volumio sudo[2012]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:32 volumio systemd-udevd[1980]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 18 17:36:34 volumio sudo[2027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=15 active_low=1 gpio_pull=up keycode=20 Jan 18 17:36:34 volumio sudo[2027]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:35 volumio kernel: input: button@f as /devices/platform/button@f/input/input13 Jan 18 17:36:35 volumio sudo[2027]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:35 volumio volumio[926]: info: CALLMETHOD: system_hardware rotaryencoder2 updateEncoder [object Object] Jan 18 17:36:35 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: rotaryencoder2 , updateEncoder Jan 18 17:36:35 volumio volumio[926]: error: [ROTARYENCODER2] detachListener: could not kill handler process Jan 18 17:36:35 volumio volumio[926]: error: [ROTARYENCODER2] detachListener: could not kill handler process Jan 18 17:36:35 volumio sudo[2042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:35 volumio sudo[2042]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:35 volumio sudo[2042]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:35 volumio systemd-udevd[1980]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 18 17:36:35 volumio sudo[2045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Jan 18 17:36:35 volumio sudo[2045]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:35 volumio startx[1214]: [dix] couldn't enable device 6 Jan 18 17:36:35 volumio kernel: input: button@f as /devices/platform/button@f/input/input14 Jan 18 17:36:35 volumio sudo[2045]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:35 volumio sudo[2059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:35 volumio sudo[2059]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:35 volumio sudo[2059]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:35 volumio sudo[2062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:35 volumio sudo[2062]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:35 volumio sudo[2062]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:35 volumio sudo[2065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Jan 18 17:36:35 volumio sudo[2065]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:35 volumio volumio[926]: info: CALLMETHOD: system_hardware rotaryencoder2 updateEncoder [object Object] Jan 18 17:36:35 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: rotaryencoder2 , updateEncoder Jan 18 17:36:35 volumio volumio[926]: error: [ROTARYENCODER2] detachListener: could not kill handler process Jan 18 17:36:35 volumio volumio[926]: error: [ROTARYENCODER2] detachListener: could not kill handler process Jan 18 17:36:35 volumio systemd-udevd[1980]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 18 17:36:35 volumio systemd-logind[464]: Failed to open /dev/input/event9: No such device Jan 18 17:36:35 volumio sudo[2073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:35 volumio sudo[2073]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:35 volumio sudo[2073]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:35 volumio sudo[2076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:35 volumio sudo[2065]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:35 volumio sudo[2076]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:35 volumio sudo[2076]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:35 volumio sudo[2082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:35 volumio sudo[2082]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:35 volumio sudo[2082]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:35 volumio sudo[2085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=8 pin_b=7 relative_axis=true steps-per-period=1 Jan 18 17:36:35 volumio sudo[2085]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:35 volumio kernel: rotary-encoder rotary@8: gray Jan 18 17:36:35 volumio kernel: input: rotary@8 as /devices/platform/rotary@8/input/input15 Jan 18 17:36:35 volumio sudo[2088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=8 pin_b=7 relative_axis=true steps-per-period=1 Jan 18 17:36:35 volumio sudo[2088]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:35 volumio sudo[2085]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:35 volumio sudo[2088]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:35 volumio volumio[926]: error: [ROTARYENCODER2] addOverlay: * Failed to apply overlay '1_rotary-encoder' (kernel) Jan 18 17:36:36 volumio systemd-udevd[1980]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 18 17:36:37 volumio sudo[2106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:37 volumio sudo[2106]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:37 volumio sudo[2108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:37 volumio sudo[2108]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:37 volumio sudo[2106]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:37 volumio sudo[2108]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:37 volumio sudo[2113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=15 active_low=1 gpio_pull=up keycode=20 Jan 18 17:36:37 volumio sudo[2113]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:37 volumio kernel: input: button@f as /devices/platform/button@f/input/input16 Jan 18 17:36:37 volumio sudo[2113]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:37 volumio sudo[2128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:37 volumio sudo[2128]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:37 volumio sudo[2128]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:37 volumio sudo[2131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:37 volumio sudo[2131]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:37 volumio sudo[2131]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:37 volumio volumio[926]: error: [ROTARYENCODER2] addEventHandle: stderr: /bin/cat: /dev/input/by-path/platform-button@f-event: No such file or directory Jan 18 17:36:37 volumio systemd-udevd[1980]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 18 17:36:39 volumio sudo[2141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:39 volumio sudo[2141]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:40 volumio sudo[2141]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:40 volumio sudo[2147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 17:36:40 volumio sudo[2147]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 17:36:40 volumio sudo[2147]: pam_unix(sudo:session): session closed for user root Jan 18 17:36:40 volumio volumio[926]: info: CoreCommandRouter::volumioGetVisibleSources Jan 18 17:36:40 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 17:36:40 volumio volumio[926]: info: CoreCommandRouter::volumioGetQueue Jan 18 17:36:40 volumio volumio[926]: info: CoreStateMachine::getQueue Jan 18 17:36:40 volumio volumio[926]: info: CorePlayQueue::getQueue Jan 18 17:36:44 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:44 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:44 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:44 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:44 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:44 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:44 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:44 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:44 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:44 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:44 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:45 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:45 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:45 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:46 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:46 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:47 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:47 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:47 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:47 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:47 volumio volumio[926]: info: VolumeController::SetAlsaVolume- Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:47 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:47 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:47 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:47 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:48 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:48 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:48 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:48 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:48 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:48 volumio volumio[926]: info: VolumeController::SetAlsaVolume+ Jan 18 17:36:48 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:48 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 17:36:48 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:48 volumio volumio[926]: info: CoreStateMachine::pushState Jan 18 17:36:48 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Jan 18 17:36:50 volumio volumio[926]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. Jan 18 17:36:51 volumio volumio[926]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 17:36:51 volumio volumio[926]: SyntaxError: Unexpected end of JSON input Jan 18 17:36:51 volumio volumio[926]: at JSON.parse () Jan 18 17:36:51 volumio volumio[926]: at rotaryencoder2.emitPushCommand (/data/plugins/system_hardware/rotaryencoder2/index.js:1048:17) Jan 18 17:36:51 volumio volumio[926]: at Timeout._onTimeout (/data/plugins/system_hardware/rotaryencoder2/index.js:908:16) Jan 18 17:36:51 volumio volumio[926]: at listOnTimeout (internal/timers.js:554:17) Jan 18 17:36:51 volumio volumio[926]: at processTimers (internal/timers.js:497:7) Jan 18 17:36:51 volumio volumio[926]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 17:36:52 volumio sudo[2242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 17:35 Jan 18 17:36:52 volumio sudo[2242]: 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="1f061e035f7cb2799b32d3520aa8e55cd07df6f9" VOLUMIO_FE_VERSION="9971a09df9c3edfdedf2ecf438999be8aba9db68" VOLUMIO_FE3_VERSION="3974def988c7b2392ddc85f9b8cb4692d5e8fda9" VOLUMIO_BE_VERSION="b3c53a818b9b3d0e5c13c9d346c4d613c4ca426f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 11 Jul 2022 04:03:33 PM CEST" VOLUMIO_VERSION="3.324" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5b2f59e6e90e57f326ca25c7ca839d52"