Jan 09 12:35:00 volumio-dormitory autossh[4645]: starting ssh (count 11) Jan 09 12:35:00 volumio-dormitory autossh[4645]: ssh child pid is 4888 Jan 09 12:35:07 volumio-dormitory ntpd[783]: PROTO: 188.68.34.173 unlink local addr 192.168.2.142 -> Jan 09 12:35:18 volumio-dormitory volumio[993]: info: Preload queue cleared Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreStateMachine::ClearQueue Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreStateMachine::stop Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreStateMachine::stPlaybackTimer Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreStateMachine::updateTrackBlock Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrackBlock Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:18 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:18 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreStateMachine::serviceStop Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreCommandRouter::serviceStop Jan 09 12:35:18 volumio-dormitory volumio[993]: info: [1767958518842] ControllerWebradio::stop Jan 09 12:35:18 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CorePlayQueue::clearPlayQueue Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CorePlayQueue::saveQueue Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushQueue Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreStateMachine::addQueueItems Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CorePlayQueue::addQueueItems Jan 09 12:35:18 volumio-dormitory volumio[993]: info: Preload queue cleared Jan 09 12:35:18 volumio-dormitory volumio[993]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s24855 Jan 09 12:35:18 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 09 12:35:18 volumio-dormitory volumio[993]: info: Jan 09 12:35:18 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:18 volumio-dormitory volumio[993]: info: sendMpdCommand stop took 154 milliseconds Jan 09 12:35:18 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:18 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:19 volumio-dormitory volumio[993]: info: Jan 09 12:35:19 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:19 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:19 volumio-dormitory volumio[993]: info: Jan 09 12:35:19 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:19 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:19 volumio-dormitory volumio[993]: info: sendMpdCommand status took 15 milliseconds Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:19 volumio-dormitory volumio[993]: info: sendMpdCommand status took 9 milliseconds Jan 09 12:35:19 volumio-dormitory volumio[993]: info: sendMpdCommand status took 7 milliseconds Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:19 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 09 12:35:19 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 09 12:35:19 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:19 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Placebo - Every you every me","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService stop Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus stop Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: No code Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Placebo - Every you every me","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService stop Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus stop Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: No code Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Placebo - Every you every me","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService stop Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus stop Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: No code Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:19 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: ------------------------------ 221ms Jan 09 12:35:19 volumio-dormitory volumio[993]: info: ------------------------------ 214ms Jan 09 12:35:19 volumio-dormitory volumio[993]: info: ------------------------------ 213ms Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushQueue Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::saveQueue Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::updateTrackBlock Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrackBlock Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPlay Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::play index 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::stop Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::play index undefined Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreStateMachine::startPlaybackTimer Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetVisibleSources Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 12:35:19 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 09 12:35:19 volumio-dormitory volumio[993]: info: [1767958519675] ControllerWebradio::clearAddPlayTrack Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 12:35:19 volumio-dormitory volumio[993]: info: sendMpdCommand stop took 6 milliseconds Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand clear Jan 09 12:35:19 volumio-dormitory volumio[993]: info: Jan 09 12:35:19 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:19 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:19 volumio-dormitory volumio[993]: info: sendMpdCommand clear took 1 milliseconds Jan 09 12:35:19 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand load "https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20" Jan 09 12:35:19 volumio-dormitory volumio[993]: info: Jan 09 12:35:19 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:19 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:19 volumio-dormitory volumio[993]: info: Jan 09 12:35:19 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:19 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:22 volumio-dormitory volumiossh-tunnel[4888]: Warning: Permanently added '[eu7.myvolumio.org]:2222' (RSA) to the list of known hosts. Jan 09 12:35:22 volumio-dormitory volumio[993]: error: updateQueue error: null Jan 09 12:35:22 volumio-dormitory volumio[993]: info: ------------------------------ 2899ms Jan 09 12:35:22 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand add "https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20" Jan 09 12:35:22 volumio-dormitory volumio[993]: error: updateQueue error: null Jan 09 12:35:22 volumio-dormitory volumio[993]: error: updateQueue error: null Jan 09 12:35:22 volumio-dormitory volumio[993]: info: ------------------------------ 2899ms Jan 09 12:35:22 volumio-dormitory volumio[993]: info: ------------------------------ 2898ms Jan 09 12:35:22 volumio-dormitory volumio[993]: info: Jan 09 12:35:22 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:22 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:22 volumio-dormitory volumio[993]: info: sendMpdCommand add "https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20" took 3 milliseconds Jan 09 12:35:22 volumio-dormitory volumio[993]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 12:35:22 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand play Jan 09 12:35:22 volumio-dormitory volumio[993]: info: Jan 09 12:35:22 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:22 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:22 volumio-dormitory volumio[993]: info: Jan 09 12:35:22 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:22 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:22 volumio-dormitory volumio[993]: info: ------------------------------ 5ms Jan 09 12:35:22 volumio-dormitory volumio[993]: info: sendMpdCommand play took 5 milliseconds Jan 09 12:35:22 volumio-dormitory volumio[993]: info: ------------------------------ 4ms Jan 09 12:35:22 volumio-dormitory volumio[993]: info: ------------------------------ 3ms Jan 09 12:35:24 volumio-dormitory volumio[993]: info: Jan 09 12:35:24 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:24 volumio-dormitory volumio[993]: info: Jan 09 12:35:24 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:24 volumio-dormitory volumio[993]: info: Jan 09 12:35:24 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:24 volumio-dormitory volumio[993]: info: Jan 09 12:35:24 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand status took 3 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:24 volumio-dormitory volumio[993]: info: Jan 09 12:35:24 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:24 volumio-dormitory volumio[993]: info: Jan 09 12:35:24 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand status took 8 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand status took 6 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand status took 4 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus stop Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ------------------------------ 19ms Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand status took 9 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:24 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:24 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:24 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:24 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ------------------------------ 216ms Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ------------------------------ 215ms Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ------------------------------ 216ms Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ------------------------------ 214ms Jan 09 12:35:24 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 206 milliseconds Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:24 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:24 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:24 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:24 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:24 volumio-dormitory volumio[993]: info: ------------------------------ 291ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 8ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand status took 7 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 6ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 4ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand status took 4 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Jan 09 12:35:25 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 10ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand status took 8 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 6ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 4ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand status took 3 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1339,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1465,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1465,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 163ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 162ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 162ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 149 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 149 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 149 milliseconds Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1465,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1465,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1465,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:25 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:25 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:25 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 230ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 224ms Jan 09 12:35:25 volumio-dormitory volumio[993]: info: ------------------------------ 224ms Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Preload queue cleared Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::ClearQueue Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::stop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::stPlaybackTimer Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::updateTrackBlock Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrackBlock Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::serviceStop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::serviceStop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: [1767958528171] ControllerWebradio::stop Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::clearPlayQueue Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::saveQueue Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushQueue Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::addQueueItems Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::addQueueItems Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Preload queue cleared Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s255613 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Jan 09 12:35:28 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:28 volumio-dormitory volumio[993]: info: sendMpdCommand stop took 55 milliseconds Jan 09 12:35:28 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Jan 09 12:35:28 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:28 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Jan 09 12:35:28 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:28 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:28 volumio-dormitory volumio[993]: info: sendMpdCommand status took 8 milliseconds Jan 09 12:35:28 volumio-dormitory volumio[993]: info: sendMpdCommand status took 4 milliseconds Jan 09 12:35:28 volumio-dormitory volumio[993]: info: sendMpdCommand status took 2 milliseconds Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:28 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 12:35:28 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 09 12:35:28 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:28 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService stop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus stop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: No code Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService stop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus stop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: No code Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService stop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus stop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: No code Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:28 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: ------------------------------ 84ms Jan 09 12:35:28 volumio-dormitory volumio[993]: info: ------------------------------ 81ms Jan 09 12:35:28 volumio-dormitory volumio[993]: info: ------------------------------ 81ms Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushQueue Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::saveQueue Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::updateTrackBlock Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrackBlock Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPlay Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::play index 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::stop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::play index undefined Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreStateMachine::startPlaybackTimer Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetVisibleSources Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 12:35:28 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 09 12:35:28 volumio-dormitory volumio[993]: info: [1767958528669] ControllerWebradio::clearAddPlayTrack Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 12:35:28 volumio-dormitory volumio[993]: info: sendMpdCommand stop took 3 milliseconds Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand clear Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Jan 09 12:35:28 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:28 volumio-dormitory volumio[993]: info: sendMpdCommand clear took 1 milliseconds Jan 09 12:35:28 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand load "https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20" Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Jan 09 12:35:28 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Jan 09 12:35:28 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:28 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:30 volumio-dormitory volumio[993]: error: updateQueue error: null Jan 09 12:35:30 volumio-dormitory volumio[993]: info: ------------------------------ 1887ms Jan 09 12:35:30 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand add "https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20" Jan 09 12:35:30 volumio-dormitory volumio[993]: error: updateQueue error: null Jan 09 12:35:30 volumio-dormitory volumio[993]: error: updateQueue error: null Jan 09 12:35:30 volumio-dormitory volumio[993]: info: ------------------------------ 1886ms Jan 09 12:35:30 volumio-dormitory volumio[993]: info: ------------------------------ 1885ms Jan 09 12:35:30 volumio-dormitory volumio[993]: info: Jan 09 12:35:30 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:30 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:30 volumio-dormitory volumio[993]: info: sendMpdCommand add "https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20" took 3 milliseconds Jan 09 12:35:30 volumio-dormitory volumio[993]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 12:35:30 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand play Jan 09 12:35:30 volumio-dormitory volumio[993]: info: Jan 09 12:35:30 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:30 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:30 volumio-dormitory volumio[993]: info: Jan 09 12:35:30 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:30 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:30 volumio-dormitory volumio[993]: info: ------------------------------ 5ms Jan 09 12:35:30 volumio-dormitory volumio[993]: info: sendMpdCommand play took 4 milliseconds Jan 09 12:35:30 volumio-dormitory volumio[993]: info: ------------------------------ 3ms Jan 09 12:35:30 volumio-dormitory volumio[993]: info: ------------------------------ 3ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 8 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 6 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus stop Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 42ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 51ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 50ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 42 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 42 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 42 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 96ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 95ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 100 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","artist":null,"album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 176ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 7ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 6ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 4 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Jan 09 12:35:32 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 9ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 8 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 9ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 8 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 6ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 4ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1128,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1213,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 59ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ------------------------------ 58ms Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 48 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 49 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 49 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 49 milliseconds Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1213,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1213,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1213,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1213,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grenzenlos hören. Bayern 2","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:32 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:32 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:32 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:32 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:33 volumio-dormitory volumio[993]: info: ------------------------------ 140ms Jan 09 12:35:33 volumio-dormitory volumio[993]: info: ------------------------------ 140ms Jan 09 12:35:33 volumio-dormitory volumio[993]: info: ------------------------------ 138ms Jan 09 12:35:33 volumio-dormitory volumio[993]: info: ------------------------------ 136ms Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Jan 09 12:35:35 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Jan 09 12:35:35 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Jan 09 12:35:35 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Jan 09 12:35:35 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Jan 09 12:35:35 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Jan 09 12:35:35 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ------------------------------ 5ms Jan 09 12:35:35 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ------------------------------ 4ms Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:35 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ------------------------------ 4ms Jan 09 12:35:35 volumio-dormitory volumio[993]: info: sendMpdCommand status took 3 milliseconds Jan 09 12:35:35 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3845,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tagesgespräch - Rufen Sie an: 0800 - 94 95 95 5 (gebührenfrei)","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ------------------------------ 27ms Jan 09 12:35:35 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 21 milliseconds Jan 09 12:35:35 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 21 milliseconds Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3845,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tagesgespräch - Rufen Sie an: 0800 - 94 95 95 5 (gebührenfrei)","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3845,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tagesgespräch - Rufen Sie an: 0800 - 94 95 95 5 (gebührenfrei)","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:35 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:35 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:35 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:35 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ------------------------------ 60ms Jan 09 12:35:35 volumio-dormitory volumio[993]: info: ------------------------------ 60ms Jan 09 12:35:43 volumio-dormitory volumio[993]: info: Tunnel connection is inactive, restarting it Jan 09 12:35:43 volumio-dormitory volumio[993]: info: Starting Tunnel 1 Jan 09 12:35:43 volumio-dormitory volumio[993]: info: Starting Tunnel Connection Checker Jan 09 12:35:43 volumio-dormitory sudo[4964]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jan 09 12:35:44 volumio-dormitory sudo[4964]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:35:44 volumio-dormitory autossh[4645]: received signal to exit (15) Jan 09 12:35:44 volumio-dormitory systemd[1]: Stopping sshtunnel.service - MyVolumio SSH Tunnel... Jan 09 12:35:44 volumio-dormitory systemd[1]: sshtunnel.service: Deactivated successfully. Jan 09 12:35:44 volumio-dormitory systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Jan 09 12:35:44 volumio-dormitory systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Jan 09 12:35:44 volumio-dormitory sudo[4964]: pam_unix(sudo:session): session closed for user root Jan 09 12:35:44 volumio-dormitory volumio[993]: info: Remote SSH Started Jan 09 12:35:44 volumio-dormitory autossh[4968]: port set to 0, monitoring disabled Jan 09 12:35:44 volumio-dormitory autossh[4968]: starting ssh (count 1) Jan 09 12:35:44 volumio-dormitory autossh[4968]: ssh child pid is 4971 Jan 09 12:35:44 volumio-dormitory volumio[993]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jan 09 12:35:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:44 volumio-dormitory volumiossh-tunnel[4971]: Warning: Permanently added '[eu7.myvolumio.org]:2222' (RSA) to the list of known hosts. Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Jan 09 12:35:56 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Jan 09 12:35:56 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Jan 09 12:35:56 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Jan 09 12:35:56 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Jan 09 12:35:56 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Jan 09 12:35:56 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ------------------------------ 5ms Jan 09 12:35:56 volumio-dormitory volumio[993]: info: sendMpdCommand status took 4 milliseconds Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ------------------------------ 4ms Jan 09 12:35:56 volumio-dormitory volumio[993]: info: sendMpdCommand status took 3 milliseconds Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ------------------------------ 5ms Jan 09 12:35:56 volumio-dormitory volumio[993]: info: sendMpdCommand status took 3 milliseconds Jan 09 12:35:56 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 09 12:35:56 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25465,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Ist Arbeitslosigkeit ein Thema für Sie?","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25465,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Ist Arbeitslosigkeit ein Thema für Sie?","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ------------------------------ 52ms Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ------------------------------ 51ms Jan 09 12:35:56 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 46 milliseconds Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25465,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Ist Arbeitslosigkeit ein Thema für Sie?","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:35:56 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:35:56 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:35:56 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:35:56 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:35:56 volumio-dormitory volumio[993]: info: ------------------------------ 75ms Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Jan 09 12:36:17 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Jan 09 12:36:17 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Jan 09 12:36:17 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Jan 09 12:36:17 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Jan 09 12:36:17 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Jan 09 12:36:17 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ------------------------------ 7ms Jan 09 12:36:17 volumio-dormitory volumio[993]: info: sendMpdCommand status took 6 milliseconds Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ------------------------------ 6ms Jan 09 12:36:17 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ------------------------------ 4ms Jan 09 12:36:17 volumio-dormitory volumio[993]: info: sendMpdCommand status took 5 milliseconds Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:36:17 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 09 12:36:17 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 09 12:36:17 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45727,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bayern 2 auf WhatsApp und Signal: 0151 - 7 220 220 7","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45727,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bayern 2 auf WhatsApp und Signal: 0151 - 7 220 220 7","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45727,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bayern 2 auf WhatsApp und Signal: 0151 - 7 220 220 7","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:36:17 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:36:17 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:17 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:17 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ------------------------------ 59ms Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ------------------------------ 58ms Jan 09 12:36:17 volumio-dormitory volumio[993]: info: ------------------------------ 58ms Jan 09 12:36:21 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:23 volumio-dormitory volumio[993]: info: Executing endpoint metavolumio Jan 09 12:36:23 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 09 12:36:23 volumio-dormitory volumio[993]: info: Executing endpoint metavolumio Jan 09 12:36:23 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 09 12:36:23 volumio-dormitory systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Jan 09 12:36:25 volumio-dormitory systemd[1]: setdatetime-helper.service: Deactivated successfully. Jan 09 12:36:25 volumio-dormitory systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Jan 09 12:36:25 volumio-dormitory systemd[1]: setdatetime-helper.service: Consumed 1.460s CPU time. Jan 09 12:36:25 volumio-dormitory volumio[993]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 12:36:26 volumio-dormitory volumio[993]: info: Getting Alsa Cards List without I2S DAC Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 09 12:36:26 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Jan 09 12:36:36 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Jan 09 12:36:36 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Jan 09 12:36:36 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Jan 09 12:36:36 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Jan 09 12:36:36 volumio-dormitory volumio[993]: ---------------------------- MPD announces system playlist update Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Ignoring MPD Status Update Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Jan 09 12:36:36 volumio-dormitory volumio[993]: ---------------------------- MPD announces state update: player Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ControllerMpd::getState Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand status Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ------------------------------ 7ms Jan 09 12:36:36 volumio-dormitory volumio[993]: info: sendMpdCommand status took 6 milliseconds Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ------------------------------ 5ms Jan 09 12:36:36 volumio-dormitory volumio[993]: info: sendMpdCommand status took 4 milliseconds Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ------------------------------ 5ms Jan 09 12:36:36 volumio-dormitory volumio[993]: info: sendMpdCommand status took 4 milliseconds Jan 09 12:36:36 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 09 12:36:36 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseState Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65217,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bayern 2 Tagesgespräch - mehr unter bayern2.de","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65217,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bayern 2 Tagesgespräch - mehr unter bayern2.de","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ------------------------------ 49ms Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ------------------------------ 48ms Jan 09 12:36:36 volumio-dormitory volumio[993]: info: sendMpdCommand playlistinfo took 40 milliseconds Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: ControllerMpd::parseTrackInfo Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ControllerMpd::pushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::servicePushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65217,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bayern 2 Tagesgespräch - mehr unter bayern2.de","artist":"Bayern 2","album":null,"uri":"https://f141.rndfnk.com/ard/br/br2/live/mp3/128/stream.mp3?aggregator=tunein&cid=01HNCWQ25NS4FWXXH2R91H67V1&sid=2mtJn0NwbmO1EnQgKxMnQBO0dtU&token=I81AD2MaBRRRnM6rmB7KA88Y9JBZSo0xFMV1ACN1YJQ&tvf=dMXal4nG-hdmMTQxLnJuZGZuay5jb20","trackType":""} Jan 09 12:36:36 volumio-dormitory volumio[993]: verbose: CURRENT POSITION 0 Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState stateService play Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::syncState currentStatus play Jan 09 12:36:36 volumio-dormitory volumio[993]: info: Received an update from plugin. extracting info from payload Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:36 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:36 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:36 volumio-dormitory volumio[993]: info: ------------------------------ 64ms Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: Restoring Previous Volume level: 100 false true Jan 09 12:36:40 volumio-dormitory volumio[993]: info: VolumeController::SetAlsaVolume100 Jan 09 12:36:40 volumio-dormitory volumio[993]: info: Enable softmixer device for audio device number 2 Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioStop Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreStateMachine::stop Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreStateMachine::stPlaybackTimer Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreStateMachine::updateTrackBlock Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrackBlock Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:40 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreStateMachine::serviceStop Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::serviceStop Jan 09 12:36:40 volumio-dormitory volumio[993]: info: [1767958600685] ControllerWebradio::stop Jan 09 12:36:40 volumio-dormitory volumio[993]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 12:36:40 volumio-dormitory volumio[993]: info: Enable softmixer device for audio device undefined Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 09 12:36:40 volumio-dormitory volumio[993]: info: Updating Volume Controller Parameters: Device: 2 Name: Generic I2S DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 09 12:36:40 volumio-dormitory volumio[993]: info: Disabling external Volume Control Jan 09 12:36:40 volumio-dormitory volumio[993]: info: Output device has changed, restarting MPD Jan 09 12:36:40 volumio-dormitory volumio[993]: info: Output device has changed, restarting Shairport Sync Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:40 volumio-dormitory sudo[5115]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 12:36:40 volumio-dormitory sudo[5115]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:40 volumio-dormitory sudo[5115]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:40 volumio-dormitory sudo[5117]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 12:36:40 volumio-dormitory sudo[5117]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:40 volumio-dormitory volumio[993]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 12:36:40 volumio-dormitory volumio[993]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:40 volumio-dormitory volumio[993]: info: QobuzConnect: setDeactiveState invoked Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:40 volumio-dormitory vtcs[3894]: [2026-01-09 12:36:40.843] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=5 errorno=104 error=Connection reset by peer Jan 09 12:36:40 volumio-dormitory vtcs[3894]: [2026-01-09 12:36:40.843] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jan 09 12:36:40 volumio-dormitory vtcs[3894]: [2026-01-09 12:36:40.843] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jan 09 12:36:40 volumio-dormitory systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 09 12:36:40 volumio-dormitory volumio[993]: info: Volume configurations have been set Jan 09 12:36:40 volumio-dormitory volumio[993]: info: QobuzConnect: setDeactiveState invoked Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:40 volumio-dormitory sudo[5129]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:40 volumio-dormitory sudo[5129]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:40 volumio-dormitory sudo[5131]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:40 volumio-dormitory sudo[5131]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 09 12:36:40 volumio-dormitory volumio[993]: info: Updating Volume Controller Parameters: Device: 2 Name: Generic I2S DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 09 12:36:40 volumio-dormitory volumio[993]: info: Disabling external Volume Control Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:40 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:40 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:40 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:40 volumio-dormitory volumio[993]: error: MPD error: Error: write EPIPE Jan 09 12:36:40 volumio-dormitory volumio[993]: error: write EPIPE {"code":"EPIPE","errno":-32,"syscall":"write"} Jan 09 12:36:41 volumio-dormitory systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jan 09 12:36:41 volumio-dormitory systemd[1]: vtcs.service: Killing process 3903 (n/a) with signal SIGKILL. Jan 09 12:36:41 volumio-dormitory systemd[1]: vtcs.service: Deactivated successfully. Jan 09 12:36:41 volumio-dormitory systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jan 09 12:36:41 volumio-dormitory sudo[5145]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:41 volumio-dormitory sudo[5145]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:41 volumio-dormitory systemd[1]: vtcs.service: Consumed 1.063s CPU time. Jan 09 12:36:41 volumio-dormitory sudo[5147]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:41 volumio-dormitory sudo[5147]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:41 volumio-dormitory sudo[5155]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 09 12:36:41 volumio-dormitory sudo[5155]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:41 volumio-dormitory sudo[5163]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 09 12:36:41 volumio-dormitory sudo[5163]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:41 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:41 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:41 volumio-dormitory volumio[993]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 12:36:41 volumio-dormitory volumio[993]: info: MPD Permissions set Jan 09 12:36:41 volumio-dormitory volumio[993]: info: Software Volume ALSA configuration written Jan 09 12:36:41 volumio-dormitory sudo[5129]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:41 volumio-dormitory sudo[5131]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:41 volumio-dormitory volumio[993]: info: Preparing to generate the ALSA configuration file Jan 09 12:36:41 volumio-dormitory sudo[5155]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:41 volumio-dormitory sudo[5163]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:41 volumio-dormitory sudo[5171]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 09 12:36:41 volumio-dormitory sudo[5171]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:41 volumio-dormitory sudo[5170]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 09 12:36:41 volumio-dormitory sudo[5170]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:41 volumio-dormitory sudo[5147]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:41 volumio-dormitory sudo[5145]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:41 volumio-dormitory systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 12:36:41 volumio-dormitory volumio[993]: info: Getting Alsa Cards List without I2S DAC Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:41 volumio-dormitory qobuz-connect[3868]: 20260109 12:36:41.671 [3868.3868] INFO SampleApp: Stopping Local configuration server Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 09 12:36:41 volumio-dormitory volumio[993]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 09 12:36:41 volumio-dormitory volumio[993]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 09 12:36:41 volumio-dormitory volumio[993]: info: Reading ALSA contributions from plugins. Jan 09 12:36:41 volumio-dormitory volumio[993]: info: VolumeController::SetAlsaVolume0 Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:41 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:41 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:41 volumio-dormitory volumio[993]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jan 09 12:36:41 volumio-dormitory volumio[993]: info: Starting Shairport Sync Jan 09 12:36:41 volumio-dormitory volumio[993]: info: Asound.conf file written Jan 09 12:36:41 volumio-dormitory sudo[5195]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 12:36:41 volumio-dormitory sudo[5195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:41 volumio-dormitory sudo[5198]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 09 12:36:41 volumio-dormitory sudo[5198]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:41 volumio-dormitory sudo[5198]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:41 volumio-dormitory systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 09 12:36:41 volumio-dormitory systemd[1]: shairport-sync.service: Deactivated successfully. Jan 09 12:36:41 volumio-dormitory systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 12:36:41 volumio-dormitory systemd[1]: shairport-sync.service: Consumed 4.344s CPU time. Jan 09 12:36:42 volumio-dormitory systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 12:36:42 volumio-dormitory sudo[5195]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card b1 Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: /usr/share/alsa/init/bcm2835:14: control element not found Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card b1 Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card Headphones Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: /usr/share/alsa/init/bcm2835:20: control element not found Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card Headphones Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card sndrpihifiberry Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: Found hardware: "RPi-simple" "" "" "" "" Jan 09 12:36:42 volumio-dormitory volumio[993]: Hardware is initialized using a generic method Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card sndrpihifiberry Jan 09 12:36:42 volumio-dormitory volumio[993]: info: Output device has changed, restarting MPD Jan 09 12:36:42 volumio-dormitory volumio[993]: info: Output device has changed, restarting Shairport Sync Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:42 volumio-dormitory volumio[993]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 12:36:42 volumio-dormitory volumio[993]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:42 volumio-dormitory sudo[5208]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 12:36:42 volumio-dormitory sudo[5208]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:42 volumio-dormitory sudo[5206]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 12:36:42 volumio-dormitory sudo[5206]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:42 volumio-dormitory volumio[993]: info: QobuzConnect: setDeactiveState invoked Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:42 volumio-dormitory sudo[5206]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:42 volumio-dormitory volumio[993]: info: Preparing to generate the ALSA configuration file Jan 09 12:36:42 volumio-dormitory sudo[5219]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:42 volumio-dormitory sudo[5219]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:42 volumio-dormitory volumio[993]: ALSA lib pcm.c:2666:(snd_pcm_open_noupdate) Unknown PCM volumioMultiRoomServer Jan 09 12:36:42 volumio-dormitory volumio[993]: aplay: main:831: audio open error: No such file or directory Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card b1 Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: /usr/share/alsa/init/bcm2835:14: control element not found Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card b1 Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card Headphones Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: /usr/share/alsa/init/bcm2835:20: control element not found Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card Headphones Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card sndrpihifiberry Jan 09 12:36:42 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jan 09 12:36:42 volumio-dormitory volumio[993]: Found hardware: "RPi-simple" "" "" "" "" Jan 09 12:36:42 volumio-dormitory volumio[993]: Hardware is initialized using a generic method Jan 09 12:36:42 volumio-dormitory volumio[993]: No state is present for card sndrpihifiberry Jan 09 12:36:42 volumio-dormitory volumio[993]: info: QobuzConnect: setDeactiveState invoked Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:42 volumio-dormitory volumio[993]: info: Output device has changed, restarting MPD Jan 09 12:36:42 volumio-dormitory sudo[5219]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:42 volumio-dormitory volumio[993]: info: Output device has changed, restarting Shairport Sync Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:42 volumio-dormitory sudo[5228]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:42 volumio-dormitory sudo[5231]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 12:36:42 volumio-dormitory sudo[5231]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:42 volumio-dormitory sudo[5228]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:42 volumio-dormitory sudo[5231]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:42 volumio-dormitory sudo[5233]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 12:36:42 volumio-dormitory sudo[5233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:42 volumio-dormitory volumio[993]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 12:36:42 volumio-dormitory volumio[993]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:42 volumio-dormitory volumio[993]: info: QobuzConnect: setDeactiveState invoked Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:42 volumio-dormitory sudo[5244]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:42 volumio-dormitory sudo[5244]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 09 12:36:42 volumio-dormitory volumio[993]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 09 12:36:42 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 09 12:36:42 volumio-dormitory volumio[993]: info: Disabling external Volume Control Jan 09 12:36:42 volumio-dormitory sudo[5228]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:42 volumio-dormitory sudo[5271]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:42 volumio-dormitory sudo[5271]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:42 volumio-dormitory sudo[5273]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:42 volumio-dormitory sudo[5273]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:42 volumio-dormitory sudo[5275]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:42 volumio-dormitory sudo[5275]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:42 volumio-dormitory sudo[5244]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:42 volumio-dormitory sudo[5286]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 09 12:36:42 volumio-dormitory sudo[5286]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:42 volumio-dormitory sudo[5293]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 09 12:36:42 volumio-dormitory sudo[5293]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory volumio[993]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 09 12:36:43 volumio-dormitory volumio[993]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 09 12:36:43 volumio-dormitory volumio[993]: info: Reading ALSA contributions from plugins. Jan 09 12:36:43 volumio-dormitory sudo[5300]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 09 12:36:43 volumio-dormitory sudo[5300]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:43 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:43 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:43 volumio-dormitory volumio[993]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jan 09 12:36:43 volumio-dormitory volumio[993]: info: MPD Permissions set Jan 09 12:36:43 volumio-dormitory volumio[993]: info: MPD Permissions set Jan 09 12:36:43 volumio-dormitory volumio[993]: info: Shairport-Sync Started Jan 09 12:36:43 volumio-dormitory sudo[5286]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory sudo[5293]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:43 volumio-dormitory sudo[5273]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory sudo[5271]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:43 volumio-dormitory sudo[5303]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 09 12:36:43 volumio-dormitory sudo[5304]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 09 12:36:43 volumio-dormitory sudo[5304]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory sudo[5303]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: Starting Shairport Sync Jan 09 12:36:43 volumio-dormitory sudo[5275]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:43 volumio-dormitory volumio[993]: info: Starting Shairport Sync Jan 09 12:36:43 volumio-dormitory systemd[1]: mpd.service: Deactivated successfully. Jan 09 12:36:43 volumio-dormitory systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 12:36:43 volumio-dormitory systemd[1]: mpd.service: Consumed 19.356s CPU time. Jan 09 12:36:43 volumio-dormitory volumio[993]: info: Asound.conf file written Jan 09 12:36:43 volumio-dormitory sudo[5323]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 12:36:43 volumio-dormitory sudo[5321]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 12:36:43 volumio-dormitory sudo[5321]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory sudo[5323]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory sudo[5300]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:43 volumio-dormitory sudo[5328]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 09 12:36:43 volumio-dormitory sudo[5328]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory sudo[5329]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 09 12:36:43 volumio-dormitory sudo[5329]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory sudo[5328]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:43 volumio-dormitory qobuz-connect[3868]: 20260109 12:36:43.541 [3868.3868] INFO SampleApp: shat down connection on UNIX socket Jan 09 12:36:43 volumio-dormitory systemd[1]: mpd.socket: Deactivated successfully. Jan 09 12:36:43 volumio-dormitory systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 12:36:43 volumio-dormitory systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 12:36:43 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 09 12:36:43 volumio-dormitory volumio[993]: No state is present for card b1 Jan 09 12:36:43 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 09 12:36:43 volumio-dormitory volumio[993]: /usr/share/alsa/init/bcm2835:14: control element not found Jan 09 12:36:43 volumio-dormitory volumio[993]: No state is present for card b1 Jan 09 12:36:43 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 09 12:36:43 volumio-dormitory volumio[993]: No state is present for card Headphones Jan 09 12:36:43 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 09 12:36:43 volumio-dormitory volumio[993]: /usr/share/alsa/init/bcm2835:20: control element not found Jan 09 12:36:43 volumio-dormitory volumio[993]: No state is present for card Headphones Jan 09 12:36:43 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jan 09 12:36:43 volumio-dormitory volumio[993]: No state is present for card sndrpihifiberry Jan 09 12:36:43 volumio-dormitory volumio[993]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jan 09 12:36:43 volumio-dormitory volumio[993]: Found hardware: "RPi-simple" "" "" "" "" Jan 09 12:36:43 volumio-dormitory volumio[993]: Hardware is initialized using a generic method Jan 09 12:36:43 volumio-dormitory volumio[993]: No state is present for card sndrpihifiberry Jan 09 12:36:43 volumio-dormitory volumio[993]: info: Output device has changed, restarting MPD Jan 09 12:36:43 volumio-dormitory volumio[993]: info: Output device has changed, restarting Shairport Sync Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:43 volumio-dormitory sudo[5337]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 12:36:43 volumio-dormitory sudo[5337]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 12:36:43 volumio-dormitory sudo[5339]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 12:36:43 volumio-dormitory sudo[5339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 12:36:43 volumio-dormitory volumio[993]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 12:36:43 volumio-dormitory volumio[993]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory sudo[5337]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:43 volumio-dormitory systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 09 12:36:43 volumio-dormitory volumio[993]: info: QobuzConnect: setDeactiveState invoked Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:43 volumio-dormitory volumio[993]: info: Preparing to generate the ALSA configuration file Jan 09 12:36:43 volumio-dormitory systemd[1]: qobuz-connect.service: Deactivated successfully. Jan 09 12:36:43 volumio-dormitory systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jan 09 12:36:43 volumio-dormitory systemd[1]: shairport-sync.service: Deactivated successfully. Jan 09 12:36:43 volumio-dormitory systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 12:36:43 volumio-dormitory systemd[1]: shairport-sync.service: Consumed 1.116s CPU time. Jan 09 12:36:43 volumio-dormitory sudo[5350]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:43 volumio-dormitory sudo[5350]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory sudo[5354]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:43 volumio-dormitory sudo[5354]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory volumio[993]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 09 12:36:43 volumio-dormitory volumio[993]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 09 12:36:43 volumio-dormitory volumio[993]: info: Reading ALSA contributions from plugins. Jan 09 12:36:43 volumio-dormitory volumio[993]: info: MPD Permissions set Jan 09 12:36:43 volumio-dormitory sudo[5359]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 09 12:36:43 volumio-dormitory sudo[5359]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:43 volumio-dormitory volumio[993]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jan 09 12:36:43 volumio-dormitory volumio[993]: info: QobuzConnect: setDeactiveState invoked Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:43 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:43 volumio-dormitory systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jan 09 12:36:43 volumio-dormitory volumio[993]: info: Starting Shairport Sync Jan 09 12:36:43 volumio-dormitory sudo[5304]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:43 volumio-dormitory sudo[5170]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:43 volumio-dormitory systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 12:36:43 volumio-dormitory sudo[5303]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:43 volumio-dormitory sudo[5329]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory sudo[5171]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory sudo[5321]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory sudo[5323]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory systemd[1]: mpd.service: Deactivated successfully. Jan 09 12:36:44 volumio-dormitory systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Shairport-Sync Started Jan 09 12:36:44 volumio-dormitory sudo[5371]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 12:36:44 volumio-dormitory sudo[5371]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory volumio[993]: (node:993) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 09 12:36:44 volumio-dormitory volumio[993]: (Use `node --trace-warnings ...` to show where the warning was created) Jan 09 12:36:44 volumio-dormitory volumio[993]: (node:993) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 09 12:36:44 volumio-dormitory volumio[993]: (node:993) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 09 12:36:44 volumio-dormitory volumio[993]: (node:993) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 09 12:36:44 volumio-dormitory volumio[993]: (node:993) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Shairport-Sync Started Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Asound.conf file unchanged, so no further update is needed Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Output device has changed, restarting MPD Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Output device has changed, restarting Shairport Sync Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:44 volumio-dormitory sudo[5374]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 12:36:44 volumio-dormitory sudo[5374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory sudo[5350]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory sudo[5359]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory systemd[1]: mpd.socket: Deactivated successfully. Jan 09 12:36:44 volumio-dormitory sudo[5390]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 12:36:44 volumio-dormitory sudo[5390]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory sudo[5376]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 12:36:44 volumio-dormitory systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 12:36:44 volumio-dormitory systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 12:36:44 volumio-dormitory sudo[5376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 12:36:44 volumio-dormitory volumio[993]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory sudo[5376]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory sudo[5398]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 09 12:36:44 volumio-dormitory sudo[5398]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 12:36:44 volumio-dormitory volumio[993]: info: QobuzConnect: setDeactiveState invoked Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:44 volumio-dormitory systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 12:36:44 volumio-dormitory systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 09 12:36:44 volumio-dormitory systemd[1]: shairport-sync.service: Deactivated successfully. Jan 09 12:36:44 volumio-dormitory systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Preparing to generate the ALSA configuration file Jan 09 12:36:44 volumio-dormitory sudo[5408]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:44 volumio-dormitory sudo[5408]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory sudo[5354]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory sudo[5411]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:44 volumio-dormitory sudo[5411]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory volumio[993]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 09 12:36:44 volumio-dormitory volumio[993]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Reading ALSA contributions from plugins. Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Executing endpoint qc_getconfig Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 09 12:36:44 volumio-dormitory sudo[5418]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 09 12:36:44 volumio-dormitory sudo[5418]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory qobuz-connect[5362]: 20260109 12:36:44.592 [5362.5362] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 09 12:36:44 volumio-dormitory volumio[993]: info: MPD Permissions set Jan 09 12:36:44 volumio-dormitory volumio[993]: info: TidalConnect service stoped! Jan 09 12:36:44 volumio-dormitory qobuz-connect[5362]: 20260109 12:36:44.607 [5362.5362] INFO VolumeManager: [0xc43258]: Setting new playback volume: 75 Jan 09 12:36:44 volumio-dormitory qobuz-connect[5362]: 20260109 12:36:44.608 [5362.5362] INFO VolumeManager: [0xc43258]: Setting new mute state: 0 Jan 09 12:36:44 volumio-dormitory qobuz-connect[5362]: 20260109 12:36:44.608 [5362.5362] INFO QobuzConnect: [0xc43c28]: Client initialized! Jan 09 12:36:44 volumio-dormitory qobuz-connect[5362]: 20260109 12:36:44.609 [5362.5362] INFO SampleApp: Starting Avahi advertising, name: Volumio-Dormitory, service name: _qobuz-connect._tcp Jan 09 12:36:44 volumio-dormitory volumio[993]: info: TidalConnect service stoped! Jan 09 12:36:44 volumio-dormitory volumio[993]: info: TidalConnect service stoped! Jan 09 12:36:44 volumio-dormitory volumio[993]: info: TidalConnect service stoped! Jan 09 12:36:44 volumio-dormitory volumio[993]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 09 12:36:44 volumio-dormitory volumio[993]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory qobuz-connect[5362]: 20260109 12:36:44.649 [5362.5362] INFO LocalConfigManager: [0xc42b38]: Starting Local Configuration server Jan 09 12:36:44 volumio-dormitory qobuz-connect[5362]: 20260109 12:36:44.649 [5362.5362] INFO SampleApp: Starting Local configuration server Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jan 09 12:36:44 volumio-dormitory qobuz-connect[5362]: 20260109 12:36:44.653 [5362.5362] INFO SampleApp: Stopping Local configuration server Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Starting Shairport Sync Jan 09 12:36:44 volumio-dormitory systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 09 12:36:44 volumio-dormitory sudo[5371]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Shairport-Sync Started Jan 09 12:36:44 volumio-dormitory systemd[1]: mpd.service: Deactivated successfully. Jan 09 12:36:44 volumio-dormitory systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Asound.conf file unchanged, so no further update is needed Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Output device has changed, restarting MPD Jan 09 12:36:44 volumio-dormitory sudo[5451]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 09 12:36:44 volumio-dormitory sudo[5451]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory sudo[5449]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 12:36:44 volumio-dormitory sudo[5449]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory sudo[5418]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory sudo[5408]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory volumio[993]: info: Output device has changed, restarting Shairport Sync Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:44 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:44 volumio-dormitory sudo[5470]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 09 12:36:44 volumio-dormitory sudo[5468]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 12:36:44 volumio-dormitory sudo[5468]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory sudo[5470]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory sudo[5474]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 12:36:44 volumio-dormitory sudo[5474]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:44 volumio-dormitory sudo[5468]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:44 volumio-dormitory sudo[5411]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:45 volumio-dormitory volumio[993]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 12:36:45 volumio-dormitory volumio[993]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:45 volumio-dormitory volumio[993]: info: QobuzConnect: setDeactiveState invoked Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:45 volumio-dormitory sudo[5485]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:45 volumio-dormitory sudo[5485]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:45 volumio-dormitory sudo[5487]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 12:36:45 volumio-dormitory sudo[5487]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:45 volumio-dormitory systemd[1]: mpd.socket: Deactivated successfully. Jan 09 12:36:45 volumio-dormitory systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 12:36:45 volumio-dormitory systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 12:36:45 volumio-dormitory volumio[993]: info: MPD Permissions set Jan 09 12:36:45 volumio-dormitory sudo[5496]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 09 12:36:45 volumio-dormitory volumio[993]: info: VolumeController::SetAlsaVolume100 Jan 09 12:36:45 volumio-dormitory sudo[5496]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreStateMachine::pushState Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioPushState Jan 09 12:36:45 volumio-dormitory systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 12:36:45 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output update for this device Jan 09 12:36:45 volumio-dormitory volumio[993]: info: MRS: Pushing multiroomSync output Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::volumioGetState Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CorePlayQueue::getTrack 0 Jan 09 12:36:45 volumio-dormitory sudo[5498]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 09 12:36:45 volumio-dormitory systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 12:36:45 volumio-dormitory sudo[5498]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:45 volumio-dormitory systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 09 12:36:45 volumio-dormitory systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jan 09 12:36:45 volumio-dormitory volumio[993]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'SoftMaster',0 Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:45 volumio-dormitory sudo[5451]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:45 volumio-dormitory systemd[1]: shairport-sync.service: Deactivated successfully. Jan 09 12:36:45 volumio-dormitory systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 12:36:45 volumio-dormitory volumio[993]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 12:36:45 volumio-dormitory volumio[993]: info: Starting Shairport Sync Jan 09 12:36:45 volumio-dormitory volumio[993]: info: TidalConnect service stoped! Jan 09 12:36:45 volumio-dormitory sudo[5512]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 12:36:45 volumio-dormitory sudo[5512]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:45 volumio-dormitory sudo[5496]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:45 volumio-dormitory sudo[5514]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 09 12:36:45 volumio-dormitory sudo[5514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 12:36:45 volumio-dormitory sudo[5485]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:45 volumio-dormitory sudo[5487]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:45 volumio-dormitory volumio[993]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 12:36:45 volumio-dormitory systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 12:36:45 volumio-dormitory sudo[5512]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:45 volumio-dormitory sudo[5449]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:45 volumio-dormitory sudo[5498]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:45 volumio-dormitory sudo[5501]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 12:36:45 volumio-dormitory sudo[5501]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 09 12:36:45 volumio-dormitory sudo[5501]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:45 volumio-dormitory volumio[993]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Jan 09 12:36:45 volumio-dormitory volumio[993]: Job for vtcs.service canceled. Jan 09 12:36:45 volumio-dormitory volumio[993]: at ChildProcess.exithandler (node:child_process:421:12) Jan 09 12:36:45 volumio-dormitory volumio[993]: at ChildProcess.emit (node:events:514:28) Jan 09 12:36:45 volumio-dormitory volumio[993]: at maybeClose (node:internal/child_process:1105:16) Jan 09 12:36:45 volumio-dormitory volumio[993]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) { Jan 09 12:36:45 volumio-dormitory volumio[993]: code: 1, Jan 09 12:36:45 volumio-dormitory volumio[993]: killed: false, Jan 09 12:36:45 volumio-dormitory volumio[993]: signal: null, Jan 09 12:36:45 volumio-dormitory volumio[993]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3', Jan 09 12:36:45 volumio-dormitory volumio[993]: stdout: '', Jan 09 12:36:45 volumio-dormitory volumio[993]: stderr: 'Job for vtcs.service canceled.\n' Jan 09 12:36:45 volumio-dormitory volumio[993]: } Jan 09 12:36:45 volumio-dormitory volumio[993]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 12:36:46 volumio-dormitory qobuz-connect[5362]: 20260109 12:36:46.664 [5362.5362] INFO SampleApp: shat down connection on UNIX socket Jan 09 12:36:46 volumio-dormitory systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=11/SEGV Jan 09 12:36:46 volumio-dormitory systemd[1]: qobuz-connect.service: Failed with result 'signal'. Jan 09 12:36:46 volumio-dormitory systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jan 09 12:36:46 volumio-dormitory systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jan 09 12:36:46 volumio-dormitory sudo[5398]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:46 volumio-dormitory sudo[5470]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:46 volumio-dormitory sudo[5514]: pam_unix(sudo:session): session closed for user root Jan 09 12:36:50 volumio-dormitory sudo[5565]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 12:35' Jan 09 12:36:50 volumio-dormitory sudo[5565]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"