-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Mon 2025-04-28 20:49:43 CEST. -- Apr 28 20:48:02 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::ClearQueue Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::stPlaybackTimer Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::serviceStop Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::serviceStop Apr 28 20:48:02 volumio volumio[3949]: info: ControllerMpd::stop Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::clearPlayQueue Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::addQueueItems Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::addQueueItems Apr 28 20:48:02 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:02 volumio volumio[3949]: info: Adding Item to queue: webeighties/11 Apr 28 20:48:02 volumio volumio[3949]: info: Exploding uri webeighties/11 in service 80s80s Apr 28 20:48:02 volumio volumio[3949]: info: [1745866082215] [80s80s] explodeUri: webeighties/11 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPlay Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::play index 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::play index undefined Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::startPlaybackTimer Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: [1745866082265] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/hamburg/mp3-192/volumio Apr 28 20:48:02 volumio volumio[3949]: info: [1745866082266] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=61&count=2 Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:02 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:02 volumio volumio[3949]: info: Apr 28 20:48:02 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:02 volumio volumio[3949]: info: sendMpdCommand stop took 92 milliseconds Apr 28 20:48:02 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music/v4/e8/6f/64/e86f6461-52aa-d75e-2dd1-392320ecb060/source/600x600bb.jpg","name":"Blackway - New Life","title":"New Life","artist":"80s80s Italo Disco","album":"","streaming":true,"disableUiControls":true,"duration":"243","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:02 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::syncState stateService stop Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:02 volumio volumio[3949]: info: No code Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:02 volumio volumio[3949]: info: Apr 28 20:48:02 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:02 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:02 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:02 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:02 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:02 volumio volumio[3949]: info: sendMpdCommand status took 73 milliseconds Apr 28 20:48:02 volumio volumio[3949]: info: sendMpdCommand status took 26 milliseconds Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:02 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 41 milliseconds Apr 28 20:48:02 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 41 milliseconds Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:02 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:02 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:02 volumio volumio[3949]: info: ------------------------------ 159ms Apr 28 20:48:02 volumio volumio[3949]: info: ------------------------------ 112ms Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:02 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:02 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:02 volumio volumio[3949]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:02 volumio volumio[3949]: info: [1745866082633] [80s80s] received new event containing 2 songs. Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:02 volumio volumio[3949]: info: sendMpdCommand stop took 2 milliseconds Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clear Apr 28 20:48:02 volumio volumio[3949]: info: Apr 28 20:48:02 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:02 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:02 volumio volumio[3949]: info: sendMpdCommand clear took 2 milliseconds Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 28 20:48:02 volumio volumio[3949]: info: Apr 28 20:48:02 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:02 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:02 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:02 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:02 volumio volumio[3949]: info: ------------------------------ 6ms Apr 28 20:48:02 volumio volumio[3949]: info: sendMpdCommand consume 1 took 4 milliseconds Apr 28 20:48:02 volumio volumio[3949]: info: ------------------------------ 4ms Apr 28 20:48:02 volumio volumio[3949]: info: [1745866082644] [80s80s] adding url: http://streams.80s80s.de/hamburg/mp3-192/volumio Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/hamburg/mp3-192/volumio" Apr 28 20:48:02 volumio volumio[3949]: info: Apr 28 20:48:02 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:02 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:02 volumio volumio[3949]: info: sendMpdCommand add "http://streams.80s80s.de/hamburg/mp3-192/volumio" took 1 milliseconds Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand play Apr 28 20:48:02 volumio volumio[3949]: info: Apr 28 20:48:02 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:02 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:02 volumio volumio[3949]: info: ------------------------------ 13ms Apr 28 20:48:02 volumio volumio[3949]: info: sendMpdCommand play took 5 milliseconds Apr 28 20:48:02 volumio volumio[3949]: info: ------------------------------ 5ms Apr 28 20:48:02 volumio volumio[3949]: info: [1745866082665] [80s80s] Pushing the next song state: Mary Jane Girls - Boys Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is1-ssl.mzstatic.com/image/thumb/Music125/v4/4d/62/bb/4d62bb8e-5171-9545-9b1f-f0648a4d0fc5/00737463540728.rgb.jpg/600x600bb.jpg","name":"Mary Jane Girls - Boys","title":"Boys","artist":"80s80s DAB Hamburg","album":"","streaming":true,"disableUiControls":true,"duration":"340","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:02 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::syncState stateService play Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:02 volumio volumio[3949]: info: [1745866082669] [80s80s] PlayNextTrack API delay: 30 Apr 28 20:48:02 volumio volumio[3949]: info: [1745866082673] [80s80s] Setting timer to: 340000 milliseconds. Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 1 Apr 28 20:48:02 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::ClearQueue Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::stPlaybackTimer Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::serviceStop Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::serviceStop Apr 28 20:48:02 volumio volumio[3949]: info: ControllerMpd::stop Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::clearPlayQueue Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::addQueueItems Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::addQueueItems Apr 28 20:48:02 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:02 volumio volumio[3949]: info: Adding Item to queue: webeighties/11 Apr 28 20:48:02 volumio volumio[3949]: info: Using cached record of: webeighties/11 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPlay Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::play index 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::play index undefined Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::startPlaybackTimer Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: [1745866082926] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/hamburg/mp3-192/volumio Apr 28 20:48:02 volumio volumio[3949]: info: [1745866082926] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=61&count=2 Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:02 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:02 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:02 volumio volumio[3949]: info: Apr 28 20:48:02 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:02 volumio volumio[3949]: info: sendMpdCommand stop took 51 milliseconds Apr 28 20:48:02 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:02 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is1-ssl.mzstatic.com/image/thumb/Music125/v4/4d/62/bb/4d62bb8e-5171-9545-9b1f-f0648a4d0fc5/00737463540728.rgb.jpg/600x600bb.jpg","name":"Mary Jane Girls - Boys","title":"Boys","artist":"80s80s DAB Hamburg","album":"","streaming":true,"disableUiControls":true,"duration":"340","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:02 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::syncState stateService stop Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:02 volumio volumio[3949]: info: No code Apr 28 20:48:02 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:02 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:02 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:03 volumio volumio[3949]: info: Apr 28 20:48:03 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:03 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:03 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:03 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:03 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:03 volumio volumio[3949]: info: sendMpdCommand status took 93 milliseconds Apr 28 20:48:03 volumio volumio[3949]: info: sendMpdCommand status took 27 milliseconds Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:03 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 28 20:48:03 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:03 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:03 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:03 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:03 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:03 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:03 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:03 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:03 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:03 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:03 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:03 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:03 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:03 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:03 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:03 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:03 volumio volumio[3949]: info: ------------------------------ 130ms Apr 28 20:48:03 volumio volumio[3949]: info: ------------------------------ 63ms Apr 28 20:48:03 volumio volumio[3949]: error: FusionDsp - WebSocket error: [object Object] Apr 28 20:48:03 volumio volumio[3949]: error: FusionDsp - WebSocket error: [object Object] Apr 28 20:48:03 volumio volumio[3949]: error: FusionDsp - WebSocket error: [object Object] Apr 28 20:48:03 volumio volumio[3949]: error: FusionDsp - WebSocket error: [object Object] Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:03 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:03 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:03 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:03 volumio volumio[3949]: error: FusionDsp - WebSocket error: [object Object] Apr 28 20:48:03 volumio volumio[3949]: error: FusionDsp - WebSocket error: [object Object] Apr 28 20:48:03 volumio volumio[3949]: info: [1745866083261] [80s80s] received new event containing 2 songs. Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:03 volumio volumio[3949]: info: sendMpdCommand stop took 2 milliseconds Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clear Apr 28 20:48:03 volumio volumio[3949]: info: Apr 28 20:48:03 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:03 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:03 volumio volumio[3949]: info: sendMpdCommand clear took 1 milliseconds Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 28 20:48:03 volumio volumio[3949]: info: Apr 28 20:48:03 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:03 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:03 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:03 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:03 volumio volumio[3949]: info: ------------------------------ 3ms Apr 28 20:48:03 volumio volumio[3949]: info: sendMpdCommand consume 1 took 2 milliseconds Apr 28 20:48:03 volumio volumio[3949]: info: ------------------------------ 2ms Apr 28 20:48:03 volumio volumio[3949]: info: [1745866083268] [80s80s] adding url: http://streams.80s80s.de/hamburg/mp3-192/volumio Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/hamburg/mp3-192/volumio" Apr 28 20:48:03 volumio volumio[3949]: info: Apr 28 20:48:03 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:03 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:03 volumio volumio[3949]: info: sendMpdCommand add "http://streams.80s80s.de/hamburg/mp3-192/volumio" took 1 milliseconds Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand play Apr 28 20:48:03 volumio volumio[3949]: info: Apr 28 20:48:03 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:03 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:03 volumio volumio[3949]: info: ------------------------------ 12ms Apr 28 20:48:03 volumio volumio[3949]: info: sendMpdCommand play took 4 milliseconds Apr 28 20:48:03 volumio volumio[3949]: info: ------------------------------ 3ms Apr 28 20:48:03 volumio volumio[3949]: info: [1745866083282] [80s80s] Pushing the next song state: Mary Jane Girls - Boys Apr 28 20:48:03 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:03 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:03 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:03 volumio volumio[3949]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is1-ssl.mzstatic.com/image/thumb/Music125/v4/4d/62/bb/4d62bb8e-5171-9545-9b1f-f0648a4d0fc5/00737463540728.rgb.jpg/600x600bb.jpg","name":"Mary Jane Girls - Boys","title":"Boys","artist":"80s80s DAB Hamburg","album":"","streaming":true,"disableUiControls":true,"duration":"340","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:03 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:03 volumio volumio[3949]: info: CoreStateMachine::syncState stateService play Apr 28 20:48:03 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:03 volumio volumio[3949]: info: [1745866083284] [80s80s] PlayNextTrack API delay: 30 Apr 28 20:48:03 volumio volumio[3949]: info: [1745866083285] [80s80s] Setting timer to: 340000 milliseconds. Apr 28 20:48:03 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:03 volumio volumio[3949]: info: CorePlayQueue::getTrack 1 Apr 28 20:48:03 volumio volumio[3949]: info: Apr 28 20:48:03 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:03 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:03 volumio volumio[3949]: info: Apr 28 20:48:03 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:03 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 28 20:48:03 volumio volumio[3949]: info: sendMpdCommand status took 12 milliseconds Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:03 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:04 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 28 20:48:04 volumio volumio[3949]: info: sendMpdCommand status took 29 milliseconds Apr 28 20:48:04 volumio volumio[3949]: info: sendMpdCommand clearerror took 20 milliseconds Apr 28 20:48:04 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 18 milliseconds Apr 28 20:48:04 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:04 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:04 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:04 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:04 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:04 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:04 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:04 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:04 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:04 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:04 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:04 volumio volumio[3949]: info: ------------------------------ 55ms Apr 28 20:48:04 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:04 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:04 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:04 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:04 volumio volumio[3949]: info: [LastFM] Current track has sufficient metadata: title (Mary Jane Girls - Boys) and artist (80s80s DAB Hamburg) passed on explicitly Apr 28 20:48:04 volumio volumio[3949]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Apr 28 20:48:04 volumio volumio[3949]: info: sendMpdCommand clearerror took 38 milliseconds Apr 28 20:48:04 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 36 milliseconds Apr 28 20:48:04 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:04 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:04 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:04 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:04 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:04 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:04 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:04 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:04 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:04 volumio volumio[3949]: info: ------------------------------ 91ms Apr 28 20:48:04 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:04 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:04 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:04 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:04 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:04 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:11 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::ClearQueue Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::stPlaybackTimer Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::serviceStop Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::serviceStop Apr 28 20:48:11 volumio volumio[3949]: info: ControllerMpd::stop Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::clearPlayQueue Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::addQueueItems Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::addQueueItems Apr 28 20:48:11 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:11 volumio volumio[3949]: info: Adding Item to queue: webeighties/11 Apr 28 20:48:11 volumio volumio[3949]: info: Using cached record of: webeighties/11 Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::volumioPlay Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::play index 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::play index undefined Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::startPlaybackTimer Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: [1745866091105] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/hamburg/mp3-192/volumio Apr 28 20:48:11 volumio volumio[3949]: info: [1745866091105] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=61&count=2 Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:11 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand stop took 71 milliseconds Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is1-ssl.mzstatic.com/image/thumb/Music125/v4/4d/62/bb/4d62bb8e-5171-9545-9b1f-f0648a4d0fc5/00737463540728.rgb.jpg/600x600bb.jpg","name":"Mary Jane Girls - Boys","title":"Boys","artist":"80s80s DAB Hamburg","album":"","streaming":true,"disableUiControls":true,"duration":"340","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:11 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::syncState stateService stop Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:11 volumio volumio[3949]: info: No code Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:11 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:11 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:11 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:11 volumio volumio[3949]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:11 volumio volumio[3949]: info: [1745866091252] [80s80s] received new event containing 2 songs. Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand stop took 1 milliseconds Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clear Apr 28 20:48:11 volumio volumio[3949]: info: Apr 28 20:48:11 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:11 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand clear took 1 milliseconds Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 28 20:48:11 volumio volumio[3949]: info: Apr 28 20:48:11 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:11 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:11 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:11 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:11 volumio volumio[3949]: info: ------------------------------ 4ms Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand consume 1 took 2 milliseconds Apr 28 20:48:11 volumio volumio[3949]: info: ------------------------------ 2ms Apr 28 20:48:11 volumio volumio[3949]: info: [1745866091258] [80s80s] adding url: http://streams.80s80s.de/hamburg/mp3-192/volumio Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/hamburg/mp3-192/volumio" Apr 28 20:48:11 volumio volumio[3949]: info: Apr 28 20:48:11 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:11 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand add "http://streams.80s80s.de/hamburg/mp3-192/volumio" took 1 milliseconds Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand play Apr 28 20:48:11 volumio volumio[3949]: info: Apr 28 20:48:11 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:11 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:11 volumio volumio[3949]: info: ------------------------------ 11ms Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand play took 2 milliseconds Apr 28 20:48:11 volumio volumio[3949]: info: ------------------------------ 1ms Apr 28 20:48:11 volumio volumio[3949]: info: [1745866091271] [80s80s] Pushing the next song state: Mary Jane Girls - Boys Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is1-ssl.mzstatic.com/image/thumb/Music125/v4/4d/62/bb/4d62bb8e-5171-9545-9b1f-f0648a4d0fc5/00737463540728.rgb.jpg/600x600bb.jpg","name":"Mary Jane Girls - Boys","title":"Boys","artist":"80s80s DAB Hamburg","album":"","streaming":true,"disableUiControls":true,"duration":"340","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:11 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::syncState stateService play Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:11 volumio volumio[3949]: info: [1745866091272] [80s80s] PlayNextTrack API delay: 30 Apr 28 20:48:11 volumio volumio[3949]: info: [1745866091273] [80s80s] Setting timer to: 340000 milliseconds. Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 1 Apr 28 20:48:11 volumio volumio[3949]: info: Apr 28 20:48:11 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:11 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:11 volumio volumio[3949]: info: Apr 28 20:48:11 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:11 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand status took 9 milliseconds Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand status took 16 milliseconds Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand clearerror took 9 milliseconds Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:11 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:11 volumio volumio[3949]: info: ------------------------------ 35ms Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:11 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand clearerror took 29 milliseconds Apr 28 20:48:11 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 28 milliseconds Apr 28 20:48:11 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:11 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:11 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:11 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:11 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:11 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:11 volumio volumio[3949]: info: ------------------------------ 67ms Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:11 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:11 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:17 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::ClearQueue Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::stPlaybackTimer Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::serviceStop Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::serviceStop Apr 28 20:48:17 volumio volumio[3949]: info: ControllerMpd::stop Apr 28 20:48:17 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::clearPlayQueue Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::addQueueItems Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::addQueueItems Apr 28 20:48:17 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:17 volumio volumio[3949]: info: Adding Item to queue: webeighties/10 Apr 28 20:48:17 volumio volumio[3949]: info: Exploding uri webeighties/10 in service 80s80s Apr 28 20:48:17 volumio volumio[3949]: info: [1745866097491] [80s80s] explodeUri: webeighties/10 Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::volumioPlay Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::play index 0 Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::play index undefined Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::startPlaybackTimer Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:17 volumio volumio[3949]: info: [1745866097550] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/christmas/mp3-192/volumio Apr 28 20:48:17 volumio volumio[3949]: info: [1745866097551] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=75&count=2 Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:17 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:17 volumio volumio[3949]: info: sendMpdCommand stop took 93 milliseconds Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:17 volumio volumio[3949]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is1-ssl.mzstatic.com/image/thumb/Music125/v4/4d/62/bb/4d62bb8e-5171-9545-9b1f-f0648a4d0fc5/00737463540728.rgb.jpg/600x600bb.jpg","name":"Mary Jane Girls - Boys","title":"Boys","artist":"80s80s DAB Hamburg","album":"","streaming":true,"disableUiControls":true,"duration":"340","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:17 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::syncState stateService stop Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:17 volumio volumio[3949]: info: No code Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:17 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:17 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:17 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:17 volumio volumio[3949]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 28 20:48:17 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:17 volumio volumio[3949]: info: [1745866097836] [80s80s] received new event containing 2 songs. Apr 28 20:48:17 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:17 volumio volumio[3949]: info: sendMpdCommand stop took 1 milliseconds Apr 28 20:48:17 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clear Apr 28 20:48:17 volumio volumio[3949]: info: Apr 28 20:48:17 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:17 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:17 volumio volumio[3949]: info: sendMpdCommand clear took 2 milliseconds Apr 28 20:48:17 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 28 20:48:17 volumio volumio[3949]: info: Apr 28 20:48:17 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:17 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:17 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:17 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:17 volumio volumio[3949]: info: ------------------------------ 5ms Apr 28 20:48:17 volumio volumio[3949]: info: sendMpdCommand consume 1 took 3 milliseconds Apr 28 20:48:17 volumio volumio[3949]: info: ------------------------------ 2ms Apr 28 20:48:17 volumio volumio[3949]: info: [1745866097845] [80s80s] adding url: http://streams.80s80s.de/christmas/mp3-192/volumio Apr 28 20:48:17 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/christmas/mp3-192/volumio" Apr 28 20:48:17 volumio volumio[3949]: info: Apr 28 20:48:17 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:17 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:17 volumio volumio[3949]: info: sendMpdCommand add "http://streams.80s80s.de/christmas/mp3-192/volumio" took 1 milliseconds Apr 28 20:48:17 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand play Apr 28 20:48:17 volumio volumio[3949]: info: Apr 28 20:48:17 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:17 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:17 volumio volumio[3949]: info: ------------------------------ 16ms Apr 28 20:48:17 volumio volumio[3949]: info: sendMpdCommand play took 3 milliseconds Apr 28 20:48:17 volumio volumio[3949]: info: ------------------------------ 2ms Apr 28 20:48:17 volumio volumio[3949]: info: [1745866097863] [80s80s] Pushing the next song state: PG Roxette - Wishing On The Same Christmas Star Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:17 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:17 volumio volumio[3949]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"/albumart?sourceicon=music_service/80s80s/images/80s80s-christmas-cover.png","name":"PG Roxette - Wishing On The Same Christmas Star","title":"Wishing On The Same Christmas Star","artist":"80s80s Christmas","album":"","streaming":true,"disableUiControls":true,"duration":"211","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:17 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::syncState stateService play Apr 28 20:48:17 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:17 volumio volumio[3949]: info: [1745866097865] [80s80s] PlayNextTrack API delay: 30 Apr 28 20:48:17 volumio volumio[3949]: info: [1745866097866] [80s80s] Setting timer to: 211000 milliseconds. Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:17 volumio volumio[3949]: info: CorePlayQueue::getTrack 1 Apr 28 20:48:19 volumio volumio[3949]: info: Apr 28 20:48:19 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:19 volumio volumio[3949]: info: Apr 28 20:48:19 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:19 volumio volumio[3949]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 28 20:48:19 volumio volumio[3949]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 28 20:48:19 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:19 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:19 volumio volumio[3949]: info: Apr 28 20:48:19 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand status took 21 milliseconds Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand status took 20 milliseconds Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:19 volumio volumio[3949]: info: Apr 28 20:48:19 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand status took 5 milliseconds Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand status took 2 milliseconds Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:19 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:19 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:19 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:19 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:19 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:19 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:19 volumio volumio[3949]: info: ------------------------------ 34ms Apr 28 20:48:19 volumio volumio[3949]: info: ------------------------------ 33ms Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:19 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:19 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:19 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:19 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:19 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:19 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:19 volumio volumio[3949]: info: ------------------------------ 19ms Apr 28 20:48:19 volumio volumio[3949]: info: ------------------------------ 15ms Apr 28 20:48:19 volumio volumio[3949]: info: Apr 28 20:48:19 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:19 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:19 volumio volumio[3949]: info: Apr 28 20:48:19 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:19 volumio volumio[3949]: info: Apr 28 20:48:19 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:19 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:19 volumio volumio[3949]: info: Apr 28 20:48:19 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:19 volumio volumio[3949]: info: ------------------------------ 7ms Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand status took 5 milliseconds Apr 28 20:48:19 volumio volumio[3949]: info: ------------------------------ 3ms Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:19 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand status took 4 milliseconds Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:19 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:19 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:19 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:19 volumio volumio[3949]: info: ------------------------------ 11ms Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:19 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:19 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:19 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:19 volumio volumio[3949]: info: ------------------------------ 9ms Apr 28 20:48:19 volumio volumio[3949]: info: Apr 28 20:48:19 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:19 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:19 volumio volumio[3949]: info: Apr 28 20:48:19 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:19 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:19 volumio volumio[3949]: info: ------------------------------ 8ms Apr 28 20:48:19 volumio volumio[3949]: info: sendMpdCommand status took 7 milliseconds Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:19 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:20 volumio volumio[3949]: info: Apr 28 20:48:20 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:20 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:20 volumio volumio[3949]: info: Apr 28 20:48:20 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:20 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:20 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:20 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 28 20:48:20 volumio volumio[3949]: info: ------------------------------ 10ms Apr 28 20:48:20 volumio volumio[3949]: info: sendMpdCommand status took 4 milliseconds Apr 28 20:48:20 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:20 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:20 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:20 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:20 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:20 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:20 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:20 volumio volumio[3949]: info: ------------------------------ 32ms Apr 28 20:48:20 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 28 20:48:20 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:20 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:20 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:20 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:20 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:20 volumio volumio[3949]: info: ------------------------------ 20ms Apr 28 20:48:21 volumio kernel: hwmon hwmon1: Undervoltage detected! Apr 28 20:48:22 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::ClearQueue Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::stPlaybackTimer Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::serviceStop Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::serviceStop Apr 28 20:48:22 volumio volumio[3949]: info: ControllerMpd::stop Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::clearPlayQueue Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::addQueueItems Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::addQueueItems Apr 28 20:48:22 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:22 volumio volumio[3949]: info: Adding Item to queue: webeighties/6 Apr 28 20:48:22 volumio volumio[3949]: info: Exploding uri webeighties/6 in service 80s80s Apr 28 20:48:22 volumio volumio[3949]: info: [1745866102280] [80s80s] explodeUri: webeighties/6 Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::volumioPlay Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::play index 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::play index undefined Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::startPlaybackTimer Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: [1745866102401] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/dm/mp3-192/volumio Apr 28 20:48:22 volumio volumio[3949]: info: [1745866102401] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=87&count=2 Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:22 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:22 volumio volumio[3949]: info: Apr 28 20:48:22 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:22 volumio volumio[3949]: info: sendMpdCommand stop took 177 milliseconds Apr 28 20:48:22 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"/albumart?sourceicon=music_service/80s80s/images/80s80s-christmas-cover.png","name":"PG Roxette - Wishing On The Same Christmas Star","title":"Wishing On The Same Christmas Star","artist":"80s80s Christmas","album":"","streaming":true,"disableUiControls":true,"duration":"211","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:22 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::syncState stateService stop Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:22 volumio volumio[3949]: info: No code Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:22 volumio volumio[3949]: info: Apr 28 20:48:22 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:22 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:22 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:22 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:22 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:22 volumio volumio[3949]: info: sendMpdCommand status took 184 milliseconds Apr 28 20:48:22 volumio volumio[3949]: info: sendMpdCommand status took 94 milliseconds Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:22 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 28 20:48:22 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:22 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:22 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:22 volumio volumio[3949]: info: ------------------------------ 261ms Apr 28 20:48:22 volumio volumio[3949]: info: ------------------------------ 171ms Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:22 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:22 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:22 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:22 volumio volumio[3949]: info: [1745866102859] [80s80s] received new event containing 2 songs. Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:22 volumio volumio[3949]: info: sendMpdCommand stop took 11 milliseconds Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clear Apr 28 20:48:22 volumio volumio[3949]: info: Apr 28 20:48:22 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:22 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:22 volumio volumio[3949]: info: sendMpdCommand clear took 3 milliseconds Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 28 20:48:22 volumio volumio[3949]: info: Apr 28 20:48:22 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:22 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:22 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:22 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:22 volumio volumio[3949]: info: ------------------------------ 7ms Apr 28 20:48:22 volumio volumio[3949]: info: sendMpdCommand consume 1 took 5 milliseconds Apr 28 20:48:22 volumio volumio[3949]: info: ------------------------------ 4ms Apr 28 20:48:22 volumio volumio[3949]: info: [1745866102882] [80s80s] adding url: http://streams.80s80s.de/dm/mp3-192/volumio Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/dm/mp3-192/volumio" Apr 28 20:48:22 volumio volumio[3949]: info: Apr 28 20:48:22 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:22 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:22 volumio volumio[3949]: info: sendMpdCommand add "http://streams.80s80s.de/dm/mp3-192/volumio" took 2 milliseconds Apr 28 20:48:22 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand play Apr 28 20:48:22 volumio volumio[3949]: info: ------------------------------ 27ms Apr 28 20:48:22 volumio volumio[3949]: info: Apr 28 20:48:22 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:22 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:22 volumio volumio[3949]: info: sendMpdCommand play took 12 milliseconds Apr 28 20:48:22 volumio volumio[3949]: info: ------------------------------ 10ms Apr 28 20:48:22 volumio volumio[3949]: info: [1745866102922] [80s80s] Pushing the next song state: Depeche Mode - Precious Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music/v4/ba/a2/34/baa23498-551c-d5b9-7405-ca147b564837/source/600x600bb.jpg","name":"Depeche Mode - Precious","title":"Precious","artist":"80s80s Depeche Mode","album":"","streaming":true,"disableUiControls":true,"duration":"230","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:22 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::syncState stateService play Apr 28 20:48:22 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:22 volumio volumio[3949]: info: [1745866102925] [80s80s] PlayNextTrack API delay: 30 Apr 28 20:48:22 volumio volumio[3949]: info: [1745866102928] [80s80s] Setting timer to: 230000 milliseconds. Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:22 volumio volumio[3949]: info: CorePlayQueue::getTrack 1 Apr 28 20:48:23 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::ClearQueue Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::stPlaybackTimer Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::serviceStop Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::serviceStop Apr 28 20:48:23 volumio volumio[3949]: info: ControllerMpd::stop Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::clearPlayQueue Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::addQueueItems Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::addQueueItems Apr 28 20:48:23 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:23 volumio volumio[3949]: info: Adding Item to queue: webeighties/6 Apr 28 20:48:23 volumio volumio[3949]: info: Using cached record of: webeighties/6 Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::volumioPlay Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::play index 0 Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::play index undefined Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::startPlaybackTimer Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: info: [1745866103759] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/dm/mp3-192/volumio Apr 28 20:48:23 volumio volumio[3949]: info: [1745866103759] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=87&count=2 Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:23 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:23 volumio volumio[3949]: info: Apr 28 20:48:23 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:23 volumio volumio[3949]: info: sendMpdCommand stop took 67 milliseconds Apr 28 20:48:23 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music/v4/ba/a2/34/baa23498-551c-d5b9-7405-ca147b564837/source/600x600bb.jpg","name":"Depeche Mode - Precious","title":"Precious","artist":"80s80s Depeche Mode","album":"","streaming":true,"disableUiControls":true,"duration":"230","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:23 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::syncState stateService stop Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:23 volumio volumio[3949]: info: No code Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:23 volumio volumio[3949]: info: Apr 28 20:48:23 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:23 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:23 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:23 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:23 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:23 volumio volumio[3949]: info: sendMpdCommand status took 105 milliseconds Apr 28 20:48:23 volumio volumio[3949]: info: sendMpdCommand status took 32 milliseconds Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:23 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 28 20:48:23 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:23 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:23 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:23 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:23 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:23 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:23 volumio volumio[3949]: info: ------------------------------ 153ms Apr 28 20:48:23 volumio volumio[3949]: info: ------------------------------ 79ms Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:23 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:23 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:23 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:23 volumio volumio[3949]: info: [1745866103988] [80s80s] received new event containing 2 songs. Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:23 volumio volumio[3949]: info: sendMpdCommand stop took 1 milliseconds Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clear Apr 28 20:48:23 volumio volumio[3949]: info: Apr 28 20:48:23 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:23 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:23 volumio volumio[3949]: info: sendMpdCommand clear took 2 milliseconds Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 28 20:48:23 volumio volumio[3949]: info: Apr 28 20:48:23 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:23 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:23 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:23 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:23 volumio volumio[3949]: info: ------------------------------ 4ms Apr 28 20:48:23 volumio volumio[3949]: info: sendMpdCommand consume 1 took 3 milliseconds Apr 28 20:48:23 volumio volumio[3949]: info: ------------------------------ 2ms Apr 28 20:48:23 volumio volumio[3949]: info: [1745866103995] [80s80s] adding url: http://streams.80s80s.de/dm/mp3-192/volumio Apr 28 20:48:23 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/dm/mp3-192/volumio" Apr 28 20:48:23 volumio volumio[3949]: info: Apr 28 20:48:23 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:23 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:23 volumio volumio[3949]: info: sendMpdCommand add "http://streams.80s80s.de/dm/mp3-192/volumio" took 1 milliseconds Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand play Apr 28 20:48:24 volumio volumio[3949]: info: Apr 28 20:48:24 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:24 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:24 volumio volumio[3949]: info: ------------------------------ 10ms Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand play took 3 milliseconds Apr 28 20:48:24 volumio volumio[3949]: info: [1745866104007] [80s80s] Pushing the next song state: Depeche Mode - Precious Apr 28 20:48:24 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:24 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:24 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:24 volumio volumio[3949]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music/v4/ba/a2/34/baa23498-551c-d5b9-7405-ca147b564837/source/600x600bb.jpg","name":"Depeche Mode - Precious","title":"Precious","artist":"80s80s Depeche Mode","album":"","streaming":true,"disableUiControls":true,"duration":"230","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:24 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:24 volumio volumio[3949]: info: CoreStateMachine::syncState stateService play Apr 28 20:48:24 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:24 volumio volumio[3949]: info: [1745866104008] [80s80s] PlayNextTrack API delay: 30 Apr 28 20:48:24 volumio volumio[3949]: info: [1745866104010] [80s80s] Setting timer to: 230000 milliseconds. Apr 28 20:48:24 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:24 volumio volumio[3949]: info: CorePlayQueue::getTrack 1 Apr 28 20:48:24 volumio volumio[3949]: info: ------------------------------ 9ms Apr 28 20:48:24 volumio volumio[3949]: info: Apr 28 20:48:24 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:24 volumio volumio[3949]: info: Apr 28 20:48:24 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:24 volumio volumio[3949]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 28 20:48:24 volumio volumio[3949]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 28 20:48:24 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:24 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:24 volumio volumio[3949]: info: Apr 28 20:48:24 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand status took 31 milliseconds Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand status took 31 milliseconds Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:24 volumio volumio[3949]: info: Apr 28 20:48:24 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:24 volumio volumio[3949]: info: Apr 28 20:48:24 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:24 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:24 volumio volumio[3949]: info: Apr 28 20:48:24 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand status took 19 milliseconds Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 18 milliseconds Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:24 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:24 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:24 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:24 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:24 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:24 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:24 volumio volumio[3949]: info: ------------------------------ 55ms Apr 28 20:48:24 volumio volumio[3949]: info: ------------------------------ 53ms Apr 28 20:48:24 volumio volumio[3949]: info: Apr 28 20:48:24 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:24 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:24 volumio volumio[3949]: info: Apr 28 20:48:24 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand status took 22 milliseconds Apr 28 20:48:24 volumio volumio[3949]: info: ------------------------------ 7ms Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand status took 7 milliseconds Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:24 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:24 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:24 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:24 volumio volumio[3949]: info: ------------------------------ 30ms Apr 28 20:48:24 volumio volumio[3949]: info: ------------------------------ 9ms Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand status took 8 milliseconds Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:24 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:24 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:24 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:24 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:24 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:24 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:24 volumio volumio[3949]: info: ------------------------------ 31ms Apr 28 20:48:24 volumio volumio[3949]: info: ------------------------------ 16ms Apr 28 20:48:24 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 28 20:48:24 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:24 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:24 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:24 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:24 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:24 volumio volumio[3949]: info: ------------------------------ 15ms Apr 28 20:48:24 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:25 volumio volumio[3949]: info: Apr 28 20:48:25 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:25 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:25 volumio volumio[3949]: info: Apr 28 20:48:25 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:25 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:25 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:25 volumio volumio[3949]: info: Apr 28 20:48:25 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:25 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:25 volumio volumio[3949]: info: Apr 28 20:48:25 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:25 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:25 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:25 volumio volumio[3949]: info: ------------------------------ 6ms Apr 28 20:48:25 volumio volumio[3949]: info: sendMpdCommand status took 5 milliseconds Apr 28 20:48:25 volumio volumio[3949]: info: ------------------------------ 5ms Apr 28 20:48:25 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:25 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:25 volumio volumio[3949]: info: sendMpdCommand status took 6 milliseconds Apr 28 20:48:25 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 28 20:48:25 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:25 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:25 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:25 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:25 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:25 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:25 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:25 volumio volumio[3949]: info: ------------------------------ 14ms Apr 28 20:48:25 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 28 20:48:25 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:25 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:25 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:25 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:25 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:25 volumio volumio[3949]: info: ------------------------------ 16ms Apr 28 20:48:25 volumio kernel: hwmon hwmon1: Voltage normalised Apr 28 20:48:35 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::ClearQueue Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::stPlaybackTimer Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::serviceStop Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::serviceStop Apr 28 20:48:35 volumio volumio[3949]: info: ControllerMpd::stop Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::clearPlayQueue Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::addQueueItems Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::addQueueItems Apr 28 20:48:35 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:35 volumio volumio[3949]: info: Adding Item to queue: webeighties/0 Apr 28 20:48:35 volumio volumio[3949]: info: Exploding uri webeighties/0 in service 80s80s Apr 28 20:48:35 volumio volumio[3949]: info: [1745866115215] [80s80s] explodeUri: webeighties/0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPlay Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::play index 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::play index undefined Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::startPlaybackTimer Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: [1745866115262] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/web/mp3-192/volumio Apr 28 20:48:35 volumio volumio[3949]: info: [1745866115262] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=2 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:35 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:35 volumio volumio[3949]: info: Apr 28 20:48:35 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:35 volumio volumio[3949]: info: sendMpdCommand stop took 78 milliseconds Apr 28 20:48:35 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music/v4/ba/a2/34/baa23498-551c-d5b9-7405-ca147b564837/source/600x600bb.jpg","name":"Depeche Mode - Precious","title":"Precious","artist":"80s80s Depeche Mode","album":"","streaming":true,"disableUiControls":true,"duration":"230","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:35 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::syncState stateService stop Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:35 volumio volumio[3949]: info: No code Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:35 volumio volumio[3949]: info: Apr 28 20:48:35 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:35 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:35 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:35 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:35 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:35 volumio volumio[3949]: info: sendMpdCommand status took 76 milliseconds Apr 28 20:48:35 volumio volumio[3949]: info: sendMpdCommand status took 34 milliseconds Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:35 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 28 20:48:35 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:35 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:35 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:35 volumio volumio[3949]: info: ------------------------------ 116ms Apr 28 20:48:35 volumio volumio[3949]: info: ------------------------------ 76ms Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:35 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:35 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:35 volumio volumio[3949]: info: [1745866115572] [80s80s] received new event containing 2 songs. Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:35 volumio volumio[3949]: info: sendMpdCommand stop took 1 milliseconds Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clear Apr 28 20:48:35 volumio volumio[3949]: info: Apr 28 20:48:35 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:35 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:35 volumio volumio[3949]: info: sendMpdCommand clear took 1 milliseconds Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 28 20:48:35 volumio volumio[3949]: info: Apr 28 20:48:35 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:35 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:35 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:35 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:35 volumio volumio[3949]: info: ------------------------------ 3ms Apr 28 20:48:35 volumio volumio[3949]: info: sendMpdCommand consume 1 took 2 milliseconds Apr 28 20:48:35 volumio volumio[3949]: info: ------------------------------ 6ms Apr 28 20:48:35 volumio volumio[3949]: info: [1745866115583] [80s80s] adding url: http://streams.80s80s.de/web/mp3-192/volumio Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/web/mp3-192/volumio" Apr 28 20:48:35 volumio volumio[3949]: info: Apr 28 20:48:35 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:35 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:35 volumio volumio[3949]: info: sendMpdCommand add "http://streams.80s80s.de/web/mp3-192/volumio" took 2 milliseconds Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand play Apr 28 20:48:35 volumio volumio[3949]: info: Apr 28 20:48:35 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:35 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:35 volumio volumio[3949]: info: ------------------------------ 13ms Apr 28 20:48:35 volumio volumio[3949]: info: sendMpdCommand play took 7 milliseconds Apr 28 20:48:35 volumio volumio[3949]: info: ------------------------------ 6ms Apr 28 20:48:35 volumio volumio[3949]: info: [1745866115603] [80s80s] Pushing the next song state: Michael Jackson - Billie Jean Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/fc/ce/46/fcce4657-36b3-d3ba-c0cf-d4d888b1ed5d/source/600x600bb.jpg","name":"Michael Jackson - Billie Jean","title":"Billie Jean","artist":"80s80s Real 80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"280","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:35 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::syncState stateService play Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:35 volumio volumio[3949]: info: [1745866115603] [80s80s] PlayNextTrack API delay: 30 Apr 28 20:48:35 volumio volumio[3949]: info: [1745866115604] [80s80s] Setting timer to: 280000 milliseconds. Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 1 Apr 28 20:48:35 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::ClearQueue Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::stPlaybackTimer Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::serviceStop Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::serviceStop Apr 28 20:48:35 volumio volumio[3949]: info: ControllerMpd::stop Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::clearPlayQueue Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::addQueueItems Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::addQueueItems Apr 28 20:48:35 volumio volumio[3949]: info: Preload queue cleared Apr 28 20:48:35 volumio volumio[3949]: info: Adding Item to queue: webeighties/0 Apr 28 20:48:35 volumio volumio[3949]: info: Using cached record of: webeighties/0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushQueue Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::saveQueue Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::updateTrackBlock Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrackBlock Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPlay Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::play index 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::stop Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::play index undefined Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::startPlaybackTimer Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: [1745866115923] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/web/mp3-192/volumio Apr 28 20:48:35 volumio volumio[3949]: info: [1745866115923] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=2 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:35 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:35 volumio volumio[3949]: info: Apr 28 20:48:35 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:35 volumio volumio[3949]: info: sendMpdCommand stop took 46 milliseconds Apr 28 20:48:35 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/fc/ce/46/fcce4657-36b3-d3ba-c0cf-d4d888b1ed5d/source/600x600bb.jpg","name":"Michael Jackson - Billie Jean","title":"Billie Jean","artist":"80s80s Real 80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"280","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:35 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::syncState stateService stop Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:35 volumio volumio[3949]: info: No code Apr 28 20:48:35 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:35 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:35 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:35 volumio volumio[3949]: info: Apr 28 20:48:35 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:35 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:35 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:35 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:36 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:36 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:36 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:36 volumio volumio[3949]: info: sendMpdCommand status took 74 milliseconds Apr 28 20:48:36 volumio volumio[3949]: info: sendMpdCommand status took 29 milliseconds Apr 28 20:48:36 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:36 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:36 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:36 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:36 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 28 20:48:36 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 28 20:48:36 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:36 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:36 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:36 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:36 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:36 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:36 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 20:48:36 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:36 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:36 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:36 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:36 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:36 volumio volumio[3949]: info: CoreStateMachine::pushState Apr 28 20:48:36 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:36 volumio volumio[3949]: info: CoreCommandRouter::volumioPushState Apr 28 20:48:36 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:36 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:36 volumio volumio[3949]: info: ------------------------------ 112ms Apr 28 20:48:36 volumio volumio[3949]: info: ------------------------------ 68ms Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - volume level for loudness 83 gain applied 0.00 Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:36 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:36 volumio volumio[3949]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:36 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:36 volumio volumio[3949]: info: [1745866116120] [80s80s] received new event containing 2 songs. Apr 28 20:48:36 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 20:48:36 volumio volumio[3949]: info: sendMpdCommand stop took 34 milliseconds Apr 28 20:48:36 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand clear Apr 28 20:48:36 volumio volumio[3949]: info: Apr 28 20:48:36 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:36 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:36 volumio volumio[3949]: info: sendMpdCommand clear took 4 milliseconds Apr 28 20:48:36 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 28 20:48:36 volumio volumio[3949]: error: updateQueue error: null Apr 28 20:48:36 volumio volumio[3949]: info: ------------------------------ 7ms Apr 28 20:48:36 volumio volumio[3949]: info: sendMpdCommand consume 1 took 2 milliseconds Apr 28 20:48:36 volumio volumio[3949]: info: [1745866116166] [80s80s] adding url: http://streams.80s80s.de/web/mp3-192/volumio Apr 28 20:48:36 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/web/mp3-192/volumio" Apr 28 20:48:36 volumio volumio[3949]: info: Apr 28 20:48:36 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:36 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:36 volumio volumio[3949]: info: Apr 28 20:48:36 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:36 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:36 volumio volumio[3949]: info: sendMpdCommand add "http://streams.80s80s.de/web/mp3-192/volumio" took 4 milliseconds Apr 28 20:48:36 volumio volumio[3949]: info: ------------------------------ 3ms Apr 28 20:48:36 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand play Apr 28 20:48:36 volumio volumio[3949]: info: Apr 28 20:48:36 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:36 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:36 volumio volumio[3949]: info: ------------------------------ 14ms Apr 28 20:48:36 volumio volumio[3949]: info: sendMpdCommand play took 9 milliseconds Apr 28 20:48:36 volumio volumio[3949]: info: ------------------------------ 14ms Apr 28 20:48:36 volumio volumio[3949]: info: [1745866116196] [80s80s] Pushing the next song state: Michael Jackson - Billie Jean Apr 28 20:48:36 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:36 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:36 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:36 volumio volumio[3949]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/fc/ce/46/fcce4657-36b3-d3ba-c0cf-d4d888b1ed5d/source/600x600bb.jpg","name":"Michael Jackson - Billie Jean","title":"Billie Jean","artist":"80s80s Real 80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"280","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 28 20:48:36 volumio volumio[3949]: verbose: CURRENT POSITION 0 Apr 28 20:48:36 volumio volumio[3949]: info: CoreStateMachine::syncState stateService play Apr 28 20:48:36 volumio volumio[3949]: info: CoreStateMachine::syncState currentStatus stop Apr 28 20:48:36 volumio volumio[3949]: info: [1745866116197] [80s80s] PlayNextTrack API delay: 30 Apr 28 20:48:36 volumio volumio[3949]: info: [1745866116198] [80s80s] Setting timer to: 280000 milliseconds. Apr 28 20:48:36 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:36 volumio volumio[3949]: info: CorePlayQueue::getTrack 1 Apr 28 20:48:37 volumio volumio[3949]: info: Apr 28 20:48:37 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:37 volumio volumio[3949]: info: Apr 28 20:48:37 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:37 volumio volumio[3949]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 28 20:48:37 volumio volumio[3949]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 28 20:48:37 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:37 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:37 volumio volumio[3949]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 28 20:48:37 volumio volumio[3949]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 28 20:48:37 volumio volumio[3949]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 28 20:48:37 volumio volumio[3949]: info: FusionDsp - Loudness is ON true Apr 28 20:48:37 volumio volumio[3949]: info: Apr 28 20:48:37 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand status took 26 milliseconds Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand status took 24 milliseconds Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:37 volumio volumio[3949]: info: Apr 28 20:48:37 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand status took 5 milliseconds Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand status took 2 milliseconds Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:37 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:37 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:37 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:37 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:37 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:37 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:37 volumio volumio[3949]: info: ------------------------------ 37ms Apr 28 20:48:37 volumio volumio[3949]: info: ------------------------------ 36ms Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:37 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:37 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:37 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:37 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:37 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:37 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:37 volumio volumio[3949]: info: ------------------------------ 18ms Apr 28 20:48:37 volumio volumio[3949]: info: ------------------------------ 14ms Apr 28 20:48:37 volumio volumio[3949]: info: Apr 28 20:48:37 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:37 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:37 volumio volumio[3949]: info: Apr 28 20:48:37 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:37 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:37 volumio volumio[3949]: info: Apr 28 20:48:37 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:37 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:37 volumio volumio[3949]: info: Apr 28 20:48:37 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:37 volumio volumio[3949]: info: ------------------------------ 9ms Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand status took 8 milliseconds Apr 28 20:48:37 volumio volumio[3949]: info: ------------------------------ 4ms Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand status took 3 milliseconds Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:37 volumio volumio[3949]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 28 20:48:37 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:37 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:37 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:37 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:37 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:37 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:37 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:37 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:37 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:37 volumio volumio[3949]: info: ------------------------------ 14ms Apr 28 20:48:37 volumio volumio[3949]: info: ------------------------------ 10ms Apr 28 20:48:42 volumio volumio[3949]: info: Apr 28 20:48:42 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:42 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:42 volumio volumio[3949]: info: Apr 28 20:48:42 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:42 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:42 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:42 volumio volumio[3949]: info: Apr 28 20:48:42 volumio volumio[3949]: ---------------------------- MPD announces system playlist update Apr 28 20:48:42 volumio volumio[3949]: info: Ignoring MPD Status Update Apr 28 20:48:42 volumio volumio[3949]: info: Apr 28 20:48:42 volumio volumio[3949]: ---------------------------- MPD announces state update: player Apr 28 20:48:42 volumio volumio[3949]: info: ControllerMpd::getState Apr 28 20:48:42 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand status Apr 28 20:48:42 volumio volumio[3949]: info: ------------------------------ 3ms Apr 28 20:48:42 volumio volumio[3949]: info: sendMpdCommand status took 3 milliseconds Apr 28 20:48:42 volumio volumio[3949]: info: ------------------------------ 2ms Apr 28 20:48:42 volumio volumio[3949]: info: sendMpdCommand status took 1 milliseconds Apr 28 20:48:42 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:42 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:42 volumio volumio[3949]: verbose: ControllerMpd::parseState Apr 28 20:48:42 volumio volumio[3949]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 20:48:42 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 28 20:48:42 volumio volumio[3949]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 28 20:48:42 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:42 volumio volumio[3949]: verbose: ControllerMpd::parseTrackInfo Apr 28 20:48:42 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:42 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:42 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:42 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:42 volumio volumio[3949]: info: ControllerMpd::pushState Apr 28 20:48:42 volumio volumio[3949]: info: CoreCommandRouter::servicePushState Apr 28 20:48:42 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:48:42 volumio volumio[3949]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Apr 28 20:48:42 volumio volumio[3949]: info: ------------------------------ 6ms Apr 28 20:48:42 volumio volumio[3949]: info: ------------------------------ 5ms Apr 28 20:48:53 volumio volumio[3949]: info: Adding http://streams.80s80s.de/web/mp3-192/volumio to favourites using generic method Apr 28 20:48:53 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: 80s80s , explodeUri Apr 28 20:48:53 volumio volumio[3949]: info: [1745866133870] [80s80s] explodeUri: http://streams.80s80s.de/web/mp3-192/volumio Apr 28 20:48:53 volumio volumio[3949]: error: Could not add to playlist: http://streams.80s80s.de/web/mp3-192/volumio Apr 28 20:49:11 volumio volumio[3949]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 20:49:16 volumio volumio[3949]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 20:49:16 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 28 20:49:16 volumio volumio[3949]: Disk list : [] Apr 28 20:49:16 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 28 20:49:16 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 28 20:49:16 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Apr 28 20:49:17 volumio volumio[3949]: info: Received Get System Version Apr 28 20:49:17 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 28 20:49:17 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Apr 28 20:49:39 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Apr 28 20:49:39 volumio volumio[3949]: info: CoreCommandRouter::Reload Ui Apr 28 20:49:40 volumio volumio[3949]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::volumioGetVisibleSources Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Apr 28 20:49:40 volumio volumio[3949]: info: Received Get System Info Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 20:49:40 volumio volumio[3949]: info: Discovery: Getting this device information Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::volumioGetState Apr 28 20:49:40 volumio volumio[3949]: info: CorePlayQueue::getTrack 0 Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 20:49:40 volumio volumio-remote-updater[625]: No test mode Apr 28 20:49:40 volumio volumio-remote-updater[625]: No alpha test mode Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 20:49:40 volumio volumio[3949]: info: Retrieving Cloud Streaming UI Apr 28 20:49:40 volumio volumio[3949]: info: Getting Tidal Cloud Configuration Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 20:49:40 volumio volumio[3949]: info: Getting Qobuz Cloud Configuration Apr 28 20:49:40 volumio volumio[3949]: info: Asking plugin for UI Config Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 20:49:40 volumio volumio[3949]: info: Getting Spotify Cloud Configuration Apr 28 20:49:40 volumio volumio[3949]: info: Asking plugin for UI Config Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 20:49:40 volumio volumio[3949]: info: Saving Spotify Acccount Apr 28 20:49:40 volumio volumio[3949]: info: Got Tidal Cloud Configuration Apr 28 20:49:40 volumio volumio[3949]: info: Got it Apr 28 20:49:40 volumio volumio[3949]: info: Got it Apr 28 20:49:40 volumio volumio[3949]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 28 20:49:40 volumio volumio[3949]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 20:49:40 volumio volumio[3949]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 28 20:49:41 volumio volumio[3949]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 28 20:49:41 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 28 20:49:42 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 28 20:49:42 volumio kernel: hwmon hwmon1: Undervoltage detected! Apr 28 20:49:43 volumio volumio[3949]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Apr 28 20:49:43 volumio volumio[3949]: info: Loading i18n strings for locale en Apr 28 20:49:43 volumio volumio[3949]: info: Plugin peppymeterbasic has duplicated i18n key APPLY. It is ignored. Apr 28 20:49:43 volumio volumio[3949]: info: Plugin peppymeterbasic has duplicated i18n key SAVE. It is ignored. Apr 28 20:49:43 volumio volumio[3949]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Apr 28 20:49:43 volumio volumio[3949]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Apr 28 20:49:43 volumio volumio[3949]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 20:49:43 volumio volumio[3949]: TypeError: Cannot read property 'logger' of null Apr 28 20:49:43 volumio volumio[3949]: at NowPlayingContext.getLogger (/data/plugins/user_interface/now_playing/dist/lib/NowPlayingContext.js:71:83) Apr 28 20:49:43 volumio volumio[3949]: at ControllerNowPlaying._ControllerNowPlaying_onVolumioLanguageChanged (/data/plugins/user_interface/now_playing/dist/index.js:2032:33) Apr 28 20:49:43 volumio volumio[3949]: at /volumio/node_modules/v-conf/index.js:165:13 Apr 28 20:49:43 volumio volumio[3949]: at /volumio/node_modules/multimap/index.js:150:9 Apr 28 20:49:43 volumio volumio[3949]: at Array.forEach () Apr 28 20:49:43 volumio volumio[3949]: at /volumio/node_modules/multimap/index.js:149:13 Apr 28 20:49:43 volumio volumio[3949]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) Apr 28 20:49:43 volumio volumio[3949]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5) Apr 28 20:49:43 volumio volumio[3949]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10) Apr 28 20:49:43 volumio volumio[3949]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20) Apr 28 20:49:43 volumio volumio[3949]: at volumioAppearance.setLanguage (/volumio/app/plugins/miscellanea/appearance/index.js:326:35) Apr 28 20:49:43 volumio volumio[3949]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Apr 28 20:49:43 volumio volumio[3949]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1674:37) Apr 28 20:49:43 volumio volumio[3949]: at Socket.emit (events.js:315:20) Apr 28 20:49:43 volumio volumio[3949]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Apr 28 20:49:43 volumio volumio[3949]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 28 20:49:43 volumio volumio[3949]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 20:49:43 volumio sudo[7169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-28 20:48 Apr 28 20:49:43 volumio sudo[7169]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"