-- Logs begin at Thu 2026-03-26 16:56:24 +05, end at Thu 2026-03-26 16:59:33 +05. -- Mar 26 16:58:03 volumio volumio[1240]: info: Preload queue cleared Mar 26 16:58:03 volumio volumio[1240]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::ClearQueue Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::stop Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:58:03 volumio volumio[1240]: info: CorePlayQueue::clearPlayQueue Mar 26 16:58:03 volumio volumio[1240]: info: CorePlayQueue::saveQueue Mar 26 16:58:03 volumio volumio[1240]: info: CoreCommandRouter::volumioPushQueue Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::addQueueItems Mar 26 16:58:03 volumio volumio[1240]: info: CorePlayQueue::addQueueItems Mar 26 16:58:03 volumio volumio[1240]: info: Preload queue cleared Mar 26 16:58:03 volumio volumio[1240]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012 Mar 26 16:58:03 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 26 16:58:03 volumio volumio[1240]: info: CoreCommandRouter::volumioPushQueue Mar 26 16:58:03 volumio volumio[1240]: info: CorePlayQueue::saveQueue Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::updateTrackBlock Mar 26 16:58:03 volumio volumio[1240]: info: CorePlayQueue::getTrackBlock Mar 26 16:58:03 volumio volumio[1240]: info: CoreCommandRouter::volumioPlay Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::play index 0 Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::stop Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::play index undefined Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:58:03 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:03 volumio volumio[1240]: info: CoreStateMachine::startPlaybackTimer Mar 26 16:58:03 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:03 volumio volumio[1240]: info: [1774526283278] ControllerWebradio::clearAddPlayTrack Mar 26 16:58:03 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 16:58:03 volumio volumio[1240]: info: sendMpdCommand stop took 5 milliseconds Mar 26 16:58:03 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand clear Mar 26 16:58:03 volumio volumio[1240]: info: Mar 26 16:58:03 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:03 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:03 volumio volumio[1240]: info: sendMpdCommand clear took 3 milliseconds Mar 26 16:58:03 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" Mar 26 16:58:03 volumio volumio[1240]: info: Mar 26 16:58:03 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:03 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:03 volumio volumio[1240]: info: Mar 26 16:58:03 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:03 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:03 volumio volumio[1240]: error: updateQueue error: null Mar 26 16:58:03 volumio volumio[1240]: info: ------------------------------ 10ms Mar 26 16:58:04 volumio volumio[1240]: info: Preload queue cleared Mar 26 16:58:04 volumio volumio[1240]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::ClearQueue Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::stop Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:58:04 volumio volumio[1240]: info: CorePlayQueue::clearPlayQueue Mar 26 16:58:04 volumio volumio[1240]: info: CorePlayQueue::saveQueue Mar 26 16:58:04 volumio volumio[1240]: info: CoreCommandRouter::volumioPushQueue Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::addQueueItems Mar 26 16:58:04 volumio volumio[1240]: info: CorePlayQueue::addQueueItems Mar 26 16:58:04 volumio volumio[1240]: info: Preload queue cleared Mar 26 16:58:04 volumio volumio[1240]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012 Mar 26 16:58:04 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 26 16:58:04 volumio volumio[1240]: info: CoreCommandRouter::volumioPushQueue Mar 26 16:58:04 volumio volumio[1240]: info: CorePlayQueue::saveQueue Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::updateTrackBlock Mar 26 16:58:04 volumio volumio[1240]: info: CorePlayQueue::getTrackBlock Mar 26 16:58:04 volumio volumio[1240]: info: CoreCommandRouter::volumioPlay Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::play index 0 Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::stop Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::play index undefined Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:58:04 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::startPlaybackTimer Mar 26 16:58:04 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:04 volumio volumio[1240]: info: [1774526284376] ControllerWebradio::clearAddPlayTrack Mar 26 16:58:04 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 16:58:04 volumio volumio[1240]: info: Mar 26 16:58:04 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:04 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:04 volumio volumio[1240]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" took 1257 milliseconds Mar 26 16:58:04 volumio volumio[1240]: info: ------------------------------ 1256ms Mar 26 16:58:04 volumio volumio[1240]: info: ------------------------------ 1254ms Mar 26 16:58:04 volumio volumio[1240]: info: sendMpdCommand stop took 171 milliseconds Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 26 16:58:04 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand play Mar 26 16:58:04 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand clear Mar 26 16:58:04 volumio volumio[1240]: info: Mar 26 16:58:04 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:04 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:04 volumio volumio[1240]: info: Mar 26 16:58:04 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:04 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:04 volumio volumio[1240]: info: ------------------------------ 9ms Mar 26 16:58:04 volumio volumio[1240]: info: sendMpdCommand play took 10 milliseconds Mar 26 16:58:04 volumio volumio[1240]: error: updateQueue error: null Mar 26 16:58:04 volumio volumio[1240]: info: Mar 26 16:58:04 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:04 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:04 volumio volumio[1240]: info: Mar 26 16:58:04 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:04 volumio volumio[1240]: info: sendMpdCommand clear took 349 milliseconds Mar 26 16:58:04 volumio volumio[1240]: info: ------------------------------ 348ms Mar 26 16:58:04 volumio volumio[1240]: info: ------------------------------ 347ms Mar 26 16:58:04 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:04 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:04 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" Mar 26 16:58:04 volumio volumio[1240]: info: Mar 26 16:58:04 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:04 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:04 volumio volumio[1240]: info: Mar 26 16:58:04 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:04 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:04 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:04 volumio volumio[1240]: info: Mar 26 16:58:04 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:04 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:04 volumio volumio[1240]: info: Mar 26 16:58:04 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:04 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:04 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:04 volumio volumio[1240]: error: updateQueue error: null Mar 26 16:58:04 volumio volumio[1240]: info: ------------------------------ 8ms Mar 26 16:58:04 volumio volumio[1240]: info: sendMpdCommand status took 7 milliseconds Mar 26 16:58:04 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:04 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:04 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:04 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:04 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:04 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:04 volumio volumio[1240]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 16:58:04 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::syncState stateService stop Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus stop Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:04 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:04 volumio volumio[1240]: info: No code Mar 26 16:58:04 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:04 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:04 volumio volumio[1240]: info: ------------------------------ 33ms Mar 26 16:58:05 volumio volumio[1240]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" took 139 milliseconds Mar 26 16:58:05 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 26 16:58:05 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand play Mar 26 16:58:05 volumio volumio[1240]: info: Mar 26 16:58:05 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:05 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:05 volumio volumio[1240]: info: ------------------------------ 141ms Mar 26 16:58:05 volumio volumio[1240]: info: sendMpdCommand status took 139 milliseconds Mar 26 16:58:05 volumio volumio[1240]: info: ------------------------------ 140ms Mar 26 16:58:05 volumio volumio[1240]: info: sendMpdCommand status took 138 milliseconds Mar 26 16:58:05 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:05 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:05 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:05 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:05 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:05 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:05 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:05 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:05 volumio volumio[1240]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 16:58:05 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:05 volumio volumio[1240]: info: CoreStateMachine::syncState stateService stop Mar 26 16:58:05 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus stop Mar 26 16:58:05 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:05 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:05 volumio volumio[1240]: info: No code Mar 26 16:58:05 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:05 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:05 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:05 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:05 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:05 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:05 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:05 volumio volumio[1240]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 16:58:05 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:05 volumio volumio[1240]: info: CoreStateMachine::syncState stateService stop Mar 26 16:58:05 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus stop Mar 26 16:58:05 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:05 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:05 volumio volumio[1240]: info: No code Mar 26 16:58:05 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:05 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:05 volumio volumio[1240]: info: ------------------------------ 174ms Mar 26 16:58:05 volumio volumio[1240]: info: ------------------------------ 173ms Mar 26 16:58:05 volumio volumio[1240]: info: Mar 26 16:58:05 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:05 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:05 volumio volumio[1240]: info: Mar 26 16:58:05 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:05 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:05 volumio volumio[1240]: info: sendMpdCommand play took 41 milliseconds Mar 26 16:58:05 volumio volumio[1240]: info: ------------------------------ 42ms Mar 26 16:58:05 volumio volumio[1240]: info: ------------------------------ 4ms Mar 26 16:58:05 volumio volumio[1240]: info: ------------------------------ 3ms Mar 26 16:58:07 volumio volumio[1240]: info: Mar 26 16:58:07 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:07 volumio volumio[1240]: info: Mar 26 16:58:07 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:07 volumio volumio[1240]: info: Mar 26 16:58:07 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:07 volumio volumio[1240]: info: sendMpdCommand status took 21 milliseconds Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:07 volumio volumio[1240]: info: Mar 26 16:58:07 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:07 volumio volumio[1240]: info: sendMpdCommand status took 28 milliseconds Mar 26 16:58:07 volumio volumio[1240]: info: sendMpdCommand status took 27 milliseconds Mar 26 16:58:07 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:07 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:07 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rockantenne","artist":"(#1 - 1982/500000) ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:07 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus stop Mar 26 16:58:07 volumio volumio[1240]: info: ------------------------------ 36ms Mar 26 16:58:07 volumio volumio[1240]: info: Mar 26 16:58:07 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:07 volumio volumio[1240]: info: Mar 26 16:58:07 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:07 volumio volumio[1240]: info: sendMpdCommand status took 10 milliseconds Mar 26 16:58:07 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 26 16:58:07 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 26 16:58:07 volumio volumio[1240]: info: sendMpdCommand status took 3 milliseconds Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:07 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:07 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rockantenne","artist":"(#1 - 1982/500000) ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:07 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:07 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:07 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:07 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rockantenne","artist":"(#1 - 1982/500000) ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:07 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:07 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:07 volumio volumio[1240]: info: ------------------------------ 81ms Mar 26 16:58:07 volumio volumio[1240]: info: ------------------------------ 80ms Mar 26 16:58:07 volumio volumio[1240]: info: Mar 26 16:58:07 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:07 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:07 volumio volumio[1240]: info: Mar 26 16:58:07 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:07 volumio volumio[1240]: info: sendMpdCommand status took 50 milliseconds Mar 26 16:58:07 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 48 milliseconds Mar 26 16:58:07 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 47 milliseconds Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:07 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:07 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:07 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rockantenne","artist":"(#1 - 1982/500000) ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:07 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:07 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:07 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:07 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:07 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rockantenne","artist":"(#1 - 1982/500000) ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:07 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:07 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:07 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 95ms Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 89ms Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:08 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:08 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:08 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 52ms Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand status took 50 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 51 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 7ms Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand status took 5 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 5ms Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand status took 5 milliseconds Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:08 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:08 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:08 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:08 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 121ms Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:08 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:08 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 33ms Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand status took 31 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 30 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 29 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 28 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 12ms Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand status took 8 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 7ms Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand status took 5 milliseconds Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:08 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:08 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:08 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:08 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:08 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:08 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:08 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:08 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:08 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:08 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:08 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:08 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 165ms Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 119ms Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 117ms Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 84 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 86 milliseconds Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:08 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:08 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:08 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:08 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:08 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:08 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:08 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:08 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:08 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:08 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:08 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:08 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 186ms Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 165ms Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 161ms Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:08 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:08 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:08 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:08 volumio volumio[1240]: info: Mar 26 16:58:08 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 5ms Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand status took 4 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 3ms Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand status took 2 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 3ms Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand status took 2 milliseconds Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 26 16:58:08 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:58:08 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:08 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:08 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:08 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:08 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:08 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:08 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:08 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:08 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:08 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:08 volumio volumio[1240]: info: ------------------------------ 38ms Mar 26 16:58:09 volumio volumio[1240]: info: ------------------------------ 42ms Mar 26 16:58:09 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 40 milliseconds Mar 26 16:58:09 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:58:09 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:09 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:09 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:09 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:09 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:09 volumio volumio[1240]: info: ------------------------------ 62ms Mar 26 16:58:09 volumio thd[789]: Executing trigger action: /usr/local/bin/volumio volume minus Mar 26 16:58:09 volumio volumio[1240]: info: Mar 26 16:58:09 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:09 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:09 volumio volumio[1240]: info: Mar 26 16:58:09 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:09 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:09 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:09 volumio volumio[1240]: info: Mar 26 16:58:09 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:09 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:09 volumio volumio[1240]: info: Mar 26 16:58:09 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:09 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:09 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:09 volumio volumio[1240]: info: Mar 26 16:58:09 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:58:09 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:58:09 volumio volumio[1240]: info: Mar 26 16:58:09 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:58:09 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:58:09 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:58:09 volumio volumio[1240]: info: ------------------------------ 23ms Mar 26 16:58:09 volumio volumio[1240]: info: sendMpdCommand status took 20 milliseconds Mar 26 16:58:09 volumio volumio[1240]: info: ------------------------------ 20ms Mar 26 16:58:09 volumio volumio[1240]: info: sendMpdCommand status took 9 milliseconds Mar 26 16:58:09 volumio volumio[1240]: info: ------------------------------ 4ms Mar 26 16:58:09 volumio volumio[1240]: info: sendMpdCommand status took 2 milliseconds Mar 26 16:58:09 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:09 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:09 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:09 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:09 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:58:09 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:58:09 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 26 16:58:09 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 26 16:58:09 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 26 16:58:09 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:58:09 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:09 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:09 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2587,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:09 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:09 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:09 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:09 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:09 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2587,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:09 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:09 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:09 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:09 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:09 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:58:09 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:58:09 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2587,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 16:58:09 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:58:09 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:09 volumio volumio[1240]: info: ------------------------------ 96ms Mar 26 16:58:09 volumio volumio[1240]: info: ------------------------------ 94ms Mar 26 16:58:09 volumio volumio[1240]: info: ------------------------------ 81ms Mar 26 16:58:09 volumio volumio[1240]: info: Mar 26 16:58:09 volumio volumio[1240]: ---------------------------- Client requests Volume - Mar 26 16:58:09 volumio volumio[1240]: info: VolumeController::SetAlsaVolume- Mar 26 16:58:09 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:09 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:09 volumio thd[789]: [158B blob data] Mar 26 16:58:10 volumio thd[789]: {"time":1774526289782,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Mar 26 16:58:10 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:10 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:10 volumio volumio[1240]: info: Mar 26 16:58:10 volumio volumio[1240]: ---------------------------- Client requests Volume - Mar 26 16:58:10 volumio volumio[1240]: info: VolumeController::SetAlsaVolume- Mar 26 16:58:10 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:10 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:10 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:10 volumio thd[789]: [158B blob data] Mar 26 16:58:10 volumio thd[789]: {"time":1774526290154,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Mar 26 16:58:10 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:10 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:10 volumio volumio[1240]: info: Mar 26 16:58:10 volumio volumio[1240]: ---------------------------- Client requests Volume - Mar 26 16:58:10 volumio volumio[1240]: info: VolumeController::SetAlsaVolume- Mar 26 16:58:10 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:10 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:10 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:10 volumio thd[789]: [158B blob data] Mar 26 16:58:10 volumio thd[789]: {"time":1774526290481,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Mar 26 16:58:10 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:10 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:10 volumio volumio[1240]: info: Mar 26 16:58:10 volumio volumio[1240]: ---------------------------- Client requests Volume - Mar 26 16:58:10 volumio volumio[1240]: info: VolumeController::SetAlsaVolume- Mar 26 16:58:10 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:10 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:10 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:10 volumio thd[789]: [158B blob data] Mar 26 16:58:11 volumio thd[789]: {"time":1774526290849,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Mar 26 16:58:11 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:11 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:11 volumio volumio[1240]: info: Mar 26 16:58:11 volumio volumio[1240]: ---------------------------- Client requests Volume - Mar 26 16:58:11 volumio volumio[1240]: info: VolumeController::SetAlsaVolume- Mar 26 16:58:11 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:11 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:11 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:11 volumio thd[789]: [158B blob data] Mar 26 16:58:11 volumio thd[789]: {"time":1774526291203,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:11 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:11 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:11 volumio volumio[1240]: info: Mar 26 16:58:11 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:11 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:12 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:12 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:12 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:12 volumio thd[789]: [158B blob data] Mar 26 16:58:12 volumio thd[789]: {"time":1774526291981,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:12 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:12 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:12 volumio volumio[1240]: info: Mar 26 16:58:12 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:12 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:12 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:12 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:12 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:12 volumio thd[789]: [158B blob data] Mar 26 16:58:12 volumio thd[789]: {"time":1774526292360,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:12 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:12 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:12 volumio volumio[1240]: info: Mar 26 16:58:12 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:12 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:12 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:12 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:12 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:12 volumio thd[789]: [158B blob data] Mar 26 16:58:12 volumio thd[789]: {"time":1774526292665,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:12 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:12 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:12 volumio volumio[1240]: info: Mar 26 16:58:12 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:12 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:12 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:12 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:12 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:12 volumio thd[789]: [158B blob data] Mar 26 16:58:13 volumio thd[789]: {"time":1774526292882,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:13 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:13 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:13 volumio volumio[1240]: info: Mar 26 16:58:13 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:13 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:13 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:13 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:13 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:13 volumio thd[789]: [158B blob data] Mar 26 16:58:13 volumio thd[789]: {"time":1774526293207,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:13 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:13 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:13 volumio volumio[1240]: info: Mar 26 16:58:13 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:13 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:13 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:13 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:13 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:13 volumio thd[789]: [158B blob data] Mar 26 16:58:13 volumio thd[789]: {"time":1774526293524,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:13 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:13 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:13 volumio volumio[1240]: info: Mar 26 16:58:13 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:13 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:13 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:13 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:13 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:13 volumio thd[789]: [158B blob data] Mar 26 16:58:15 volumio thd[789]: {"time":1774526293836,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:15 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:15 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:15 volumio volumio[1240]: info: Mar 26 16:58:15 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:15 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:15 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:15 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:15 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:15 volumio thd[789]: [237B blob data] Mar 26 16:58:15 volumio thd[789]: {"time":1774526295251,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:15 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:15 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:15 volumio volumio[1240]: info: Mar 26 16:58:15 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:15 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:15 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:15 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:15 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:15 volumio thd[789]: [158B blob data] Mar 26 16:58:15 volumio thd[789]: {"time":1774526295530,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:15 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:15 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:15 volumio volumio[1240]: info: Mar 26 16:58:15 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:15 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:15 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:15 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:15 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:15 volumio thd[789]: [158B blob data] Mar 26 16:58:16 volumio thd[789]: {"time":1774526295831,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:16 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:16 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:16 volumio volumio[1240]: info: Mar 26 16:58:16 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:16 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:16 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:16 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:16 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:16 volumio thd[789]: [158B blob data] Mar 26 16:58:16 volumio thd[789]: {"time":1774526296084,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:16 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:16 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:16 volumio volumio[1240]: info: Mar 26 16:58:16 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:16 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:16 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:16 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:16 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:16 volumio thd[789]: [158B blob data] Mar 26 16:58:16 volumio thd[789]: {"time":1774526296375,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:16 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:16 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:16 volumio volumio[1240]: info: Mar 26 16:58:16 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:16 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:16 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:16 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:16 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:16 volumio thd[789]: [158B blob data] Mar 26 16:58:16 volumio thd[789]: {"time":1774526296666,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:16 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:16 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:16 volumio volumio[1240]: info: Mar 26 16:58:16 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:16 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:16 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:16 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:16 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:16 volumio thd[789]: [158B blob data] Mar 26 16:58:17 volumio thd[789]: {"time":1774526296952,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:17 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:17 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:17 volumio volumio[1240]: info: Mar 26 16:58:17 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:17 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:17 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:17 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:17 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:17 volumio thd[789]: [237B blob data] Mar 26 16:58:17 volumio thd[789]: {"time":1774526297250,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:17 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:17 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:17 volumio volumio[1240]: info: Mar 26 16:58:17 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:17 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:17 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:17 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:17 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:17 volumio thd[789]: [158B blob data] Mar 26 16:58:17 volumio thd[789]: {"time":1774526297564,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:17 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:17 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:17 volumio volumio[1240]: info: Mar 26 16:58:17 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:17 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:17 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:17 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:17 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:17 volumio thd[789]: [158B blob data] Mar 26 16:58:18 volumio thd[789]: {"time":1774526297918,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:18 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:18 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:18 volumio volumio[1240]: info: Mar 26 16:58:18 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:18 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:18 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:18 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:18 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:18 volumio thd[789]: [158B blob data] Mar 26 16:58:18 volumio thd[789]: {"time":1774526298345,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:18 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:18 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:18 volumio volumio[1240]: info: Mar 26 16:58:18 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:18 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:18 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:18 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:18 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:18 volumio thd[789]: [158B blob data] Mar 26 16:58:19 volumio thd[789]: {"time":1774526298772,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:19 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:19 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:19 volumio volumio[1240]: info: Mar 26 16:58:19 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:19 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:19 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:19 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:19 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:19 volumio thd[789]: [158B blob data] Mar 26 16:58:19 volumio thd[789]: {"time":1774526299168,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:19 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:19 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:19 volumio volumio[1240]: info: Mar 26 16:58:19 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:19 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:19 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:19 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:19 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:19 volumio thd[789]: [158B blob data] Mar 26 16:58:19 volumio thd[789]: {"time":1774526299504,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:19 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:19 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:19 volumio volumio[1240]: info: Mar 26 16:58:19 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:19 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:19 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:19 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:19 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:19 volumio thd[789]: [158B blob data] Mar 26 16:58:20 volumio thd[789]: {"time":1774526299848,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Mar 26 16:58:20 volumio thd[789]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 26 16:58:20 volumio thd[789]: Dload Upload Total Spent Left Speed Mar 26 16:58:20 volumio volumio[1240]: info: Mar 26 16:58:20 volumio volumio[1240]: ---------------------------- Client requests Volume + Mar 26 16:58:20 volumio volumio[1240]: info: VolumeController::SetAlsaVolume+ Mar 26 16:58:20 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:58:20 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:58:20 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:58:20 volumio thd[789]: [158B blob data] Mar 26 16:58:27 volumio volumio[1240]: info: CoreCommandRouter::volumioGetState Mar 26 16:59:13 volumio volumio[1240]: info: CoreCommandRouter::volumioGetState Mar 26 16:59:22 volumio volumio[1240]: info: Preload queue cleared Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::ClearQueue Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::stop Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::stPlaybackTimer Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::updateTrackBlock Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::getTrackBlock Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::serviceStop Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::serviceStop Mar 26 16:59:22 volumio volumio[1240]: info: [1774526362871] ControllerWebradio::stop Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::clearPlayQueue Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::saveQueue Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::volumioPushQueue Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::addQueueItems Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::addQueueItems Mar 26 16:59:22 volumio volumio[1240]: info: Preload queue cleared Mar 26 16:59:22 volumio volumio[1240]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568323 Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::volumioPushQueue Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::saveQueue Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::updateTrackBlock Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::getTrackBlock Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::volumioPlay Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::play index 0 Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::stop Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::play index undefined Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::startPlaybackTimer Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:22 volumio volumio[1240]: info: [1774526362902] ControllerWebradio::clearAddPlayTrack Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 16:59:22 volumio volumio[1240]: info: Mar 26 16:59:22 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:22 volumio volumio[1240]: info: sendMpdCommand stop took 41 milliseconds Mar 26 16:59:22 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:22 volumio volumio[1240]: info: sendMpdCommand stop took 14 milliseconds Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand clear Mar 26 16:59:22 volumio volumio[1240]: info: Mar 26 16:59:22 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:22 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:22 volumio volumio[1240]: info: Mar 26 16:59:22 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:22 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:22 volumio volumio[1240]: info: Mar 26 16:59:22 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:22 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:22 volumio volumio[1240]: info: sendMpdCommand status took 10 milliseconds Mar 26 16:59:22 volumio volumio[1240]: info: sendMpdCommand clear took 9 milliseconds Mar 26 16:59:22 volumio volumio[1240]: info: sendMpdCommand status took 8 milliseconds Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568323" Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:22 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:22 volumio volumio[1240]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 26 16:59:22 volumio volumio[1240]: info: ------------------------------ 28ms Mar 26 16:59:22 volumio volumio[1240]: info: Mar 26 16:59:22 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:22 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:22 volumio volumio[1240]: info: Mar 26 16:59:22 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:22 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:22 volumio volumio[1240]: error: updateQueue error: null Mar 26 16:59:22 volumio volumio[1240]: info: sendMpdCommand status took 29 milliseconds Mar 26 16:59:22 volumio volumio[1240]: info: ------------------------------ 29ms Mar 26 16:59:22 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 23 milliseconds Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:22 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:22 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:22 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:22 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:22 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:22 volumio volumio[1240]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 26 16:59:22 volumio volumio[1240]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 26 16:59:22 volumio volumio[1240]: info: ------------------------------ 47ms Mar 26 16:59:22 volumio volumio[1240]: info: ------------------------------ 57ms Mar 26 16:59:23 volumio volumio[1240]: info: Mar 26 16:59:23 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:23 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:23 volumio volumio[1240]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568323" took 618 milliseconds Mar 26 16:59:23 volumio volumio[1240]: info: ------------------------------ 602ms Mar 26 16:59:23 volumio volumio[1240]: info: ------------------------------ 601ms Mar 26 16:59:23 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 26 16:59:23 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand play Mar 26 16:59:23 volumio volumio[1240]: info: Mar 26 16:59:23 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:23 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:23 volumio volumio[1240]: info: Mar 26 16:59:23 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:23 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:23 volumio volumio[1240]: info: ------------------------------ 8ms Mar 26 16:59:23 volumio volumio[1240]: info: sendMpdCommand play took 7 milliseconds Mar 26 16:59:23 volumio volumio[1240]: info: ------------------------------ 6ms Mar 26 16:59:23 volumio volumio[1240]: info: ------------------------------ 5ms Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand status took 5 milliseconds Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand status took 6 milliseconds Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand status took 6 milliseconds Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:25 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:25 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"retrodance.mp3","artist":"(#1 - 3860/32000) Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Mar 26 16:59:25 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus stop Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 16ms Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:25 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:25 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"retrodance.mp3","artist":"(#1 - 3860/32000) Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Mar 26 16:59:25 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:25 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:25 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:25 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"retrodance.mp3","artist":"(#1 - 3860/32000) Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Mar 26 16:59:25 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:25 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 55ms Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:25 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:25 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:25 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:25 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:25 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:25 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:25 volumio volumio[1240]: info: Mar 26 16:59:25 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 55ms Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand status took 53 milliseconds Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 53ms Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand status took 52 milliseconds Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 52ms Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand status took 53 milliseconds Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 21ms Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand status took 18 milliseconds Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 14ms Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand status took 11 milliseconds Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 12ms Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand status took 10 milliseconds Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:25 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:25 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Mar 26 16:59:25 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:25 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:25 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:25 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Mar 26 16:59:25 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:25 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:25 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:25 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Mar 26 16:59:25 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:25 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:25 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:25 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Mar 26 16:59:25 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:25 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:25 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:25 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Mar 26 16:59:25 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:25 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 124ms Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 124ms Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 123ms Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 89ms Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 82ms Mar 26 16:59:25 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 64 milliseconds Mar 26 16:59:25 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:25 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:25 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:25 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Mar 26 16:59:25 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:25 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:25 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:25 volumio volumio[1240]: info: ------------------------------ 98ms Mar 26 16:59:30 volumio volumio[1240]: info: Preload queue cleared Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::ClearQueue Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::stop Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::stPlaybackTimer Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::updateTrackBlock Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::getTrackBlock Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::serviceStop Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::serviceStop Mar 26 16:59:30 volumio volumio[1240]: info: [1774526370710] ControllerWebradio::stop Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::clearPlayQueue Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::saveQueue Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::volumioPushQueue Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::addQueueItems Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::addQueueItems Mar 26 16:59:30 volumio volumio[1240]: info: Preload queue cleared Mar 26 16:59:30 volumio volumio[1240]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::volumioPushQueue Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::saveQueue Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::updateTrackBlock Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::getTrackBlock Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::volumioPlay Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::play index 0 Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::stop Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::play index undefined Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::startPlaybackTimer Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:30 volumio volumio[1240]: info: [1774526370737] ControllerWebradio::clearAddPlayTrack Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 16:59:30 volumio volumio[1240]: info: Mar 26 16:59:30 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:30 volumio volumio[1240]: info: sendMpdCommand stop took 35 milliseconds Mar 26 16:59:30 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:30 volumio volumio[1240]: info: sendMpdCommand stop took 8 milliseconds Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand clear Mar 26 16:59:30 volumio volumio[1240]: info: Mar 26 16:59:30 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:30 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:30 volumio volumio[1240]: info: Mar 26 16:59:30 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:30 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:30 volumio volumio[1240]: info: Mar 26 16:59:30 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:30 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:30 volumio volumio[1240]: info: sendMpdCommand status took 11 milliseconds Mar 26 16:59:30 volumio volumio[1240]: info: sendMpdCommand clear took 8 milliseconds Mar 26 16:59:30 volumio volumio[1240]: info: sendMpdCommand status took 6 milliseconds Mar 26 16:59:30 volumio volumio[1240]: info: sendMpdCommand status took 4 milliseconds Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:30 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:30 volumio volumio[1240]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 26 16:59:30 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:30 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:30 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:30 volumio volumio[1240]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 26 16:59:30 volumio volumio[1240]: info: ------------------------------ 41ms Mar 26 16:59:30 volumio volumio[1240]: info: ------------------------------ 40ms Mar 26 16:59:30 volumio volumio[1240]: info: Mar 26 16:59:30 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:30 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:30 volumio volumio[1240]: info: Mar 26 16:59:30 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:30 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:30 volumio volumio[1240]: error: updateQueue error: null Mar 26 16:59:30 volumio volumio[1240]: info: ------------------------------ 42ms Mar 26 16:59:30 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 37 milliseconds Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:30 volumio volumio[1240]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 26 16:59:30 volumio volumio[1240]: info: ------------------------------ 51ms Mar 26 16:59:30 volumio volumio[1240]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 209 milliseconds Mar 26 16:59:30 volumio volumio[1240]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 26 16:59:30 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand play Mar 26 16:59:30 volumio volumio[1240]: info: Mar 26 16:59:30 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:30 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:30 volumio volumio[1240]: info: ------------------------------ 177ms Mar 26 16:59:30 volumio volumio[1240]: info: Mar 26 16:59:30 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:30 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:30 volumio volumio[1240]: info: Mar 26 16:59:30 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:30 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:30 volumio volumio[1240]: info: sendMpdCommand play took 15 milliseconds Mar 26 16:59:30 volumio volumio[1240]: info: ------------------------------ 15ms Mar 26 16:59:30 volumio volumio[1240]: info: ------------------------------ 8ms Mar 26 16:59:30 volumio volumio[1240]: info: ------------------------------ 11ms Mar 26 16:59:31 volumio volumio[1240]: info: Mar 26 16:59:31 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:31 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:31 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:31 volumio volumio[1240]: info: Mar 26 16:59:31 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:31 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:31 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:31 volumio volumio[1240]: info: Mar 26 16:59:31 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:31 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:31 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:31 volumio volumio[1240]: info: sendMpdCommand status took 7 milliseconds Mar 26 16:59:31 volumio volumio[1240]: info: sendMpdCommand status took 5 milliseconds Mar 26 16:59:31 volumio volumio[1240]: info: sendMpdCommand status took 2 milliseconds Mar 26 16:59:31 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:31 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:31 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:31 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:31 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:31 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:31 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 26 16:59:31 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 26 16:59:31 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 26 16:59:31 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:31 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:31 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:31 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:31 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 16:59:31 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:31 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:31 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus stop Mar 26 16:59:31 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:31 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:31 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:31 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 16:59:31 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:31 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:31 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:31 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:31 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:31 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:31 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:31 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:59:31 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:31 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:31 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:31 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:31 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:31 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:31 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 16:59:31 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:31 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:31 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:31 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:31 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:31 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:31 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:31 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:31 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:31 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:31 volumio volumio[1240]: info: ------------------------------ 37ms Mar 26 16:59:31 volumio volumio[1240]: info: ------------------------------ 50ms Mar 26 16:59:31 volumio volumio[1240]: info: ------------------------------ 48ms Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:32 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:32 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:32 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:32 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:32 volumio volumio[1240]: info: ------------------------------ 11ms Mar 26 16:59:32 volumio volumio[1240]: info: sendMpdCommand status took 10 milliseconds Mar 26 16:59:32 volumio volumio[1240]: info: ------------------------------ 9ms Mar 26 16:59:32 volumio volumio[1240]: info: sendMpdCommand status took 9 milliseconds Mar 26 16:59:32 volumio volumio[1240]: info: ------------------------------ 6ms Mar 26 16:59:32 volumio volumio[1240]: info: sendMpdCommand status took 4 milliseconds Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:32 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces system playlist update Mar 26 16:59:32 volumio volumio[1240]: info: Ignoring MPD Status Update Mar 26 16:59:32 volumio volumio[1240]: info: Mar 26 16:59:32 volumio volumio[1240]: ---------------------------- MPD announces state update: player Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::getState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand status Mar 26 16:59:32 volumio volumio[1240]: info: ------------------------------ 17ms Mar 26 16:59:32 volumio volumio[1240]: info: sendMpdCommand status took 14 milliseconds Mar 26 16:59:32 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 26 16:59:32 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 26 16:59:32 volumio volumio[1240]: info: ------------------------------ 9ms Mar 26 16:59:32 volumio volumio[1240]: info: sendMpdCommand status took 8 milliseconds Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:32 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:32 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":879,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 16:59:32 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:32 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:32 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:32 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":879,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 16:59:32 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:32 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:32 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:32 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":879,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 16:59:32 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:32 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: ------------------------------ 83ms Mar 26 16:59:32 volumio volumio[1240]: info: ------------------------------ 81ms Mar 26 16:59:32 volumio volumio[1240]: info: ------------------------------ 68ms Mar 26 16:59:32 volumio volumio[1240]: info: sendMpdCommand status took 65 milliseconds Mar 26 16:59:32 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 55 milliseconds Mar 26 16:59:32 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 50 milliseconds Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::parseState Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:32 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:32 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":879,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 16:59:32 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:32 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:32 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:32 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":879,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 16:59:32 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:32 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: ------------------------------ 103ms Mar 26 16:59:32 volumio volumio[1240]: info: ------------------------------ 94ms Mar 26 16:59:32 volumio volumio[1240]: info: sendMpdCommand playlistinfo took 33 milliseconds Mar 26 16:59:32 volumio volumio[1240]: verbose: ControllerMpd::parseTrackInfo Mar 26 16:59:32 volumio volumio[1240]: info: ControllerMpd::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::servicePushState Mar 26 16:59:32 volumio volumio[1240]: info: CorePlayQueue::getTrack 0 Mar 26 16:59:32 volumio volumio[1240]: verbose: STATE SERVICE {"status":"play","position":0,"seek":879,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 16:59:32 volumio volumio[1240]: verbose: CURRENT POSITION 0 Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState stateService play Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::syncState currentStatus play Mar 26 16:59:32 volumio volumio[1240]: info: Received an update from plugin. extracting info from payload Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreStateMachine::pushState Mar 26 16:59:32 volumio volumio[1240]: info: CoreCommandRouter::volumioPushState Mar 26 16:59:32 volumio volumio[1240]: info: ------------------------------ 114ms Mar 26 16:59:33 volumio volumio[1240]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 16:59:33 volumio volumio[1240]: TypeError: Cannot read property 'slice' of null Mar 26 16:59:33 volumio volumio[1240]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Mar 26 16:59:33 volumio volumio[1240]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Mar 26 16:59:33 volumio volumio[1240]: at Object.onceWrapper (events.js:520:26) Mar 26 16:59:33 volumio volumio[1240]: at ClientRequest.emit (events.js:400:28) Mar 26 16:59:33 volumio volumio[1240]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Mar 26 16:59:33 volumio volumio[1240]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Mar 26 16:59:33 volumio volumio[1240]: at TLSSocket.socketOnData (_http_client.js:515:22) Mar 26 16:59:33 volumio volumio[1240]: at TLSSocket.emit (events.js:400:28) Mar 26 16:59:33 volumio volumio[1240]: at addChunk (internal/streams/readable.js:293:12) Mar 26 16:59:33 volumio volumio[1240]: at readableAddChunk (internal/streams/readable.js:267:9) Mar 26 16:59:33 volumio volumio[1240]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Mar 26 16:59:33 volumio volumio[1240]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Mar 26 16:59:33 volumio volumio[1240]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 16:59:33 volumio sudo[2731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-26 16:58 Mar 26 16:59:33 volumio sudo[2731]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="49c352e1d55e9b76c3bd7b0e3940507619bf455a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="1d32690fc900ac8c739e7eabd35ed0f570899eb8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 19 Dec 2025 02:40:03 PM CET" VOLUMIO_VERSION="3.887" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="05e5ed27b04d8d1e8a8a87ca324a64c8"