-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Tue 2026-02-24 18:24:41 MSK. -- Feb 24 18:23:01 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::ClearQueue Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::stPlaybackTimer Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::serviceStop Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::serviceStop Feb 24 18:23:01 volumio volumio[1053]: info: [1771946581075] ControllerWebradio::stop Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::clearPlayQueue Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::addQueueItems Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::addQueueItems Feb 24 18:23:01 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:23:01 volumio volumio[1053]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99594606 Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.077+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.078+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99566190" title="Radio Pro Music 90s" Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPlay Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::play index 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::play index undefined Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::startPlaybackTimer Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: info: [1771946581084] ControllerWebradio::clearAddPlayTrack Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand stop took 13 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand stop took 4 milliseconds Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand clear took 3 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99594606" Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.099+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 11ms Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.100+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.104+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99594606" title="CD 101.9 Smooth Jazz" Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.105+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99594606" title="CD 101.9 Smooth Jazz" Feb 24 18:23:01 volumio volumio[1053]: error: updateQueue error: null Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 31ms Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 30 milliseconds Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:01 volumio volumio[1053]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 37ms Feb 24 18:23:01 volumio volumio[1053]: info: touch_display: Setting screensaver timeout to 10000000000 seconds. Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99594606" took 121 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand play Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 113ms Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 112ms Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand play took 3 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 1ms Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState Feb 24 18:23:01 volumio volumio[1053]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Feb 24 18:23:01 volumio volumio[1053]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 4 milliseconds Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 4 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: 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":"stream","artist":"(#1 - 88/1000) CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""} Feb 24 18:23:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus stop Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 7ms Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: 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":"stream","artist":"(#1 - 88/1000) CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""} Feb 24 18:23:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: 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":"stream","artist":"(#1 - 88/1000) CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""} Feb 24 18:23:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.776+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.776+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="CD 101.9 Smooth Jazz" Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.777+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.777+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="CD 101.9 Smooth Jazz" Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 17ms Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 18ms Feb 24 18:23:01 volumio volumio[1053]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 5ms Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 4 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 4ms Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 3ms Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:01 volumio volumio[1053]: info: Feb 24 18:23:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 5 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 6ms Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 5 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 3ms Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand status took 1 milliseconds Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":695,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Art Ruprect - New Every Day","artist":"CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""} Feb 24 18:23:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Art Ruprect - New Every Day","artist":"CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""} Feb 24 18:23:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.910+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=156 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.910+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.911+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=156 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.911+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.912+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=156 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.912+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.913+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 26ms Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 26ms Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 18 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 18 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 18 milliseconds Feb 24 18:23:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 18 milliseconds Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Art Ruprect - New Every Day","artist":"CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""} Feb 24 18:23:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Art Ruprect - New Every Day","artist":"CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""} Feb 24 18:23:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Art Ruprect - New Every Day","artist":"CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""} Feb 24 18:23:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Art Ruprect - New Every Day","artist":"CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""} Feb 24 18:23:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.937+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=195 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.937+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.937+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=195 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.938+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.938+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=195 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.938+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.938+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=195 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.938+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.939+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.939+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=195 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.939+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.939+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=195 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.938+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=195 volume=100 Feb 24 18:23:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:01.939+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 52ms Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 51ms Feb 24 18:23:01 volumio volumio[1053]: info: ------------------------------ 50ms Feb 24 18:23:22 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::ClearQueue Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::stPlaybackTimer Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::serviceStop Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::serviceStop Feb 24 18:23:22 volumio volumio[1053]: info: [1771946602416] ControllerWebradio::stop Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::clearPlayQueue Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::addQueueItems Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::addQueueItems Feb 24 18:23:22 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:23:22 volumio volumio[1053]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1528122 Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 24 18:23:22 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:22.418+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 24 18:23:22 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:22.418+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99594606" title="CD 101.9 Smooth Jazz" Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::volumioPlay Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::play index 0 Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::play index undefined Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::startPlaybackTimer Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:22 volumio volumio[1053]: info: [1771946602424] ControllerWebradio::clearAddPlayTrack Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:23:22 volumio volumio[1053]: info: Feb 24 18:23:22 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:22 volumio volumio[1053]: info: sendMpdCommand stop took 14 milliseconds Feb 24 18:23:22 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:22 volumio volumio[1053]: info: sendMpdCommand stop took 6 milliseconds Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 18:23:22 volumio volumio[1053]: info: Feb 24 18:23:22 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:22 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:22 volumio volumio[1053]: info: Feb 24 18:23:22 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:22 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:22 volumio volumio[1053]: info: Feb 24 18:23:22 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:22 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:22 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:23:22 volumio volumio[1053]: info: sendMpdCommand clear took 3 milliseconds Feb 24 18:23:22 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:23:22 volumio volumio[1053]: info: sendMpdCommand status took 1 milliseconds Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1528122" Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:22 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:22 volumio volumio[1053]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 24 18:23:22 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:22 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:22 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:22 volumio volumio[1053]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 24 18:23:22 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:22.446+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=1 volume=100 Feb 24 18:23:22 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:22.446+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1528122" title="JAZZGROOVE.org - LAID-BACK JAZZ - The Jazz Groove. Ad Free. (East)" Feb 24 18:23:22 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:22.446+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=1 volume=100 Feb 24 18:23:22 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:22.447+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1528122" title="JAZZGROOVE.org - LAID-BACK JAZZ - The Jazz Groove. Ad Free. (East)" Feb 24 18:23:22 volumio volumio[1053]: info: ------------------------------ 16ms Feb 24 18:23:22 volumio volumio[1053]: info: ------------------------------ 16ms Feb 24 18:23:22 volumio volumio[1053]: info: Feb 24 18:23:22 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:22 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:22 volumio volumio[1053]: info: Feb 24 18:23:22 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:22 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:22 volumio volumio[1053]: error: updateQueue error: null Feb 24 18:23:22 volumio volumio[1053]: info: ------------------------------ 37ms Feb 24 18:23:22 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 31 milliseconds Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:22 volumio volumio[1053]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 24 18:23:22 volumio volumio[1053]: info: ------------------------------ 41ms Feb 24 18:23:22 volumio volumio[1053]: info: touch_display: Setting screensaver timeout to 10000000000 seconds. Feb 24 18:23:22 volumio volumio[1053]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1528122" took 123 milliseconds Feb 24 18:23:22 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 24 18:23:22 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand play Feb 24 18:23:22 volumio volumio[1053]: info: Feb 24 18:23:22 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:22 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:22 volumio volumio[1053]: info: ------------------------------ 116ms Feb 24 18:23:22 volumio volumio[1053]: info: ------------------------------ 115ms Feb 24 18:23:22 volumio volumio[1053]: info: Feb 24 18:23:22 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:22 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:22 volumio volumio[1053]: info: Feb 24 18:23:22 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:22 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:22 volumio volumio[1053]: info: sendMpdCommand play took 3 milliseconds Feb 24 18:23:22 volumio volumio[1053]: info: ------------------------------ 3ms Feb 24 18:23:22 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:23:22 volumio volumio[1053]: info: ------------------------------ 1ms Feb 24 18:23:26 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:23:26 volumio volumio[1053]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::ClearQueue Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:26 volumio volumio[1053]: info: CorePlayQueue::clearPlayQueue Feb 24 18:23:26 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:23:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::addQueueItems Feb 24 18:23:26 volumio volumio[1053]: info: CorePlayQueue::addQueueItems Feb 24 18:23:26 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:23:26 volumio volumio[1053]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1528122 Feb 24 18:23:26 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 24 18:23:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:23:26 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:23:26 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:23:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPlay Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::play index 0 Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::play index undefined Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:26 volumio volumio[1053]: info: CoreStateMachine::startPlaybackTimer Feb 24 18:23:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:26 volumio volumio[1053]: info: [1771946606951] ControllerWebradio::clearAddPlayTrack Feb 24 18:23:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:23:26 volumio volumio[1053]: info: Feb 24 18:23:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:26 volumio volumio[1053]: info: sendMpdCommand stop took 2 milliseconds Feb 24 18:23:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 18:23:26 volumio volumio[1053]: info: Feb 24 18:23:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:26 volumio volumio[1053]: info: sendMpdCommand status took 1 milliseconds Feb 24 18:23:26 volumio volumio[1053]: info: sendMpdCommand clear took 1 milliseconds Feb 24 18:23:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1528122" Feb 24 18:23:26 volumio volumio[1053]: info: Feb 24 18:23:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:26 volumio volumio[1053]: info: Feb 24 18:23:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:26 volumio volumio[1053]: error: updateQueue error: null Feb 24 18:23:26 volumio volumio[1053]: info: ------------------------------ 4ms Feb 24 18:23:26 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 24 18:23:26 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:26 volumio volumio[1053]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 24 18:23:26 volumio volumio[1053]: info: ------------------------------ 7ms Feb 24 18:23:27 volumio volumio[1053]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1528122" took 123 milliseconds Feb 24 18:23:27 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 24 18:23:27 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand play Feb 24 18:23:27 volumio volumio[1053]: info: Feb 24 18:23:27 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:27 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:27 volumio volumio[1053]: info: sendMpdCommand status took 122 milliseconds Feb 24 18:23:27 volumio volumio[1053]: info: sendMpdCommand status took 122 milliseconds Feb 24 18:23:27 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:27 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:27 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:27 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:27 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:27 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:27 volumio volumio[1053]: 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} Feb 24 18:23:27 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:27 volumio volumio[1053]: info: CoreStateMachine::syncState stateService stop Feb 24 18:23:27 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus stop Feb 24 18:23:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:27 volumio volumio[1053]: info: No code Feb 24 18:23:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:27 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:27 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:27 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:27 volumio volumio[1053]: 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} Feb 24 18:23:27 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:27 volumio volumio[1053]: info: CoreStateMachine::syncState stateService stop Feb 24 18:23:27 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus stop Feb 24 18:23:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:27 volumio volumio[1053]: info: No code Feb 24 18:23:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:27.092+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=91 volume=100 Feb 24 18:23:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:27.092+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:27.092+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=91 volume=100 Feb 24 18:23:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:27.092+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:27.093+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=91 volume=100 Feb 24 18:23:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:27.093+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:27.094+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=91 volume=100 Feb 24 18:23:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:27.094+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:27.094+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=91 volume=100 Feb 24 18:23:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:27.095+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:27 volumio volumio[1053]: info: ------------------------------ 140ms Feb 24 18:23:27 volumio volumio[1053]: info: ------------------------------ 142ms Feb 24 18:23:27 volumio volumio[1053]: info: Feb 24 18:23:27 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:27 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:27 volumio volumio[1053]: info: Feb 24 18:23:27 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:27 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:27 volumio volumio[1053]: info: sendMpdCommand play took 24 milliseconds Feb 24 18:23:27 volumio volumio[1053]: info: ------------------------------ 23ms Feb 24 18:23:27 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:23:27 volumio volumio[1053]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 24 18:23:45 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:23:45 volumio volumio[1053]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::ClearQueue Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:45 volumio volumio[1053]: info: CorePlayQueue::clearPlayQueue Feb 24 18:23:45 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:23:45 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::addQueueItems Feb 24 18:23:45 volumio volumio[1053]: info: CorePlayQueue::addQueueItems Feb 24 18:23:45 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:23:45 volumio volumio[1053]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99435742 Feb 24 18:23:45 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 24 18:23:45 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:23:45 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:23:45 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:23:45 volumio volumio[1053]: info: CoreCommandRouter::volumioPlay Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::play index 0 Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::play index undefined Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:23:45 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:45 volumio volumio[1053]: info: CoreStateMachine::startPlaybackTimer Feb 24 18:23:45 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:45 volumio volumio[1053]: info: [1771946625994] ControllerWebradio::clearAddPlayTrack Feb 24 18:23:45 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:23:45 volumio volumio[1053]: info: Feb 24 18:23:45 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:45 volumio volumio[1053]: info: sendMpdCommand stop took 2 milliseconds Feb 24 18:23:45 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:45 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:45 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 18:23:45 volumio volumio[1053]: info: Feb 24 18:23:45 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:45 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:45 volumio volumio[1053]: info: sendMpdCommand status took 1 milliseconds Feb 24 18:23:45 volumio volumio[1053]: info: sendMpdCommand clear took 1 milliseconds Feb 24 18:23:45 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:45 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:45 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99435742" Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: error: updateQueue error: null Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 4ms Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:46 volumio volumio[1053]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 5ms Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99435742" took 121 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand play Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:46 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 119 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 119 milliseconds Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: 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} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService stop Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus stop Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: No code Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: 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} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService stop Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus stop Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: No code Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.129+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=117 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.129+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.129+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=117 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.129+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.129+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=117 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.129+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.130+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=117 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.130+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.130+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=117 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.130+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5334/stream title="Art Ruprect - New Every Day" Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 134ms Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 134ms Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:46 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:46 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand play took 18 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 18ms Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 3ms Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 4 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 4 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 1 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus stop Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:46 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:46 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 13ms Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.810+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.811+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.811+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.812+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.812+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 17ms Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 17ms Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 14 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 1 milliseconds Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:46 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.828+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=70 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.829+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.829+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=70 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.829+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 31ms Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 19 milliseconds Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:46 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:46 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.851+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=70 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.852+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.852+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=70 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.852+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.852+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=70 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.854+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.853+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=70 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.857+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 44ms Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 45ms Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:46 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:46 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:46 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:46 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 3ms Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:46 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:23:46 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:23:46 volumio volumio[1053]: info: Feb 24 18:23:46 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 5 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 4ms Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 3ms Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand status took 1 milliseconds Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:46 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":501,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:46 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.941+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=169 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.941+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.942+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=169 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.943+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.944+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=169 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.944+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 23ms Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 23ms Feb 24 18:23:46 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 17 milliseconds Feb 24 18:23:46 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":672,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:46 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:46 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:46 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:23:46 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:23:46 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:23:46 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:23:46 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:23:46 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.971+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=202 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.971+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.971+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=202 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.972+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=202 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.972+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.972+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=202 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.971+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=202 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.973+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.973+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.975+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=202 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.976+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=202 volume=100 Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.975+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=202 volume=100 Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 50ms Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.976+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:23:46 volumio volumio5-onboarding[1325]: time=2026-02-24T18:23:46.977+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 50ms Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 49ms Feb 24 18:23:46 volumio volumio[1053]: info: ------------------------------ 49ms Feb 24 18:24:01 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::ClearQueue Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::stPlaybackTimer Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::serviceStop Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::serviceStop Feb 24 18:24:01 volumio volumio[1053]: info: [1771946641336] ControllerWebradio::stop Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::clearPlayQueue Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::addQueueItems Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::addQueueItems Feb 24 18:24:01 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:24:01 volumio volumio[1053]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99435742 Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.338+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.338+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99435742" title="Smooth Jazz - Tampa Bay" Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPlay Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::play index 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::play index undefined Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::startPlaybackTimer Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: [1771946641345] ControllerWebradio::clearAddPlayTrack Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand stop took 13 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand stop took 4 milliseconds Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand clear took 2 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99435742" Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.361+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.361+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99435742" title="Smooth Jazz - Tampa Bay" Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 12ms Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 11ms Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: error: updateQueue error: null Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 29ms Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 29 milliseconds Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:01 volumio volumio[1053]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 34ms Feb 24 18:24:01 volumio volumio[1053]: info: touch_display: Setting screensaver timeout to 10000000000 seconds. Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99435742" took 121 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand play Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 113ms Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 112ms Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 1ms Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand play took 3 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 1ms Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 0ms Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState Feb 24 18:24:01 volumio volumio[1053]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Feb 24 18:24:01 volumio volumio[1053]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus stop Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 8ms Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: 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":"stream","artist":"(#1 - 83/1000) Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.822+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.822+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.822+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.822+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.822+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.822+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.823+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.825+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.825+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.826+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.827+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.827+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.827+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.828+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.828+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.829+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.829+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 37ms Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 36ms Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 37ms Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 36ms Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 36ms Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.833+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.834+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Smooth Jazz - Tampa Bay" Feb 24 18:24:01 volumio volumio[1053]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/(%231%20-%2083%2F1000)%20Smooth%20Jazz%20-%20Tampa%20Bay/86f7443f-c6d1-4820-a196-e27008b21fe2.jpg' Feb 24 18:24:01 volumio volumio[1053]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 5ms Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 4 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 4ms Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 4 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 4ms Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:01 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:01 volumio volumio[1053]: info: Feb 24 18:24:01 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 6ms Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 5 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 4ms Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 4 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 3ms Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":354,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":626,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.949+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=155 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.952+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=155 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.953+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.952+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=155 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.953+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.952+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=155 volume=100 Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 33ms Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 32ms Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.953+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 24 milliseconds Feb 24 18:24:01 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 24 18:24:01 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:01 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:01 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Donald Fagen - New Frontier","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Feb 24 18:24:01 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:01 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.970+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=186 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.971+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=186 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.972+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.972+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=186 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.972+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.972+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=186 volume=100 Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.972+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:24:01 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:01.972+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://server.webnetradio.net:5250/stream title="Donald Fagen - New Frontier" Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 48ms Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 47ms Feb 24 18:24:01 volumio volumio[1053]: info: ------------------------------ 47ms Feb 24 18:24:26 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::ClearQueue Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::stPlaybackTimer Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::serviceStop Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::serviceStop Feb 24 18:24:26 volumio volumio[1053]: info: [1771946666378] ControllerWebradio::stop Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::clearPlayQueue Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::addQueueItems Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::addQueueItems Feb 24 18:24:26 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:24:26 volumio volumio[1053]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1774234 Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.381+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.381+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99435742" title="Smooth Jazz - Tampa Bay" Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPlay Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::play index 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::play index undefined Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::startPlaybackTimer Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: info: [1771946666389] ControllerWebradio::clearAddPlayTrack Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand stop took 15 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand stop took 4 milliseconds Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 4 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand clear took 3 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1774234" Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.404+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=7 volume=100 Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.404+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1774234" title="C-Dance RETRO" Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.404+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=7 volume=100 Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.405+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1774234" title="C-Dance RETRO" Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 12ms Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 11ms Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: error: updateQueue error: null Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 31ms Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 31 milliseconds Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:26 volumio volumio[1053]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 36ms Feb 24 18:24:26 volumio volumio[1053]: info: touch_display: Setting screensaver timeout to 10000000000 seconds. Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1774234" took 123 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand play Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 115ms Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 114ms Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand play took 3 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 1ms Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 1 milliseconds Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: 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":"198.100.145.187:18304","artist":"(#1 - 137/300) C-Dance RETRO","album":null,"uri":"http://198.100.145.187:18304","trackType":"187:18304"} Feb 24 18:24:26 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus stop Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: 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":"198.100.145.187:18304","artist":"(#1 - 137/300) C-Dance RETRO","album":null,"uri":"http://198.100.145.187:18304","trackType":"187:18304"} Feb 24 18:24:26 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:26 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: 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":"198.100.145.187:18304","artist":"(#1 - 137/300) C-Dance RETRO","album":null,"uri":"http://198.100.145.187:18304","trackType":"187:18304"} Feb 24 18:24:26 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:26 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 15ms Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.865+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.866+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="C-Dance RETRO" Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.866+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.867+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="C-Dance RETRO" Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.867+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.867+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="C-Dance RETRO" Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.868+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=0 volume=100 Feb 24 18:24:26 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:26.868+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="C-Dance RETRO" Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 20ms Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 21ms Feb 24 18:24:26 volumio volumio[1053]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:26 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:26 volumio volumio[1053]: info: Feb 24 18:24:26 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 7ms Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 6 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 6ms Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 5 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 5ms Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 5 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 4ms Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 3ms Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:26 volumio volumio[1053]: info: ------------------------------ 3ms Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand status took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:26 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:26 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:26 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:26 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Nico Parisi - Basstrain","artist":"C-Dance RETRO","album":null,"uri":"http://198.100.145.187:18304","trackType":"187:18304"} Feb 24 18:24:26 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:26 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:26 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:24:26 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:27 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:27 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Nico Parisi - Basstrain","artist":"C-Dance RETRO","album":null,"uri":"http://198.100.145.187:18304","trackType":"187:18304"} Feb 24 18:24:27 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:27 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:27 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:27 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Nico Parisi - Basstrain","artist":"C-Dance RETRO","album":null,"uri":"http://198.100.145.187:18304","trackType":"187:18304"} Feb 24 18:24:27 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:27 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:27 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:27 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Nico Parisi - Basstrain","artist":"C-Dance RETRO","album":null,"uri":"http://198.100.145.187:18304","trackType":"187:18304"} Feb 24 18:24:27 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:27 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:27 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:27 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Nico Parisi - Basstrain","artist":"C-Dance RETRO","album":null,"uri":"http://198.100.145.187:18304","trackType":"187:18304"} Feb 24 18:24:27 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:27 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.012+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=119 volume=100 Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.012+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="Nico Parisi - Basstrain" Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.012+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=119 volume=100 Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.012+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="Nico Parisi - Basstrain" Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.013+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=119 volume=100 Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.013+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="Nico Parisi - Basstrain" Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.013+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=119 volume=100 Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.013+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="Nico Parisi - Basstrain" Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.013+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=119 volume=100 Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.014+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="Nico Parisi - Basstrain" Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.014+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=119 volume=100 Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.014+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="Nico Parisi - Basstrain" Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.014+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=119 volume=100 Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.014+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="Nico Parisi - Basstrain" Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.014+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=119 volume=100 Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.014+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="Nico Parisi - Basstrain" Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.014+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=119 volume=100 Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.015+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="Nico Parisi - Basstrain" Feb 24 18:24:27 volumio volumio[1053]: info: ------------------------------ 31ms Feb 24 18:24:27 volumio volumio[1053]: info: ------------------------------ 30ms Feb 24 18:24:27 volumio volumio[1053]: info: ------------------------------ 30ms Feb 24 18:24:27 volumio volumio[1053]: info: ------------------------------ 29ms Feb 24 18:24:27 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 26 milliseconds Feb 24 18:24:27 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:27 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:27 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:27 volumio volumio[1053]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Nico Parisi - Basstrain","artist":"C-Dance RETRO","album":null,"uri":"http://198.100.145.187:18304","trackType":"187:18304"} Feb 24 18:24:27 volumio volumio[1053]: verbose: CURRENT POSITION 0 Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::syncState stateService play Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::syncState currentStatus play Feb 24 18:24:27 volumio volumio[1053]: info: Received an update from plugin. extracting info from payload Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:27 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.036+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_PLAYING positionMs=119 volume=100 Feb 24 18:24:27 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:27.037+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id=http://198.100.145.187:18304 title="Nico Parisi - Basstrain" Feb 24 18:24:27 volumio volumio[1053]: info: ------------------------------ 43ms Feb 24 18:24:40 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::ClearQueue Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::stPlaybackTimer Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::serviceStop Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::serviceStop Feb 24 18:24:40 volumio volumio[1053]: info: [1771946680023] ControllerWebradio::stop Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::clearPlayQueue Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::addQueueItems Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::addQueueItems Feb 24 18:24:40 volumio volumio[1053]: info: Preload queue cleared Feb 24 18:24:40 volumio volumio[1053]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1575288 Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 24 18:24:40 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:40.025+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 24 18:24:40 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:40.026+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1774234" title="C-Dance RETRO" Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::volumioPushQueue Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::saveQueue Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::updateTrackBlock Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::getTrackBlock Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::volumioPlay Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::play index 0 Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::stop Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::play index undefined Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::startPlaybackTimer Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:40 volumio volumio[1053]: info: [1771946680036] ControllerWebradio::clearAddPlayTrack Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 18:24:40 volumio volumio[1053]: info: Feb 24 18:24:40 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:40 volumio volumio[1053]: info: sendMpdCommand stop took 18 milliseconds Feb 24 18:24:40 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:40 volumio volumio[1053]: info: sendMpdCommand stop took 5 milliseconds Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 18:24:40 volumio volumio[1053]: info: Feb 24 18:24:40 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:40 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:40 volumio volumio[1053]: info: Feb 24 18:24:40 volumio volumio[1053]: ---------------------------- MPD announces state update: player Feb 24 18:24:40 volumio volumio[1053]: info: ControllerMpd::getState Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand status Feb 24 18:24:40 volumio volumio[1053]: info: Feb 24 18:24:40 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:40 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:40 volumio volumio[1053]: info: sendMpdCommand status took 3 milliseconds Feb 24 18:24:40 volumio volumio[1053]: info: sendMpdCommand clear took 3 milliseconds Feb 24 18:24:40 volumio volumio[1053]: info: sendMpdCommand status took 1 milliseconds Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1575288" Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::parseState Feb 24 18:24:40 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:40 volumio volumio[1053]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 24 18:24:40 volumio volumio[1053]: info: ControllerMpd::pushState Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::servicePushState Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::pushState Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:40 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState Feb 24 18:24:40 volumio volumio[1053]: info: CorePlayQueue::getTrack 0 Feb 24 18:24:40 volumio volumio[1053]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 24 18:24:40 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:40.052+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 24 18:24:40 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:40.053+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1575288" title=".113FM Hits 1992" Feb 24 18:24:40 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:40.053+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" state=STATUS_STOPPED positionMs=0 volume=100 Feb 24 18:24:40 volumio volumio5-onboarding[1325]: time=2026-02-24T18:24:40.054+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.151:54270 @ 0x19494a0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1575288" title=".113FM Hits 1992" Feb 24 18:24:40 volumio volumio[1053]: info: ------------------------------ 14ms Feb 24 18:24:40 volumio volumio[1053]: info: ------------------------------ 20ms Feb 24 18:24:40 volumio volumio[1053]: info: Feb 24 18:24:40 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:40 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:40 volumio volumio[1053]: info: Feb 24 18:24:40 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:40 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:40 volumio volumio[1053]: error: updateQueue error: null Feb 24 18:24:40 volumio volumio[1053]: info: ------------------------------ 43ms Feb 24 18:24:40 volumio volumio[1053]: info: sendMpdCommand playlistinfo took 42 milliseconds Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::parseTrackInfo Feb 24 18:24:40 volumio volumio[1053]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 24 18:24:40 volumio volumio[1053]: info: ------------------------------ 48ms Feb 24 18:24:40 volumio volumio[1053]: info: touch_display: Setting screensaver timeout to 10000000000 seconds. Feb 24 18:24:40 volumio volumio[1053]: info: Feb 24 18:24:40 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:40 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:40 volumio volumio[1053]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1575288" took 130 milliseconds Feb 24 18:24:40 volumio volumio[1053]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 24 18:24:40 volumio volumio[1053]: verbose: ControllerMpd::sendMpdCommand play Feb 24 18:24:40 volumio volumio[1053]: info: ------------------------------ 114ms Feb 24 18:24:40 volumio volumio[1053]: info: ------------------------------ 113ms Feb 24 18:24:40 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:24:40 volumio volumio[1053]: info: Feb 24 18:24:40 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:40 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:40 volumio volumio[1053]: info: Feb 24 18:24:40 volumio volumio[1053]: ---------------------------- MPD announces system playlist update Feb 24 18:24:40 volumio volumio[1053]: info: Ignoring MPD Status Update Feb 24 18:24:40 volumio volumio[1053]: info: sendMpdCommand play took 3 milliseconds Feb 24 18:24:40 volumio volumio[1053]: info: ------------------------------ 2ms Feb 24 18:24:40 volumio volumio[1053]: info: ------------------------------ 1ms Feb 24 18:24:40 volumio volumio[1053]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 18:24:40 volumio volumio[1053]: Error: connect ETIMEDOUT 23.73.2.84:443 Feb 24 18:24:40 volumio volumio[1053]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Feb 24 18:24:40 volumio volumio[1053]: errno: -110, Feb 24 18:24:40 volumio volumio[1053]: code: 'ETIMEDOUT', Feb 24 18:24:40 volumio volumio[1053]: syscall: 'connect', Feb 24 18:24:40 volumio volumio[1053]: address: '23.73.2.84', Feb 24 18:24:40 volumio volumio[1053]: port: 443 Feb 24 18:24:40 volumio volumio[1053]: } Feb 24 18:24:40 volumio volumio[1053]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 18:24:41 volumio sudo[4802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-24 18:23 Feb 24 18:24:41 volumio sudo[4802]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"