Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 03 12:21:04 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 03 12:21:07 volumio kernel: EDID has corrupt header Apr 03 12:21:12 volumio go-librespot[7801]: time="2026-04-03T12:21:12+03:00" level=trace msg="received accesspoint ping" Apr 03 12:21:12 volumio go-librespot[7801]: time="2026-04-03T12:21:12+03:00" level=trace msg="received accesspoint pong ack" Apr 03 12:21:12 volumio go-librespot[7801]: time="2026-04-03T12:21:12+03:00" level=trace msg="sent dealer ping" Apr 03 12:21:12 volumio go-librespot[7801]: time="2026-04-03T12:21:12+03:00" level=trace msg="received dealer pong" Apr 03 12:21:19 volumio kernel: EDID has corrupt header Apr 03 12:21:21 volumio volumio[1256]: error: [LastFM] plugin is not authenticated, please retry Apr 03 12:21:30 volumio kernel: EDID has corrupt header Apr 03 12:21:39 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Apr 03 12:21:39 volumio volumio[1256]: info: [1775208099079] [80s80s] handleBrowseUri curUri: 80s80s Apr 03 12:21:39 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:40 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Apr 03 12:21:40 volumio volumio[1256]: info: [1775208100795] [80s80s] handleBrowseUri curUri: 80s80s/eighties Apr 03 12:21:40 volumio volumio[1256]: info: [1775208100795] [80s80s] getRadioContent url: eighties Apr 03 12:21:40 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:42 volumio kernel: EDID has corrupt header Apr 03 12:21:42 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:42 volumio volumio[1256]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::ClearQueue Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::stop Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::stPlaybackTimer Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::updateTrackBlock Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::getTrackBlock Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:42 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:21:42 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::serviceStop Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:42 volumio volumio[1256]: info: CoreCommandRouter::serviceStop Apr 03 12:21:42 volumio volumio[1256]: info: [1775208102719] ControllerWebradio::stop Apr 03 12:21:42 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::clearPlayQueue Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::saveQueue Apr 03 12:21:42 volumio volumio[1256]: info: CoreCommandRouter::volumioPushQueue Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::addQueueItems Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::addQueueItems Apr 03 12:21:42 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:42 volumio volumio[1256]: info: Adding Item to queue: webeighties/0 Apr 03 12:21:42 volumio volumio[1256]: info: Exploding uri webeighties/0 in service 80s80s Apr 03 12:21:42 volumio volumio[1256]: info: [1775208102724] [80s80s] explodeUri: webeighties/0 Apr 03 12:21:42 volumio volumio5-onboarding[1623]: time=2026-04-03T12:21:42.726+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 03 12:21:42 volumio volumio5-onboarding[1623]: time=2026-04-03T12:21:42.727+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://media-ice.musicradio.com/ClassicFMMP3 title="Classic FM" Apr 03 12:21:42 volumio volumio[1256]: info: CoreCommandRouter::volumioPushQueue Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::saveQueue Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::updateTrackBlock Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::getTrackBlock Apr 03 12:21:42 volumio volumio[1256]: info: CoreCommandRouter::volumioPlay Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::play index 0 Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::stop Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::play index undefined Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::startPlaybackTimer Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:42 volumio volumio[1256]: info: [1775208102750] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/web/mp3-192/volumio Apr 03 12:21:42 volumio volumio[1256]: info: [1775208102751] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=2 Apr 03 12:21:42 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 03 12:21:42 volumio volumio[1256]: info: Apr 03 12:21:42 volumio volumio[1256]: ---------------------------- MPD announces state update: player Apr 03 12:21:42 volumio volumio[1256]: info: sendMpdCommand stop took 49 milliseconds Apr 03 12:21:42 volumio volumio[1256]: info: ControllerMpd::getState Apr 03 12:21:42 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand status Apr 03 12:21:42 volumio volumio[1256]: info: sendMpdCommand status took 1 milliseconds Apr 03 12:21:42 volumio volumio[1256]: verbose: ControllerMpd::parseState Apr 03 12:21:42 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 12:21:42 volumio volumio[1256]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 03 12:21:42 volumio volumio[1256]: verbose: ControllerMpd::parseTrackInfo Apr 03 12:21:42 volumio volumio[1256]: info: ControllerMpd::pushState Apr 03 12:21:42 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:21:42 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:42 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:21:42 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:21:42 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:42 volumio volumio[1256]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 03 12:21:42 volumio volumio[1256]: info: ------------------------------ 37ms Apr 03 12:21:42 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 03 12:21:42 volumio volumio5-onboarding[1623]: time=2026-04-03T12:21:42.803+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_STOPPED positionMs=20 volume=100 Apr 03 12:21:42 volumio volumio5-onboarding[1623]: time=2026-04-03T12:21:42.803+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/web/mp3-192/volumio title="80s80s Real 80s Radio" Apr 03 12:21:42 volumio volumio[1256]: info: touch_display: Setting screensaver timeout to 600 seconds. Apr 03 12:21:42 volumio go-librespot[7801]: time="2026-04-03T12:21:42+03:00" level=trace msg="sent dealer ping" Apr 03 12:21:42 volumio go-librespot[7801]: time="2026-04-03T12:21:42+03:00" level=trace msg="received dealer pong" Apr 03 12:21:48 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:48 volumio volumio[1256]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::ClearQueue Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::stop Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:48 volumio volumio[1256]: info: CorePlayQueue::clearPlayQueue Apr 03 12:21:48 volumio volumio[1256]: info: CorePlayQueue::saveQueue Apr 03 12:21:48 volumio volumio[1256]: info: CoreCommandRouter::volumioPushQueue Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::addQueueItems Apr 03 12:21:48 volumio volumio[1256]: info: CorePlayQueue::addQueueItems Apr 03 12:21:48 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:48 volumio volumio[1256]: info: Adding Item to queue: webeighties/1 Apr 03 12:21:48 volumio volumio[1256]: info: Exploding uri webeighties/1 in service 80s80s Apr 03 12:21:48 volumio volumio[1256]: info: [1775208108009] [80s80s] explodeUri: webeighties/1 Apr 03 12:21:48 volumio volumio[1256]: info: CoreCommandRouter::volumioPushQueue Apr 03 12:21:48 volumio volumio[1256]: info: CorePlayQueue::saveQueue Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::updateTrackBlock Apr 03 12:21:48 volumio volumio[1256]: info: CorePlayQueue::getTrackBlock Apr 03 12:21:48 volumio volumio[1256]: info: CoreCommandRouter::volumioPlay Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::play index 0 Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::stop Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::play index undefined Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:48 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:48 volumio volumio[1256]: info: CoreStateMachine::startPlaybackTimer Apr 03 12:21:48 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:48 volumio volumio[1256]: info: [1775208108015] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/ndw/mp3-192/volumio Apr 03 12:21:48 volumio volumio[1256]: info: [1775208108015] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=137&count=2 Apr 03 12:21:54 volumio kernel: EDID has corrupt header Apr 03 12:21:54 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:54 volumio volumio[1256]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::ClearQueue Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::stop Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:54 volumio volumio[1256]: info: CorePlayQueue::clearPlayQueue Apr 03 12:21:54 volumio volumio[1256]: info: CorePlayQueue::saveQueue Apr 03 12:21:54 volumio volumio[1256]: info: CoreCommandRouter::volumioPushQueue Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::addQueueItems Apr 03 12:21:54 volumio volumio[1256]: info: CorePlayQueue::addQueueItems Apr 03 12:21:54 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:54 volumio volumio[1256]: info: Adding Item to queue: webeighties/2 Apr 03 12:21:54 volumio volumio[1256]: info: Exploding uri webeighties/2 in service 80s80s Apr 03 12:21:54 volumio volumio[1256]: info: [1775208114916] [80s80s] explodeUri: webeighties/2 Apr 03 12:21:54 volumio volumio[1256]: info: CoreCommandRouter::volumioPushQueue Apr 03 12:21:54 volumio volumio[1256]: info: CorePlayQueue::saveQueue Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::updateTrackBlock Apr 03 12:21:54 volumio volumio[1256]: info: CorePlayQueue::getTrackBlock Apr 03 12:21:54 volumio volumio[1256]: info: CoreCommandRouter::volumioPlay Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::play index 0 Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::stop Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::play index undefined Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:54 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:54 volumio volumio[1256]: info: CoreStateMachine::startPlaybackTimer Apr 03 12:21:54 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:54 volumio volumio[1256]: info: [1775208114921] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/love/mp3-192/volumio Apr 03 12:21:54 volumio volumio[1256]: info: [1775208114921] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=85&count=2 Apr 03 12:21:59 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:59 volumio volumio[1256]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::ClearQueue Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::stop Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::clearPlayQueue Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::saveQueue Apr 03 12:21:59 volumio volumio[1256]: info: CoreCommandRouter::volumioPushQueue Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::addQueueItems Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::addQueueItems Apr 03 12:21:59 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:59 volumio volumio[1256]: info: Adding Item to queue: webeighties/3 Apr 03 12:21:59 volumio volumio[1256]: info: Exploding uri webeighties/3 in service 80s80s Apr 03 12:21:59 volumio volumio[1256]: info: [1775208119350] [80s80s] explodeUri: webeighties/3 Apr 03 12:21:59 volumio volumio[1256]: info: CoreCommandRouter::volumioPushQueue Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::saveQueue Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::updateTrackBlock Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::getTrackBlock Apr 03 12:21:59 volumio volumio[1256]: info: CoreCommandRouter::volumioPlay Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::play index 0 Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::stop Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::play index undefined Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::startPlaybackTimer Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:59 volumio volumio[1256]: info: [1775208119354] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/party/mp3-192/volumio Apr 03 12:21:59 volumio volumio[1256]: info: [1775208119354] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=252&count=2 Apr 03 12:21:59 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:59 volumio volumio[1256]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::ClearQueue Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::stop Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::clearPlayQueue Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::saveQueue Apr 03 12:21:59 volumio volumio[1256]: info: CoreCommandRouter::volumioPushQueue Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::addQueueItems Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::addQueueItems Apr 03 12:21:59 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:21:59 volumio volumio[1256]: info: Adding Item to queue: webeighties/3 Apr 03 12:21:59 volumio volumio[1256]: info: Using cached record of: webeighties/3 Apr 03 12:21:59 volumio volumio[1256]: info: CoreCommandRouter::volumioPushQueue Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::saveQueue Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::updateTrackBlock Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::getTrackBlock Apr 03 12:21:59 volumio volumio[1256]: info: CoreCommandRouter::volumioPlay Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::play index 0 Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::stop Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::play index undefined Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:59 volumio volumio[1256]: info: CoreStateMachine::startPlaybackTimer Apr 03 12:21:59 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:21:59 volumio volumio[1256]: info: [1775208119488] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/party/mp3-192/volumio Apr 03 12:21:59 volumio volumio[1256]: info: [1775208119488] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=252&count=2 Apr 03 12:22:03 volumio volumio[1256]: info: CoreCommandRouter::volumioPlay Apr 03 12:22:03 volumio volumio[1256]: info: CoreStateMachine::play index undefined Apr 03 12:22:03 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:22:03 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:03 volumio volumio[1256]: info: CoreStateMachine::startPlaybackTimer Apr 03 12:22:03 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:03 volumio volumio[1256]: info: [1775208123127] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/party/mp3-192/volumio Apr 03 12:22:03 volumio volumio[1256]: info: [1775208123127] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=252&count=2 Apr 03 12:22:04 volumio volumio[1256]: info: CoreCommandRouter::volumioPlay Apr 03 12:22:04 volumio volumio[1256]: info: CoreStateMachine::play index undefined Apr 03 12:22:04 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:22:04 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:04 volumio volumio[1256]: info: CoreStateMachine::startPlaybackTimer Apr 03 12:22:04 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:04 volumio volumio[1256]: info: [1775208124171] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/party/mp3-192/volumio Apr 03 12:22:04 volumio volumio[1256]: info: [1775208124171] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=252&count=2 Apr 03 12:22:04 volumio volumio[1256]: info: CoreCommandRouter::volumioPlay Apr 03 12:22:04 volumio volumio[1256]: info: CoreStateMachine::play index undefined Apr 03 12:22:04 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:22:04 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:04 volumio volumio[1256]: info: CoreStateMachine::startPlaybackTimer Apr 03 12:22:04 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:04 volumio volumio[1256]: info: [1775208124834] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/party/mp3-192/volumio Apr 03 12:22:04 volumio volumio[1256]: info: [1775208124834] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=252&count=2 Apr 03 12:22:06 volumio kernel: EDID has corrupt header Apr 03 12:22:07 volumio volumio[1256]: info: [1775208127923] [80s80s] received new event containing 2 songs. Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 12:22:07 volumio volumio[1256]: info: [1775208127925] [80s80s] received new event containing 2 songs. Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 12:22:07 volumio volumio[1256]: info: sendMpdCommand stop took 2 milliseconds Apr 03 12:22:07 volumio volumio[1256]: info: sendMpdCommand stop took 0 milliseconds Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 12:22:07 volumio volumio[1256]: info: Apr 03 12:22:07 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:07 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:07 volumio volumio[1256]: info: Apr 03 12:22:07 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:07 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:07 volumio volumio[1256]: info: sendMpdCommand clear took 2 milliseconds Apr 03 12:22:07 volumio volumio[1256]: info: sendMpdCommand clear took 2 milliseconds Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 03 12:22:07 volumio volumio[1256]: error: updateQueue error: null Apr 03 12:22:07 volumio volumio[1256]: error: updateQueue error: null Apr 03 12:22:07 volumio volumio[1256]: info: Apr 03 12:22:07 volumio volumio[1256]: ---------------------------- MPD announces state update: options Apr 03 12:22:07 volumio volumio[1256]: info: ------------------------------ 4ms Apr 03 12:22:07 volumio volumio[1256]: info: ------------------------------ 4ms Apr 03 12:22:07 volumio volumio[1256]: info: sendMpdCommand consume 1 took 2 milliseconds Apr 03 12:22:07 volumio volumio[1256]: info: ControllerMpd::getState Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand status Apr 03 12:22:07 volumio volumio[1256]: info: sendMpdCommand consume 1 took 3 milliseconds Apr 03 12:22:07 volumio volumio[1256]: info: [1775208127934] [80s80s] adding url: http://streams.80s80s.de/ndw/mp3-192/volumio Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/ndw/mp3-192/volumio" Apr 03 12:22:07 volumio volumio[1256]: info: [1775208127934] [80s80s] adding url: http://streams.80s80s.de/web/mp3-192/volumio Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/web/mp3-192/volumio" Apr 03 12:22:07 volumio volumio[1256]: info: Apr 03 12:22:07 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:07 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:07 volumio volumio[1256]: info: Apr 03 12:22:07 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:07 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:07 volumio volumio[1256]: info: sendMpdCommand status took 1 milliseconds Apr 03 12:22:07 volumio volumio[1256]: info: sendMpdCommand add "http://streams.80s80s.de/ndw/mp3-192/volumio" took 1 milliseconds Apr 03 12:22:07 volumio volumio[1256]: info: sendMpdCommand add "http://streams.80s80s.de/web/mp3-192/volumio" took 1 milliseconds Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::parseState Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand play Apr 03 12:22:07 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand play Apr 03 12:22:07 volumio volumio[1256]: info: ControllerMpd::pushState Apr 03 12:22:07 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:07 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:07 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:07 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:07 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:07 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:07 volumio volumio[1256]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 03 12:22:07 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:07.946+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_STOPPED positionMs=3097 volume=100 Apr 03 12:22:07 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:07.948+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="80s80s Party" Apr 03 12:22:07 volumio volumio[1256]: info: ------------------------------ 18ms Apr 03 12:22:07 volumio volumio[1256]: info: ------------------------------ 17ms Apr 03 12:22:07 volumio volumio[1256]: info: ------------------------------ 17ms Apr 03 12:22:07 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 03 12:22:07 volumio volumio[1256]: info: sendMpdCommand play took 20 milliseconds Apr 03 12:22:07 volumio volumio[1256]: info: sendMpdCommand play took 20 milliseconds Apr 03 12:22:07 volumio volumio[1256]: info: [1775208127962] [80s80s] Pushing the next song state: Combo Colossale - Puppen weinen nicht Apr 03 12:22:07 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:07 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:07 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:07 volumio volumio[1256]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"/albumart?sourceicon=music_service/80s80s/images/80s80s-party-cover.png","name":"Combo Colossale - Puppen weinen nicht","title":"Puppen weinen nicht","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"201","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 03 12:22:07 volumio volumio[1256]: verbose: CURRENT POSITION 0 Apr 03 12:22:07 volumio volumio[1256]: info: CoreStateMachine::syncState stateService play Apr 03 12:22:07 volumio volumio[1256]: info: CoreStateMachine::syncState currentStatus stop Apr 03 12:22:07 volumio volumio[1256]: info: [1775208127968] [80s80s] Pushing the next song state: Sandra - In the Heat of the Night Apr 03 12:22:07 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:07 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:07 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:07 volumio volumio[1256]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music114/v4/61/d2/8b/61d28bc8-a404-0aed-2af1-2cedf80e1e9c/source/600x600bb.jpg","name":"Sandra - In the Heat of the Night","title":"In the Heat of the Night","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"228","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 03 12:22:07 volumio volumio[1256]: verbose: CURRENT POSITION 0 Apr 03 12:22:07 volumio volumio[1256]: info: CoreStateMachine::syncState stateService play Apr 03 12:22:07 volumio volumio[1256]: info: CoreStateMachine::syncState currentStatus play Apr 03 12:22:07 volumio volumio[1256]: info: Received an update from plugin. extracting info from payload Apr 03 12:22:07 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:07 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:07 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:07 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:07 volumio volumio[1256]: info: [1775208127978] [80s80s] PlayNextTrack API delay: 30 Apr 03 12:22:07 volumio volumio[1256]: info: [1775208127995] [80s80s] Setting timer to: 201000 milliseconds. Apr 03 12:22:07 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:07.999+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.000+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Sandra - In the Heat of the Night" Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 1 Apr 03 12:22:08 volumio volumio[1256]: info: [LastFM] Current track has sufficient metadata: title (Sandra - In the Heat of the Night) and artist (80s80s Party) passed on explicitly Apr 03 12:22:08 volumio volumio[1256]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Apr 03 12:22:08 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128013] [80s80s] received new event containing 2 songs. Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128017] [80s80s] received new event containing 2 songs. Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128019] [80s80s] received new event containing 2 songs. Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces state update: player Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand stop took 37 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: ControllerMpd::getState Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand status Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand stop took 34 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand stop took 30 milliseconds Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:08 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:08 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:08 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand status took 3 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand clear took 3 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand clear took 2 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand clear took 3 milliseconds Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::parseState Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128058] [80s80s] received new event containing 2 songs. Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 12:22:08 volumio volumio[1256]: error: updateQueue error: null Apr 03 12:22:08 volumio volumio[1256]: error: updateQueue error: null Apr 03 12:22:08 volumio volumio[1256]: error: updateQueue error: null Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 7ms Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 7ms Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 7ms Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand consume 1 took 6 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand consume 1 took 6 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand consume 1 took 5 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand stop took 2 milliseconds Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::parseTrackInfo Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128062] [80s80s] adding url: http://streams.80s80s.de/love/mp3-192/volumio Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/love/mp3-192/volumio" Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128062] [80s80s] adding url: http://streams.80s80s.de/party/mp3-192/volumio Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128062] [80s80s] adding url: http://streams.80s80s.de/party/mp3-192/volumio Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 12:22:08 volumio volumio[1256]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 14ms Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:08 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:08 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:08 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:08 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand add "http://streams.80s80s.de/love/mp3-192/volumio" took 8 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" took 8 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" took 9 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand clear took 9 milliseconds Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand play Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand play Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand play Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 03 12:22:08 volumio volumio[1256]: error: updateQueue error: null Apr 03 12:22:08 volumio volumio[1256]: error: updateQueue error: null Apr 03 12:22:08 volumio volumio[1256]: error: updateQueue error: null Apr 03 12:22:08 volumio volumio[1256]: error: updateQueue error: null Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 17ms Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 17ms Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 16ms Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 16ms Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand play took 13 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand play took 12 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand play took 11 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand consume 1 took 11 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128087] [80s80s] Pushing the next song state: Joyce Sims - Come Into My Life Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music/v4/af/d5/61/afd561bc-e856-b6c3-6bd9-5a07d28c17d0/source/600x600bb.jpg","name":"Joyce Sims - Come Into My Life","title":"Come Into My Life","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"214","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 03 12:22:08 volumio volumio[1256]: verbose: CURRENT POSITION 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState stateService play Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState currentStatus play Apr 03 12:22:08 volumio volumio[1256]: info: Received an update from plugin. extracting info from payload Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128091] [80s80s] Pushing the next song state: Murray Head - One Night in Bangkok Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music125/v4/8c/b6/e2/8cb6e252-88be-804a-e8e7-5ad4cd1df0ba/source/600x600bb.jpg","name":"Murray Head - One Night in Bangkok","title":"One Night in Bangkok","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"242","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 03 12:22:08 volumio volumio[1256]: verbose: CURRENT POSITION 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState stateService play Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState currentStatus play Apr 03 12:22:08 volumio volumio[1256]: info: Received an update from plugin. extracting info from payload Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128094] [80s80s] Pushing the next song state: Murray Head - One Night in Bangkok Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music125/v4/8c/b6/e2/8cb6e252-88be-804a-e8e7-5ad4cd1df0ba/source/600x600bb.jpg","name":"Murray Head - One Night in Bangkok","title":"One Night in Bangkok","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"242","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 03 12:22:08 volumio volumio[1256]: verbose: CURRENT POSITION 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState stateService play Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState currentStatus play Apr 03 12:22:08 volumio volumio[1256]: info: Received an update from plugin. extracting info from payload Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128097] [80s80s] adding url: http://streams.80s80s.de/party/mp3-192/volumio Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.101+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.101+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.101+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.102+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.102+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Joyce Sims - Come Into My Life" Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.104+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128108] [80s80s] received new event containing 2 songs. Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 12:22:08 volumio volumio[1256]: info: [LastFM] Current track has sufficient metadata: title (Joyce Sims - Come Into My Life) and artist (80s80s Party) passed on explicitly Apr 03 12:22:08 volumio volumio[1256]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Apr 03 12:22:08 volumio volumio[1256]: info: [LastFM] Current track has sufficient metadata: title (Murray Head - One Night in Bangkok) and artist (80s80s Party) passed on explicitly Apr 03 12:22:08 volumio volumio[1256]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Apr 03 12:22:08 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 03 12:22:08 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 03 12:22:08 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 1 Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:08 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" took 31 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand stop took 21 milliseconds Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand play Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 13ms Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand play took 8 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128142] [80s80s] Pushing the next song state: Murray Head - One Night in Bangkok Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music125/v4/8c/b6/e2/8cb6e252-88be-804a-e8e7-5ad4cd1df0ba/source/600x600bb.jpg","name":"Murray Head - One Night in Bangkok","title":"One Night in Bangkok","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"242","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 03 12:22:08 volumio volumio[1256]: verbose: CURRENT POSITION 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState stateService play Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState currentStatus play Apr 03 12:22:08 volumio volumio[1256]: info: Received an update from plugin. extracting info from payload Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.153+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.154+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:08 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128162] [80s80s] received new event containing 2 songs. Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 1 Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand clear took 86 milliseconds Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:08 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces state update: player Apr 03 12:22:08 volumio volumio[1256]: info: ControllerMpd::getState Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand status Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand stop took 59 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand consume 1 took 1 milliseconds Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128222] [80s80s] adding url: http://streams.80s80s.de/party/mp3-192/volumio Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" Apr 03 12:22:08 volumio volumio[1256]: error: updateQueue error: null Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:08 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 10ms Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand status took 9 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand clear took 9 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" took 8 milliseconds Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::parseState Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand play Apr 03 12:22:08 volumio volumio[1256]: info: ControllerMpd::pushState Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.237+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=40 volume=100 Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.237+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:08 volumio volumio[1256]: error: ControllerMpd::pushError: Error: Failed to convert napi value String into rust type `f64` on TimelineInfo.duration Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 18ms Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 9ms Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand consume 1 took 8 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand play took 7 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128240] [80s80s] adding url: http://streams.80s80s.de/party/mp3-192/volumio Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128241] [80s80s] Pushing the next song state: Murray Head - One Night in Bangkok Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music125/v4/8c/b6/e2/8cb6e252-88be-804a-e8e7-5ad4cd1df0ba/source/600x600bb.jpg","name":"Murray Head - One Night in Bangkok","title":"One Night in Bangkok","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"242","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 03 12:22:08 volumio volumio[1256]: verbose: CURRENT POSITION 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState stateService play Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState currentStatus play Apr 03 12:22:08 volumio volumio[1256]: info: Received an update from plugin. extracting info from payload Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.246+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.247+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:08 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 03 12:22:08 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 1 Apr 03 12:22:08 volumio volumio[1256]: info: Apr 03 12:22:08 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:08 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" took 15 milliseconds Apr 03 12:22:08 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand play Apr 03 12:22:08 volumio volumio[1256]: info: ------------------------------ 3ms Apr 03 12:22:08 volumio volumio[1256]: info: sendMpdCommand play took 1 milliseconds Apr 03 12:22:08 volumio volumio[1256]: info: [1775208128260] [80s80s] Pushing the next song state: Murray Head - One Night in Bangkok Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music125/v4/8c/b6/e2/8cb6e252-88be-804a-e8e7-5ad4cd1df0ba/source/600x600bb.jpg","name":"Murray Head - One Night in Bangkok","title":"One Night in Bangkok","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"242","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 03 12:22:08 volumio volumio[1256]: verbose: CURRENT POSITION 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState stateService play Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::syncState currentStatus play Apr 03 12:22:08 volumio volumio[1256]: info: Received an update from plugin. extracting info from payload Apr 03 12:22:08 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.265+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 12:22:08 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:08.266+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:08 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:08 volumio volumio[1256]: info: CorePlayQueue::getTrack 1 Apr 03 12:22:09 volumio volumio[1256]: info: Apr 03 12:22:09 volumio volumio[1256]: ---------------------------- MPD announces state update: player Apr 03 12:22:09 volumio volumio[1256]: info: ControllerMpd::getState Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand status Apr 03 12:22:09 volumio volumio[1256]: info: Apr 03 12:22:09 volumio volumio[1256]: ---------------------------- MPD announces state update: player Apr 03 12:22:09 volumio volumio[1256]: info: sendMpdCommand status took 3 milliseconds Apr 03 12:22:09 volumio volumio[1256]: info: ControllerMpd::getState Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand status Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::parseState Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 12:22:09 volumio volumio[1256]: info: sendMpdCommand status took 3 milliseconds Apr 03 12:22:09 volumio volumio[1256]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::parseState Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::parseTrackInfo Apr 03 12:22:09 volumio volumio[1256]: info: ControllerMpd::pushState Apr 03 12:22:09 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:09 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:09 volumio volumio[1256]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 03 12:22:09 volumio volumio[1256]: info: ------------------------------ 11ms Apr 03 12:22:09 volumio volumio[1256]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::parseTrackInfo Apr 03 12:22:09 volumio volumio[1256]: info: ControllerMpd::pushState Apr 03 12:22:09 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:09 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:09 volumio volumio[1256]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 03 12:22:09 volumio volumio[1256]: info: ------------------------------ 10ms Apr 03 12:22:09 volumio volumio[1256]: info: Apr 03 12:22:09 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:09 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:09 volumio volumio[1256]: info: Apr 03 12:22:09 volumio volumio[1256]: ---------------------------- MPD announces state update: player Apr 03 12:22:09 volumio volumio[1256]: info: ControllerMpd::getState Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand status Apr 03 12:22:09 volumio volumio[1256]: info: ------------------------------ 2ms Apr 03 12:22:09 volumio volumio[1256]: info: sendMpdCommand status took 4 milliseconds Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::parseState Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 12:22:09 volumio volumio[1256]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 03 12:22:09 volumio volumio[1256]: verbose: ControllerMpd::parseTrackInfo Apr 03 12:22:09 volumio volumio[1256]: info: ControllerMpd::pushState Apr 03 12:22:09 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:09 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:09 volumio volumio[1256]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 03 12:22:09 volumio volumio[1256]: info: ------------------------------ 6ms Apr 03 12:22:12 volumio go-librespot[7801]: time="2026-04-03T12:22:12+03:00" level=trace msg="sent dealer ping" Apr 03 12:22:12 volumio go-librespot[7801]: time="2026-04-03T12:22:12+03:00" level=trace msg="received dealer pong" Apr 03 12:22:15 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:15.031+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-344.857459ms timeout=3s volume=99 Apr 03 12:22:15 volumio volumio[1256]: info: VolumeController::SetAlsaVolume99 Apr 03 12:22:15 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:15 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:15 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:15 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:15 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 99 Apr 03 12:22:15 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 100 Apr 03 12:22:15 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 99 Apr 03 12:22:15 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:15 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:15.049+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=6769 volume=99 Apr 03 12:22:15 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:15.049+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:15 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:15.576+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-339.834545ms timeout=3s volume=98 Apr 03 12:22:15 volumio volumio[1256]: info: VolumeController::SetAlsaVolume98 Apr 03 12:22:15 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:15 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:15 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:15 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:15 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:15.588+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=7269 volume=98 Apr 03 12:22:15 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:15.590+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:15 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98 Apr 03 12:22:15 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 100 Apr 03 12:22:15 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 98 Apr 03 12:22:15 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:15 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 98 Apr 03 12:22:16 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:16.320+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-340.893321ms timeout=3s volume=97 Apr 03 12:22:16 volumio volumio[1256]: info: VolumeController::SetAlsaVolume97 Apr 03 12:22:16 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:16 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:16 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:16 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:16.333+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=8019 volume=97 Apr 03 12:22:16 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:16.333+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:16 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 97 Apr 03 12:22:16 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 98 Apr 03 12:22:16 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 97 Apr 03 12:22:16 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:16 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:16.557+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-351.449104ms timeout=3s volume=96 Apr 03 12:22:16 volumio volumio[1256]: info: VolumeController::SetAlsaVolume96 Apr 03 12:22:16 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:16 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:16 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:16 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:16.571+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=8269 volume=96 Apr 03 12:22:16 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:16.571+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:16 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 96 Apr 03 12:22:16 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 98 Apr 03 12:22:16 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 96 Apr 03 12:22:16 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:16 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 96 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.050+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-350.798159ms timeout=3s volume=95 Apr 03 12:22:17 volumio volumio[1256]: info: VolumeController::SetAlsaVolume95 Apr 03 12:22:17 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:17 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.064+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=8770 volume=95 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.064+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 96 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 95 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.295+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-354.583168ms timeout=3s volume=94 Apr 03 12:22:17 volumio volumio[1256]: info: VolumeController::SetAlsaVolume94 Apr 03 12:22:17 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:17 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.308+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=9020 volume=94 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.309+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 96 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 94 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:17 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 94 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.344+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-358.584451ms timeout=3s volume=93 Apr 03 12:22:17 volumio volumio[1256]: info: VolumeController::SetAlsaVolume93 Apr 03 12:22:17 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:17 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.357+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=9082 volume=93 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.357+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 94 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 93 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.397+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-351.199138ms timeout=3s volume=92 Apr 03 12:22:17 volumio volumio[1256]: info: VolumeController::SetAlsaVolume92 Apr 03 12:22:17 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:17 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.414+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=9124 volume=92 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.415+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 92 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 94 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 92 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:17 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 92 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.446+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-358.26168ms timeout=3s volume=91 Apr 03 12:22:17 volumio volumio[1256]: info: VolumeController::SetAlsaVolume91 Apr 03 12:22:17 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:17 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.461+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=9178 volume=91 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.462+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 92 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 91 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.492+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-358.683492ms timeout=3s volume=90 Apr 03 12:22:17 volumio volumio[1256]: info: VolumeController::SetAlsaVolume90 Apr 03 12:22:17 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:17 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.509+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=9178 volume=90 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.509+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 92 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 90 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:17 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 90 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.540+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-358.228919ms timeout=3s volume=89 Apr 03 12:22:17 volumio volumio[1256]: info: VolumeController::SetAlsaVolume89 Apr 03 12:22:17 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:17 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.555+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=9269 volume=89 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.556+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 89 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 90 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 89 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.623+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-326.252629ms timeout=3s volume=88 Apr 03 12:22:17 volumio volumio[1256]: info: VolumeController::SetAlsaVolume88 Apr 03 12:22:17 volumio kernel: EDID has corrupt header Apr 03 12:22:17 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:17 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.645+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-358.008774ms timeout=3s volume=87 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.645+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=9332 volume=88 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.645+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:17 volumio volumio[1256]: info: VolumeController::SetAlsaVolume87 Apr 03 12:22:17 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:17 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.669+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=9386 volume=87 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.670+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 88 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 90 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 88 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:17 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 88 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 87 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 88 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 87 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.697+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-358.968247ms timeout=3s volume=86 Apr 03 12:22:17 volumio volumio[1256]: info: VolumeController::SetAlsaVolume86 Apr 03 12:22:17 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:17 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:17 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.720+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=9428 volume=86 Apr 03 12:22:17 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:17.720+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 88 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 86 Apr 03 12:22:17 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:17 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 86 Apr 03 12:22:18 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:18.419+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-352.835523ms timeout=3s volume=85 Apr 03 12:22:18 volumio volumio[1256]: info: VolumeController::SetAlsaVolume85 Apr 03 12:22:18 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:18 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:18 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:18 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:18 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:18.436+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=10136 volume=85 Apr 03 12:22:18 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:18.437+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:18 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Apr 03 12:22:18 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 86 Apr 03 12:22:18 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 85 Apr 03 12:22:18 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:18 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:18.937+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-337.874512ms timeout=3s volume=84 Apr 03 12:22:18 volumio volumio[1256]: info: VolumeController::SetAlsaVolume84 Apr 03 12:22:18 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:18 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:18 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:18 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:18 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:18.949+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=10636 volume=84 Apr 03 12:22:18 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:18.950+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:18 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Apr 03 12:22:18 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 86 Apr 03 12:22:18 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 84 Apr 03 12:22:18 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:18 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 84 Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.307+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-325.808904ms timeout=3s volume=83 Apr 03 12:22:19 volumio volumio[1256]: info: VolumeController::SetAlsaVolume83 Apr 03 12:22:19 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:19 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:19 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:19 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.321+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=11023 volume=83 Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.325+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 84 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 83 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.533+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-350.7501ms timeout=3s volume=82 Apr 03 12:22:19 volumio volumio[1256]: info: VolumeController::SetAlsaVolume82 Apr 03 12:22:19 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:19 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:19 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:19 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.547+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=11255 volume=82 Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.547+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 84 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 82 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:19 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 82 Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.576+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-358.680023ms timeout=3s volume=81 Apr 03 12:22:19 volumio volumio[1256]: info: VolumeController::SetAlsaVolume81 Apr 03 12:22:19 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:19 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:19 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:19 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.589+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=11287 volume=81 Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.590+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 82 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 81 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.645+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-339.704737ms timeout=3s volume=80 Apr 03 12:22:19 volumio volumio[1256]: info: VolumeController::SetAlsaVolume80 Apr 03 12:22:19 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:19 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:19 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:19 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.667+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=11341 volume=80 Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.668+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 82 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 80 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:19 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 80 Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.681+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-352.534866ms timeout=3s volume=79 Apr 03 12:22:19 volumio volumio[1256]: info: VolumeController::SetAlsaVolume79 Apr 03 12:22:19 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:19 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:19 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:19 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.703+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=11405 volume=79 Apr 03 12:22:19 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:19.703+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 80 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 79 Apr 03 12:22:19 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:20 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:20.616+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-349.850401ms timeout=3s volume=78 Apr 03 12:22:20 volumio volumio[1256]: info: VolumeController::SetAlsaVolume78 Apr 03 12:22:20 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:20 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:20 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:20 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:20 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:20.629+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=12342 volume=78 Apr 03 12:22:20 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:20.630+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:20 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Apr 03 12:22:20 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 80 Apr 03 12:22:20 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 78 Apr 03 12:22:20 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:20 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 78 Apr 03 12:22:21 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:21.330+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-350.734153ms timeout=3s volume=77 Apr 03 12:22:21 volumio volumio[1256]: info: VolumeController::SetAlsaVolume77 Apr 03 12:22:21 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:21 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:21 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:21 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:21 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:21.343+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=13038 volume=77 Apr 03 12:22:21 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:21.343+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:21 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 77 Apr 03 12:22:21 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 78 Apr 03 12:22:21 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 77 Apr 03 12:22:21 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 03 12:22:21 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:21.909+03:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" latency=-351.908442ms timeout=3s volume=76 Apr 03 12:22:21 volumio volumio[1256]: info: VolumeController::SetAlsaVolume76 Apr 03 12:22:21 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:21 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:21 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:21 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:21 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:21.925+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" state=STATUS_PLAYING positionMs=13594 volume=76 Apr 03 12:22:21 volumio volumio5-onboarding[1623]: time=2026-04-03T12:22:21.926+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.53:55722,00:00:00:00:00:00%02 @ 0x2b2c6f0" id=http://streams.80s80s.de/party/mp3-192/volumio title="Murray Head - One Night in Bangkok" Apr 03 12:22:21 volumio volumio[1256]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Apr 03 12:22:21 volumio volumio[1256]: SPOTIFY: SPOTIFY VOLUME 78 Apr 03 12:22:21 volumio volumio[1256]: SPOTIFY: VOLUMIO VOLUME 76 Apr 03 12:22:21 volumio volumio[1256]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 12:22:21 volumio volumio[1256]: info: Setting Spotify Volume from Volumio: 76 Apr 03 12:22:23 volumio volumio[1256]: SPOTIFY: SETTING SPOTIFY VOLUME 76 Apr 03 12:22:23 volumio volumio[1256]: info: Sending Spotify command with payload to local API: /player/volume Apr 03 12:22:23 volumio go-librespot[7801]: time="2026-04-03T12:22:23+03:00" level=debug msg="update volume requested to 49806/65535" Apr 03 12:22:24 volumio go-librespot[7801]: time="2026-04-03T12:22:24+03:00" level=debug msg="put connect state because VOLUME_CHANGED" Apr 03 12:22:24 volumio go-librespot[7801]: time="2026-04-03T12:22:24+03:00" level=trace msg="emitting websocket event: volume" Apr 03 12:22:24 volumio volumio[1256]: SPOTIFY: received: {"type":"volume","data":{"value":76,"max":100}} Apr 03 12:22:24 volumio volumio[1256]: SPOTIFY: RECEIVED SPOTIFY VOLUME 76 Apr 03 12:22:28 volumio volumio[1256]: info: Apr 03 12:22:28 volumio volumio[1256]: ---------------------------- MPD announces system playlist update Apr 03 12:22:28 volumio volumio[1256]: info: Ignoring MPD Status Update Apr 03 12:22:28 volumio volumio[1256]: info: Apr 03 12:22:28 volumio volumio[1256]: ---------------------------- MPD announces state update: player Apr 03 12:22:28 volumio volumio[1256]: info: ControllerMpd::getState Apr 03 12:22:28 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand status Apr 03 12:22:28 volumio volumio[1256]: info: ------------------------------ 3ms Apr 03 12:22:28 volumio volumio[1256]: info: sendMpdCommand status took 2 milliseconds Apr 03 12:22:28 volumio volumio[1256]: verbose: ControllerMpd::parseState Apr 03 12:22:28 volumio volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 12:22:28 volumio volumio[1256]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 03 12:22:28 volumio volumio[1256]: verbose: ControllerMpd::parseTrackInfo Apr 03 12:22:28 volumio volumio[1256]: info: ControllerMpd::pushState Apr 03 12:22:28 volumio volumio[1256]: info: CoreCommandRouter::servicePushState Apr 03 12:22:28 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:28 volumio volumio[1256]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 03 12:22:28 volumio volumio[1256]: info: ------------------------------ 4ms Apr 03 12:22:29 volumio kernel: EDID has corrupt header Apr 03 12:22:32 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Apr 03 12:22:32 volumio volumio[1256]: info: [1775208152965] [80s80s] handleBrowseUri curUri: 80s80s Apr 03 12:22:33 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:22:34 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Apr 03 12:22:34 volumio volumio[1256]: info: [1775208154817] [80s80s] handleBrowseUri curUri: 80s80s/eighties Apr 03 12:22:34 volumio volumio[1256]: info: [1775208154817] [80s80s] getRadioContent url: eighties Apr 03 12:22:34 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:22:37 volumio volumio[1256]: info: Preload queue cleared Apr 03 12:22:37 volumio volumio[1256]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 12:22:37 volumio volumio[1256]: info: CoreStateMachine::ClearQueue Apr 03 12:22:37 volumio volumio[1256]: info: CoreStateMachine::stop Apr 03 12:22:37 volumio volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 12:22:37 volumio volumio[1256]: info: CoreStateMachine::stPlaybackTimer Apr 03 12:22:37 volumio volumio[1256]: info: CoreStateMachine::updateTrackBlock Apr 03 12:22:37 volumio volumio[1256]: info: CorePlayQueue::getTrackBlock Apr 03 12:22:37 volumio volumio[1256]: info: CoreStateMachine::pushState Apr 03 12:22:37 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Apr 03 12:22:37 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 12:22:37 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Apr 03 12:22:37 volumio volumio[1256]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 12:22:37 volumio volumio[1256]: Error: Failed to convert napi value String into rust type `f64` on TimelineInfo.duration Apr 03 12:22:37 volumio volumio[1256]: at FerrumStreamingControlTechnology.updateStateOnPlayer (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:72:12) Apr 03 12:22:37 volumio volumio[1256]: at FerrumStreamingControlTechnology.pushState (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:182:10) Apr 03 12:22:37 volumio volumio[1256]: at /volumio/app/index.js:326:81 Apr 03 12:22:37 volumio volumio[1256]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Apr 03 12:22:37 volumio volumio[1256]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Apr 03 12:22:37 volumio volumio[1256]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:324:13) Apr 03 12:22:37 volumio volumio[1256]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:534:22) Apr 03 12:22:37 volumio volumio[1256]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1247:12) Apr 03 12:22:37 volumio volumio[1256]: at CoreStateMachine.clearQueue (/volumio/app/statemachine.js:277:8) Apr 03 12:22:37 volumio volumio[1256]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:494:21) Apr 03 12:22:37 volumio volumio[1256]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Apr 03 12:22:37 volumio volumio[1256]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Apr 03 12:22:37 volumio volumio[1256]: at Socket.emit (node:events:514:28) Apr 03 12:22:37 volumio volumio[1256]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 03 12:22:37 volumio volumio[1256]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Apr 03 12:22:37 volumio volumio[1256]: code: 'NumberExpected' Apr 03 12:22:37 volumio volumio[1256]: } Apr 03 12:22:37 volumio volumio[1256]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 12:22:38 volumio sudo[15687]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-03 12:21' Apr 03 12:22:38 volumio sudo[15687]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"