Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: Preload queue cleared Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::ClearQueue Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stPlaybackTimer Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::updateTrackBlock Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrackBlock Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::serviceStop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::serviceStop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: [1775228047120] ControllerWebradio::stop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::clearPlayQueue Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::saveQueue Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushQueue Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::addQueueItems Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::addQueueItems Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: Preload queue cleared Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s323902 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 03 16:54:07 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:07.122+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 03 16:54:07 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:07.123+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://streams.90s90s.de/trance/mp3-128/tunein/ title="90s90s TRANCE" Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand stop took 28 milliseconds Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:07 volumio-alain-pi5 sudo[10774]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 03 16:54:07 volumio-alain-pi5 sudo[10774]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 6 milliseconds Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Kai Tracid - Your Own Reality","artist":"90s90s - TRANCE","album":null,"uri":"https://streams.90s90s.de/trance/mp3-128/tunein/","trackType":""} Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService stop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus stop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: No code Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:07.169+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 03 16:54:07 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:07.169+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 03 16:54:07 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:07.169+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id= title= Apr 03 16:54:07 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:07.169+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 03 16:54:07 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:07.169+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id= title= Apr 03 16:54:07 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:07.169+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id= title= Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 23ms Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 03 16:54:07 volumio-alain-pi5 systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Apr 03 16:54:07 volumio-alain-pi5 systemd[1]: peppymeterbasic.service: Deactivated successfully. Apr 03 16:54:07 volumio-alain-pi5 systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Apr 03 16:54:07 volumio-alain-pi5 sudo[10774]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 03 16:54:07 volumio-alain-pi5 sudo[10781]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 03 16:54:07 volumio-alain-pi5 sudo[10781]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 03 16:54:07 volumio-alain-pi5 sudo[10784]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 03 16:54:07 volumio-alain-pi5 sudo[10784]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:07 volumio-alain-pi5 sudo[10786]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 03 16:54:07 volumio-alain-pi5 sudo[10786]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Stop Apr 03 16:54:07 volumio-alain-pi5 sudo[10781]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Stop Apr 03 16:54:07 volumio-alain-pi5 sudo[10784]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:07 volumio-alain-pi5 sudo[10786]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Stop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Stop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushQueue Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::saveQueue Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::updateTrackBlock Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrackBlock Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPlay Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::play index 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::play index undefined Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::startPlaybackTimer Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetVisibleSources Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: [1775228047476] ControllerWebradio::clearAddPlayTrack Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand stop took 1 milliseconds Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand clear took 0 milliseconds Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand load "https://stream.regenbogen2.de/festivalradio/mp3-128/tunein" Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: error: updateQueue error: null Apr 03 16:54:07 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 1ms Apr 03 16:54:09 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand add "https://stream.regenbogen2.de/festivalradio/mp3-128/tunein" Apr 03 16:54:09 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:09 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:54:09 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:54:09 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand add "https://stream.regenbogen2.de/festivalradio/mp3-128/tunein" took 1 milliseconds Apr 03 16:54:09 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 03 16:54:09 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand play Apr 03 16:54:09 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 1ms Apr 03 16:54:09 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand play took 0 milliseconds Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 47 milliseconds Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 1ms Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 0 milliseconds Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK FM Festival Radio","artist":"ROCK FM Festival Radio","album":null,"uri":"https://stream.regenbogen2.de/festivalradio/mp3-128/tunein","trackType":""} Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService play Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus stop Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 49ms Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1112,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK FM Festival Radio","artist":"ROCK FM Festival Radio","album":null,"uri":"https://stream.regenbogen2.de/festivalradio/mp3-128/tunein","trackType":""} Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService play Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus play Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: Received an update from plugin. extracting info from payload Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 15ms Apr 03 16:54:10 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:10.505+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 16:54:10 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:10.506+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://stream.regenbogen2.de/festivalradio/mp3-128/tunein title="ROCK FM Festival Radio" Apr 03 16:54:10 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:10.508+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 16:54:10 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:10.508+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://stream.regenbogen2.de/festivalradio/mp3-128/tunein title="ROCK FM Festival Radio" Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:10 volumio-alain-pi5 sudo[10802]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:10 volumio-alain-pi5 sudo[10802]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:10 volumio-alain-pi5 sudo[10805]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:10 volumio-alain-pi5 sudo[10805]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 03 16:54:10 volumio-alain-pi5 systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Apr 03 16:54:10 volumio-alain-pi5 sudo[10802]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:10 volumio-alain-pi5 sudo[10805]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:10 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:12 volumio-alain-pi5 volumio[1479]: info: Executing endpoint metavolumio Apr 03 16:54:12 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 03 16:54:12 volumio-alain-pi5 volumio[1479]: info: Executing endpoint metavolumio Apr 03 16:54:12 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: Preload queue cleared Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::ClearQueue Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stPlaybackTimer Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::updateTrackBlock Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrackBlock Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::serviceStop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::serviceStop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: [1775228054409] ControllerWebradio::stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::clearPlayQueue Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::saveQueue Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushQueue Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::addQueueItems Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::addQueueItems Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: Preload queue cleared Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s321834 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 03 16:54:14 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:14.411+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 03 16:54:14 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:14.412+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://stream.regenbogen2.de/festivalradio/mp3-128/tunein title="FESTIVAL RADIO" Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 03 16:54:14 volumio-alain-pi5 sudo[10836]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 03 16:54:14 volumio-alain-pi5 sudo[10836]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand stop took 40 milliseconds Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:14 volumio-alain-pi5 systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 4 milliseconds Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ROCK FM Festival Radio","artist":"ROCK FM Festival Radio","album":null,"uri":"https://stream.regenbogen2.de/festivalradio/mp3-128/tunein","trackType":""} Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: No code Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:14 volumio-alain-pi5 systemd[1]: peppymeterbasic.service: Deactivated successfully. Apr 03 16:54:14 volumio-alain-pi5 systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 sudo[10836]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:14 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:14.467+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 03 16:54:14 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:14.467+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id= title= Apr 03 16:54:14 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:14.468+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 03 16:54:14 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:14.468+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id= title= Apr 03 16:54:14 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:14.469+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 03 16:54:14 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:14.469+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id= title= Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 25ms Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 03 16:54:14 volumio-alain-pi5 sudo[10843]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 03 16:54:14 volumio-alain-pi5 sudo[10843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:14 volumio-alain-pi5 sudo[10845]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 03 16:54:14 volumio-alain-pi5 sudo[10845]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:14 volumio-alain-pi5 sudo[10847]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 03 16:54:14 volumio-alain-pi5 sudo[10847]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:14 volumio-alain-pi5 sudo[10843]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:14 volumio-alain-pi5 sudo[10845]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Stop Apr 03 16:54:14 volumio-alain-pi5 sudo[10847]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushQueue Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::saveQueue Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::updateTrackBlock Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrackBlock Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPlay Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::play index 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::play index undefined Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::startPlaybackTimer Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetVisibleSources Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: [1775228054739] ControllerWebradio::clearAddPlayTrack Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand stop took 1 milliseconds Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand clear took 0 milliseconds Apr 03 16:54:14 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand load "https://streams.90s90s.de/rock/mp3-192/tunein/" Apr 03 16:54:16 volumio-alain-pi5 volumio[1479]: error: updateQueue error: null Apr 03 16:54:16 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 1965ms Apr 03 16:54:16 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand add "https://streams.90s90s.de/rock/mp3-192/tunein/" Apr 03 16:54:16 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:16 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:54:16 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:54:16 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand add "https://streams.90s90s.de/rock/mp3-192/tunein/" took 1 milliseconds Apr 03 16:54:16 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 03 16:54:16 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand play Apr 03 16:54:16 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 1ms Apr 03 16:54:16 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand play took 1 milliseconds Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 48 milliseconds Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 2 milliseconds Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"90s90s - Rock","artist":"90s90s - Rock","album":null,"uri":"https://streams.90s90s.de/rock/mp3-192/tunein/","trackType":""} Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService play Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus stop Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 52ms Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 3ms Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"90s90s - Rock","artist":"90s90s - Rock","album":null,"uri":"https://streams.90s90s.de/rock/mp3-192/tunein/","trackType":""} Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService play Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus play Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: Received an update from plugin. extracting info from payload Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:18 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:18.779+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 16:54:18 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:18.779+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://streams.90s90s.de/rock/mp3-192/tunein/ title="90s90s - Rock" Apr 03 16:54:18 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:18.780+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 16:54:18 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:18.780+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://streams.90s90s.de/rock/mp3-192/tunein/ title="90s90s - Rock" Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 13ms Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:18 volumio-alain-pi5 sudo[10864]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:18 volumio-alain-pi5 sudo[10864]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:18 volumio-alain-pi5 sudo[10866]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:18 volumio-alain-pi5 sudo[10866]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 03 16:54:18 volumio-alain-pi5 systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Apr 03 16:54:18 volumio-alain-pi5 sudo[10864]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:18 volumio-alain-pi5 sudo[10866]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:18 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:20 volumio-alain-pi5 volumio[1479]: info: Executing endpoint metavolumio Apr 03 16:54:20 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 03 16:54:20 volumio-alain-pi5 volumio[1479]: info: Executing endpoint metavolumio Apr 03 16:54:20 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: READ Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: Preload queue cleared Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 1ms Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 2 milliseconds Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19607,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Alanis Morissette - hand in my pocket","artist":"90s90s - Rock","album":null,"uri":"https://streams.90s90s.de/rock/mp3-192/tunein/","trackType":""} Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService play Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus play Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: Received an update from plugin. extracting info from payload Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:36 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:36.961+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=18015 volume=100 Apr 03 16:54:36 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:36.962+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://streams.90s90s.de/rock/mp3-192/tunein/ title="Alanis Morissette - hand in my pocket" Apr 03 16:54:36 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:36.962+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=18015 volume=100 Apr 03 16:54:36 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:36.962+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://streams.90s90s.de/rock/mp3-192/tunein/ title="Alanis Morissette - hand in my pocket" Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 12ms Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:36 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:36 volumio-alain-pi5 sudo[10942]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:36 volumio-alain-pi5 sudo[10942]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:36 volumio-alain-pi5 sudo[10944]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:36 volumio-alain-pi5 sudo[10944]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:37 volumio-alain-pi5 sudo[10942]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:37 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:37 volumio-alain-pi5 sudo[10944]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:37 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:40 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 03 16:54:40 volumio-alain-pi5 volumio[1479]: info: Preload queue cleared Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: Preload queue cleared Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::ClearQueue Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stop Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stPlaybackTimer Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::updateTrackBlock Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrackBlock Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::serviceStop Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::serviceStop Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: [1775228082187] ControllerWebradio::stop Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::clearPlayQueue Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::saveQueue Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushQueue Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::addQueueItems Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::addQueueItems Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: Preload queue cleared Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99603036 Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 03 16:54:42 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:42.189+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 03 16:54:42 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:42.189+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://streams.90s90s.de/rock/mp3-192/tunein/ title="90s90s Rock" Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushQueue Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::saveQueue Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::updateTrackBlock Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrackBlock Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPlay Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::play index 0 Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stop Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::play index undefined Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::startPlaybackTimer Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetVisibleSources Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: [1775228082197] ControllerWebradio::clearAddPlayTrack Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 03 16:54:42 volumio-alain-pi5 sudo[10961]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 03 16:54:42 volumio-alain-pi5 sudo[10961]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand stop took 40 milliseconds Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand stop took 29 milliseconds Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 5 milliseconds Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:42 volumio-alain-pi5 systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand clear took 8 milliseconds Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99603036" Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:42 volumio-alain-pi5 systemd[1]: peppymeterbasic.service: Deactivated successfully. Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 10ms Apr 03 16:54:42 volumio-alain-pi5 systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: error: updateQueue error: null Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 1ms Apr 03 16:54:42 volumio-alain-pi5 sudo[10961]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Stop Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99603036" took 448 milliseconds Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand play Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand play took 1 milliseconds Apr 03 16:54:42 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 1ms Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 53 milliseconds Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 0 milliseconds Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 17/100) Eastern Radio","album":null,"uri":"https://liveradio.co.il:9089/","trackType":"il:9089/"} Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService play Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus stop Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 54ms Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 17/100) Eastern Radio","album":null,"uri":"https://liveradio.co.il:9089/","trackType":"il:9089/"} Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService play Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus play Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: Received an update from plugin. extracting info from payload Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:43 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:43.342+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 16:54:43 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:43.342+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 16:54:43 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:43.342+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://liveradio.co.il:9089/ title= Apr 03 16:54:43 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:43.342+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://liveradio.co.il:9089/ title= Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 11ms Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:43 volumio-alain-pi5 sudo[10987]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:43 volumio-alain-pi5 sudo[10987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:43 volumio-alain-pi5 sudo[10990]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:43 volumio-alain-pi5 sudo[10990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 2ms Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 2 milliseconds Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1110,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"","artist":"Eastern Radio","album":null,"uri":"https://liveradio.co.il:9089/","trackType":"il:9089/"} Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService play Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus play Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: Received an update from plugin. extracting info from payload Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:43 volumio-alain-pi5 systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:43 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:43.406+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 16:54:43 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:43.406+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 16:54:43 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:43.406+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://liveradio.co.il:9089/ title= Apr 03 16:54:43 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:43.407+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://liveradio.co.il:9089/ title= Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 23ms Apr 03 16:54:43 volumio-alain-pi5 sudo[10987]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:43 volumio-alain-pi5 sudo[10990]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:43 volumio-alain-pi5 sudo[10997]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:43 volumio-alain-pi5 sudo[10997]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:43 volumio-alain-pi5 sudo[10999]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:43 volumio-alain-pi5 sudo[10999]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 03 16:54:43 volumio-alain-pi5 sudo[10997]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:43 volumio-alain-pi5 sudo[10999]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:43 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 0ms Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 0 milliseconds Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2358,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"דודו אהרון - עלה קטן שלי מתוך ההופעה בהיכל התרבות","artist":"Eastern Radio","album":null,"uri":"https://liveradio.co.il:9089/","trackType":"il:9089/"} Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService play Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus play Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: Received an update from plugin. extracting info from payload Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:54:44 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:44.315+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=1000 volume=100 Apr 03 16:54:44 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:44.315+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=1000 volume=100 Apr 03 16:54:44 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:44.316+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://liveradio.co.il:9089/ title="דודו אהרון - עלה קטן שלי מתוך ההופעה בהיכל התרבות" Apr 03 16:54:44 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:54:44.316+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://liveradio.co.il:9089/ title="דודו אהרון - עלה קטן שלי מתוך ההופעה בהיכל התרבות" Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 10ms Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:54:44 volumio-alain-pi5 sudo[11008]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:44 volumio-alain-pi5 sudo[11008]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:44 volumio-alain-pi5 sudo[11010]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:54:44 volumio-alain-pi5 sudo[11010]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:54:44 volumio-alain-pi5 systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Apr 03 16:54:44 volumio-alain-pi5 sudo[11008]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:44 volumio-alain-pi5 sudo[11010]: pam_unix(sudo:session): session closed for user root Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:44 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:54:44 volumio-alain-pi5 systemd[1]: setdatetime-helper.service: Deactivated successfully. Apr 03 16:54:44 volumio-alain-pi5 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Apr 03 16:54:45 volumio-alain-pi5 volumio[1479]: info: Executing endpoint metavolumio Apr 03 16:54:45 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 03 16:54:45 volumio-alain-pi5 volumio[1479]: info: Executing endpoint metavolumio Apr 03 16:54:45 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 03 16:54:58 volumio-alain-pi5 nmbd[1363]: [2026/04/03 16:54:58.959307, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Apr 03 16:54:58 volumio-alain-pi5 nmbd[1363]: register_name_response: Answer name <00> differs from question name <00>. Apr 03 16:54:58 volumio-alain-pi5 nmbd[1363]: [2026/04/03 16:54:58.959425, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Apr 03 16:54:58 volumio-alain-pi5 nmbd[1363]: register_name_response: Answer name <03> differs from question name <03>. Apr 03 16:54:58 volumio-alain-pi5 nmbd[1363]: [2026/04/03 16:54:58.959490, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Apr 03 16:54:58 volumio-alain-pi5 nmbd[1363]: register_name_response: Answer name <20> differs from question name <20>. Apr 03 16:55:13 volumio-alain-pi5 volumio[10992]: /data/plugins/user_interface/peppymeterbasic/startpeppymeterbasic.sh: 4: cd: can't cd to /data/plugins/user_interface/peppymeterbasic/BasicPeppyMeter Apr 03 16:55:13 volumio-alain-pi5 systemd[1]: peppymeterbasic.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Apr 03 16:55:13 volumio-alain-pi5 systemd[1]: peppymeterbasic.service: Failed with result 'exit-code'. Apr 03 16:55:21 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 03 16:55:22 volumio-alain-pi5 volumio[1479]: info: Preload queue cleared Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: Preload queue cleared Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::ClearQueue Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stop Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stPlaybackTimer Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::updateTrackBlock Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrackBlock Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::serviceStop Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::serviceStop Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: [1775228125613] ControllerWebradio::stop Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::clearPlayQueue Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::saveQueue Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushQueue Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::addQueueItems Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::addQueueItems Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: Preload queue cleared Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 03 16:55:25 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:55:25.615+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 03 16:55:25 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:55:25.615+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99603036" title="Eastern Radio" Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushQueue Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::saveQueue Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::updateTrackBlock Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrackBlock Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPlay Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::play index 0 Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::stop Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::play index undefined Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::startPlaybackTimer Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetVisibleSources Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: [1775228125618] ControllerWebradio::clearAddPlayTrack Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 03 16:55:25 volumio-alain-pi5 sudo[11186]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 03 16:55:25 volumio-alain-pi5 sudo[11186]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand stop took 36 milliseconds Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand stop took 31 milliseconds Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 16:55:25 volumio-alain-pi5 sudo[11186]: pam_unix(sudo:session): session closed for user root Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 8 milliseconds Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand clear took 8 milliseconds Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Stop Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: error: updateQueue error: null Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 148ms Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 147 milliseconds Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 147 milliseconds Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand play Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 156ms Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand play took 1 milliseconds Apr 03 16:55:25 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 1ms Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 52 milliseconds Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces state update: player Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: ---------------------------- MPD announces system playlist update Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: Ignoring MPD Status Update Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::getState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand status Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService play Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus stop Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 55ms Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand status took 1 milliseconds Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 2ms Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: ControllerMpd::parseTrackInfo Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: ControllerMpd::pushState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::servicePushState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CorePlayQueue::getTrack 0 Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1088,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: verbose: CURRENT POSITION 0 Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState stateService play Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::syncState currentStatus play Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: Received an update from plugin. extracting info from payload Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreStateMachine::pushState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioPushState Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output update for this device Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: MRS: Pushing multiroomSync output Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: CoreCommandRouter::volumioGetState Apr 03 16:55:26 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:55:26.924+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 16:55:26 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:55:26.924+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" state=STATUS_PLAYING positionMs=0 volume=100 Apr 03 16:55:26 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:55:26.925+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 03 16:55:26 volumio-alain-pi5 volumio5-onboarding[1748]: time=2026-04-03T16:55:26.925+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.247:41026,00:00:00:00:00:00%07 @ 0x1cb24b0" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: ------------------------------ 12ms Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 03 16:55:26 volumio-alain-pi5 sudo[11204]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:55:26 volumio-alain-pi5 sudo[11206]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 03 16:55:26 volumio-alain-pi5 sudo[11204]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:55:26 volumio-alain-pi5 sudo[11206]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 03 16:55:26 volumio-alain-pi5 systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Apr 03 16:55:26 volumio-alain-pi5 sudo[11204]: pam_unix(sudo:session): session closed for user root Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:55:26 volumio-alain-pi5 sudo[11206]: pam_unix(sudo:session): session closed for user root Apr 03 16:55:26 volumio-alain-pi5 volumio[1479]: info: peppymeterbasic Daemon Started Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: TypeError: Cannot read properties of null (reading 'slice') Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at Object.onceWrapper (node:events:629:26) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at ClientRequest.emit (node:events:514:28) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at TLSSocket.socketOnData (node:_http_client:535:22) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at TLSSocket.emit (node:events:514:28) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at addChunk (node:internal/streams/readable:343:12) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at readableAddChunk (node:internal/streams/readable:316:9) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at Readable.push (node:internal/streams/readable:253:10) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Apr 03 16:55:27 volumio-alain-pi5 volumio[1479]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 16:55:27 volumio-alain-pi5 sudo[11227]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-03 16:54' Apr 03 16:55:27 volumio-alain-pi5 sudo[11227]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"