-- Logs begin at Wed 2026-03-25 19:54:32 +05, end at Wed 2026-03-25 21:38:32 +05. -- Mar 25 21:37:01 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Mar 25 21:37:01 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:02 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 21:37:02 volumio volumio[1096]: info: CURURI: albums:// Mar 25 21:37:02 volumio volumio[1096]: info: listAlbums - loading Albums from cache Mar 25 21:37:02 volumio volumio[1096]: info: Preload queue cleared Mar 25 21:37:04 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 21:37:04 volumio volumio[1096]: info: CURURI: albums://Roxette/Joyride Mar 25 21:37:04 volumio volumio[1096]: info: Preload queue cleared Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/02 - Hotblooded.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/03 - Fading Like A Flower (Every Time You Leave).mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/04 - Knockin' On Every Door.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/05 - Spending My Time.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/06 - I Remember You.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/07 - Watercolours In The Rain.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/08 - The Big L..mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/09 - Soul Deep.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/10 - (Do You Get) Excited.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/11 - Church Of Your Heart.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/12 - Small Talk.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/13 - Physical Fascination.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/14 - Things Will Never Be The Same.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Preloading song: music-library/USB/A715-B941/1991 - Joyride/15 - Perfect Day.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3 in service mpd Mar 25 21:37:04 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F01%20-%20Joyride.mp3&metadata=false Mar 25 21:37:04 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/02 - Hotblooded.mp3 in service mpd Mar 25 21:37:04 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F02%20-%20Hotblooded.mp3&metadata=false Mar 25 21:37:04 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/02 - Hotblooded.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/03 - Fading Like A Flower (Every Time You Leave).mp3 in service mpd Mar 25 21:37:04 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F03%20-%20Fading%20Like%20A%20Flower%20(Every%20Time%20You%20Leave).mp3&metadata=false Mar 25 21:37:04 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/03 - Fading Like A Flower (Every Time You Leave).mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/04 - Knockin' On Every Door.mp3 in service mpd Mar 25 21:37:04 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F04%20-%20Knockin'%20On%20Every%20Door.mp3&metadata=false Mar 25 21:37:04 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/04 - Knockin' On Every Door.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/05 - Spending My Time.mp3 in service mpd Mar 25 21:37:04 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F05%20-%20Spending%20My%20Time.mp3&metadata=false Mar 25 21:37:04 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/05 - Spending My Time.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/06 - I Remember You.mp3 in service mpd Mar 25 21:37:04 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F06%20-%20I%20Remember%20You.mp3&metadata=false Mar 25 21:37:04 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/06 - I Remember You.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/07 - Watercolours In The Rain.mp3 in service mpd Mar 25 21:37:04 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F07%20-%20Watercolours%20In%20The%20Rain.mp3&metadata=false Mar 25 21:37:04 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/07 - Watercolours In The Rain.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/08 - The Big L..mp3 in service mpd Mar 25 21:37:04 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F08%20-%20The%20Big%20L..mp3&metadata=false Mar 25 21:37:04 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/08 - The Big L..mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/09 - Soul Deep.mp3 in service mpd Mar 25 21:37:04 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F09%20-%20Soul%20Deep.mp3&metadata=false Mar 25 21:37:04 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/09 - Soul Deep.mp3 Mar 25 21:37:04 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/10 - (Do You Get) Excited.mp3 in service mpd Mar 25 21:37:05 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F10%20-%20(Do%20You%20Get)%20Excited.mp3&metadata=false Mar 25 21:37:05 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/10 - (Do You Get) Excited.mp3 Mar 25 21:37:05 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/11 - Church Of Your Heart.mp3 in service mpd Mar 25 21:37:05 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F11%20-%20Church%20Of%20Your%20Heart.mp3&metadata=false Mar 25 21:37:05 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/11 - Church Of Your Heart.mp3 Mar 25 21:37:05 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/12 - Small Talk.mp3 in service mpd Mar 25 21:37:05 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F12%20-%20Small%20Talk.mp3&metadata=false Mar 25 21:37:05 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/12 - Small Talk.mp3 Mar 25 21:37:05 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/13 - Physical Fascination.mp3 in service mpd Mar 25 21:37:05 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F13%20-%20Physical%20Fascination.mp3&metadata=false Mar 25 21:37:05 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/13 - Physical Fascination.mp3 Mar 25 21:37:05 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/14 - Things Will Never Be The Same.mp3 in service mpd Mar 25 21:37:05 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F14%20-%20Things%20Will%20Never%20Be%20The%20Same.mp3&metadata=false Mar 25 21:37:05 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/14 - Things Will Never Be The Same.mp3 Mar 25 21:37:05 volumio volumio[1096]: info: Exploding uri music-library/USB/A715-B941/1991 - Joyride/15 - Perfect Day.mp3 in service mpd Mar 25 21:37:05 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=109&web=Roxette/Joyride/large&path=%2Fmnt%2FUSB%2FA715-B941%2F1991%20-%20Joyride%2F15%20-%20Perfect%20Day.mp3&metadata=false Mar 25 21:37:05 volumio volumio[1096]: info: URI /mnt/USB/A715-B941/1991 - Joyride/15 - Perfect Day.mp3 Mar 25 21:37:05 volumio volumio[1096]: info: Preload queue cleared Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::ClearQueue Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::stPlaybackTimer Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::serviceStop Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::serviceStop Mar 25 21:37:05 volumio volumio[1096]: info: ControllerMpd::stop Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::clearPlayQueue Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::saveQueue Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::addQueueItems Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::addQueueItems Mar 25 21:37:05 volumio volumio[1096]: info: Preload queue cleared Mar 25 21:37:05 volumio volumio[1096]: info: Adding Item to queue: albums://Roxette/Joyride Mar 25 21:37:05 volumio volumio[1096]: info: Exploding uri albums://Roxette/Joyride in service mpd Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.575+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=0 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.575+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id=http://streams.80s80s.de/italohits/mp3-192/volumio title="Koto - Visitors" Mar 25 21:37:05 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:05 volumio volumio[1096]: info: sendMpdCommand stop took 34 milliseconds Mar 25 21:37:05 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music/v4/2f/af/0f/2faf0fba-5985-3b3e-fb34-0eb5c31e39f8/source/600x600bb.jpg","name":"Koto - Visitors","title":"Visitors","artist":"80s80s Italo Disco","album":"","streaming":true,"disableUiControls":true,"duration":"204","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Mar 25 21:37:05 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::syncState stateService stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: No code Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio sudo[1727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.617+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=0 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.617+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id= title= Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.618+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id= title= Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Mar 25 21:37:05 volumio sudo[1727]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::saveQueue Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPlay Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::play index 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::play index undefined Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::startPlaybackTimer Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::clearAddPlayTracks USB/A715-B941/1991 - Joyride/01 - Joyride.mp3 Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Mar 25 21:37:05 volumio systemd[1]: Stopping peppymeterbasic Daemon... Mar 25 21:37:05 volumio systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Mar 25 21:37:05 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:05 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:05 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:05 volumio sudo[1730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:05 volumio sudo[1730]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:05 volumio sudo[1733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:05 volumio sudo[1733]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:05 volumio volumio[1096]: info: sendMpdCommand status took 131 milliseconds Mar 25 21:37:05 volumio volumio[1096]: info: sendMpdCommand stop took 101 milliseconds Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand clear Mar 25 21:37:05 volumio systemd[1]: peppymeterbasic.service: Succeeded. Mar 25 21:37:05 volumio systemd[1]: Stopped peppymeterbasic Daemon. Mar 25 21:37:05 volumio sudo[1733]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:05 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:05 volumio sudo[1730]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:05 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:05 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:05 volumio sudo[1727]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:05 volumio sudo[1736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:05 volumio sudo[1736]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Mar 25 21:37:05 volumio volumio[1096]: info: Ignoring MPD Status Update Mar 25 21:37:05 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 44 milliseconds Mar 25 21:37:05 volumio volumio[1096]: info: sendMpdCommand clear took 43 milliseconds Mar 25 21:37:05 volumio volumio[1096]: info: sendMpdCommand status took 23 milliseconds Mar 25 21:37:05 volumio volumio[1096]: info: sendMpdCommand status took 9 milliseconds Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand add "USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:37:05 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: 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":"Den Harrow - Charleston","artist":"80s80s Italo Hits","album":null,"uri":"http://streams.80s80s.de/italohits/mp3-192/volumio","trackType":""} Mar 25 21:37:05 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::syncState stateService stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: No code Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 25 21:37:05 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::syncState stateService stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: No code Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 25 21:37:05 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::syncState stateService stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: No code Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 25 21:37:05 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::syncState stateService stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio[1096]: info: No code Mar 25 21:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.820+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=142 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.822+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.823+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=142 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.823+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.822+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=142 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.824+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:05 volumio sudo[1736]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.829+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=142 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.832+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.839+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=142 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.839+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.839+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=142 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.839+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.839+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=142 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.839+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.839+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=142 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.840+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.840+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=142 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.840+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.840+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=142 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.840+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.840+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_STOPPED positionMs=142 volume=55 Mar 25 21:37:05 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:05.840+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:05 volumio volumio[1096]: info: ------------------------------ 240ms Mar 25 21:37:05 volumio volumio[1096]: info: ------------------------------ 88ms Mar 25 21:37:05 volumio volumio[1096]: info: ------------------------------ 87ms Mar 25 21:37:05 volumio volumio[1096]: info: ------------------------------ 75ms Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Mar 25 21:37:05 volumio volumio[1096]: info: Ignoring MPD Status Update Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Mar 25 21:37:05 volumio volumio[1096]: info: Ignoring MPD Status Update Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Mar 25 21:37:05 volumio volumio[1096]: info: Ignoring MPD Status Update Mar 25 21:37:05 volumio volumio[1096]: info: peppymeterbasic Daemon Stop Mar 25 21:37:05 volumio volumio[1096]: info: peppymeterbasic Daemon Stop Mar 25 21:37:05 volumio volumio[1096]: info: peppymeterbasic Daemon Stop Mar 25 21:37:05 volumio volumio[1096]: error: updateQueue error: null Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Mar 25 21:37:05 volumio volumio[1096]: info: Ignoring MPD Status Update Mar 25 21:37:05 volumio volumio[1096]: info: ------------------------------ 78ms Mar 25 21:37:05 volumio volumio[1096]: info: sendMpdCommand add "USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" took 76 milliseconds Mar 25 21:37:05 volumio volumio[1096]: info: ------------------------------ 7ms Mar 25 21:37:05 volumio volumio[1096]: info: ------------------------------ 6ms Mar 25 21:37:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand play Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Mar 25 21:37:05 volumio volumio[1096]: info: Ignoring MPD Status Update Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Mar 25 21:37:05 volumio volumio[1096]: info: Ignoring MPD Status Update Mar 25 21:37:05 volumio volumio[1096]: info: Mar 25 21:37:05 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Mar 25 21:37:05 volumio volumio[1096]: info: Ignoring MPD Status Update Mar 25 21:37:05 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:05 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:05 volumio sudo[1741]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:05 volumio sudo[1741]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:05 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:05 volumio sudo[1743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:05 volumio sudo[1743]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:05 volumio sudo[1743]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:05 volumio sudo[1741]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:05 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:05 volumio sudo[1747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:05 volumio sudo[1747]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1747]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:06 volumio sudo[1750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1750]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1750]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:06 volumio sudo[1754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1754]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1756]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:06 volumio sudo[1760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1756]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1754]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:06 volumio sudo[1760]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1762]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:06 volumio sudo[1760]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1762]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1766]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:06 volumio sudo[1769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1769]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1766]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 25 21:37:06 volumio sudo[1769]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1772]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1772]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1775]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio volumio[1096]: info: peppymeterbasic Daemon Stop Mar 25 21:37:06 volumio volumio[1096]: info: Mar 25 21:37:06 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:06 volumio volumio[1096]: info: ------------------------------ 459ms Mar 25 21:37:06 volumio volumio[1096]: info: sendMpdCommand play took 458 milliseconds Mar 25 21:37:06 volumio volumio[1096]: info: ------------------------------ 453ms Mar 25 21:37:06 volumio volumio[1096]: info: ------------------------------ 452ms Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:06 volumio volumio[1096]: info: Mar 25 21:37:06 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:06 volumio volumio[1096]: info: Mar 25 21:37:06 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:06 volumio volumio[1096]: info: Mar 25 21:37:06 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:06 volumio volumio[1096]: info: peppymeterbasic Daemon Stop Mar 25 21:37:06 volumio volumio[1096]: info: peppymeterbasic Daemon Stop Mar 25 21:37:06 volumio volumio[1096]: info: Mar 25 21:37:06 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:06 volumio volumio[1096]: info: sendMpdCommand status took 11 milliseconds Mar 25 21:37:06 volumio volumio[1096]: info: sendMpdCommand status took 10 milliseconds Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:37:06 volumio volumio[1096]: info: Mar 25 21:37:06 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:06 volumio volumio[1096]: info: Mar 25 21:37:06 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:06 volumio volumio[1096]: info: Mar 25 21:37:06 volumio volumio[1096]: ---------------------------- MPD announces state update: player Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:37:06 volumio volumio[1096]: info: sendMpdCommand status took 11 milliseconds Mar 25 21:37:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 25 21:37:06 volumio volumio[1096]: info: sendMpdCommand status took 6 milliseconds Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:37:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:37:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:37:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio sudo[1775]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:37:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:37:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:37:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:37:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: ------------------------------ 42ms Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.359+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=1354 volume=55 Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.360+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.360+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=1354 volume=55 Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.361+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.361+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=1354 volume=55 Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.361+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=1354 volume=55 Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.361+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.361+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=1354 volume=55 Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.362+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.362+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=1354 volume=55 Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.362+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:06 volumio volumio[1096]: info: ------------------------------ 50ms Mar 25 21:37:06 volumio volumio[1096]: info: ------------------------------ 52ms Mar 25 21:37:06 volumio volumio[1096]: info: ------------------------------ 51ms Mar 25 21:37:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 36 milliseconds Mar 25 21:37:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 35 milliseconds Mar 25 21:37:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:37:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:37:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:37:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:37:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:37:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:37:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:37:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:37:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:37:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.393+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=1354 volume=55 Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.395+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=1354 volume=55 Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.396+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.395+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=1354 volume=55 Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.396+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.395+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=1354 volume=55 Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.396+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.395+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=1354 volume=55 Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.396+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:37:06.397+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:37:06 volumio volumio[1096]: info: ------------------------------ 79ms Mar 25 21:37:06 volumio volumio[1096]: info: ------------------------------ 73ms Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1780]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1782]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1786]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio systemd[1]: Started peppymeterbasic Daemon. Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1782]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1786]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1790]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1780]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1790]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1794]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1794]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1797]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1797]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1800]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1800]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1805]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1803]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1808]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1805]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1803]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1812]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1808]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1812]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1815]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:37:06 volumio sudo[1815]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1818]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:06 volumio sudo[1818]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:06 volumio sudo[1821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:37:06 volumio sudo[1821]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:37:07 volumio volumio[1096]: info: peppymeterbasic Daemon Stop Mar 25 21:37:07 volumio sudo[1821]: pam_unix(sudo:session): session closed for user root Mar 25 21:37:07 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:37:07 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:37:07 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:37:07 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:37:07 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:37:07 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:37:07 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:37:07 volumio volumio[1787]: libpng warning: iCCP: known incorrect sRGB profile Mar 25 21:37:07 volumio volumio[1787]: libpng warning: iCCP: known incorrect sRGB profile Mar 25 21:37:07 volumio volumio[1787]: libpng warning: iCCP: known incorrect sRGB profile Mar 25 21:37:11 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Mar 25 21:37:11 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:11 volumio volumio[1096]: info: Listing playlists Mar 25 21:37:11 volumio volumio[1096]: info: Listing playlists Mar 25 21:37:14 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 25 21:37:14 volumio volumio[1096]: info: Preload queue cleared Mar 25 21:37:21 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Mar 25 21:37:21 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:24 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 25 21:37:24 volumio volumio[1096]: info: UPNP Browser: No servers found, reinitializing and searching... Mar 25 21:37:25 volumio kernel: perf: interrupt took too long (6194 > 6186), lowering kernel.perf_event_max_sample_rate to 32250 Mar 25 21:37:27 volumio volumio[1096]: info: UPNP Browser: Returning 0 server(s) after 3s wait Mar 25 21:37:27 volumio volumio[1096]: info: Preload queue cleared Mar 25 21:37:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Mar 25 21:37:31 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:31 volumio volumio[1096]: info: Listing playlists Mar 25 21:37:40 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 21:37:40 volumio volumio[1096]: info: CURURI: albums:// Mar 25 21:37:40 volumio volumio[1096]: info: listAlbums - loading Albums from cache Mar 25 21:37:40 volumio volumio[1096]: info: Preload queue cleared Mar 25 21:37:41 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Mar 25 21:37:41 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:51 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Mar 25 21:37:51 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:37:51 volumio volumio[1096]: info: Listing playlists Mar 25 21:37:57 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 21:37:57 volumio volumio[1096]: info: CURURI: artists:// Mar 25 21:37:57 volumio volumio[1096]: info: Preload queue cleared Mar 25 21:38:01 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Mar 25 21:38:01 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 21:38:03 volumio volumio[1096]: info: Retrieving Cloud Streaming UI Mar 25 21:38:03 volumio volumio[1096]: info: Getting Tidal Cloud Configuration Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 21:38:03 volumio volumio[1096]: info: Getting Qobuz Cloud Configuration Mar 25 21:38:03 volumio volumio[1096]: info: Asking plugin for UI Config Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 21:38:03 volumio volumio[1096]: info: Getting Spotify Cloud Configuration Mar 25 21:38:03 volumio volumio[1096]: info: Asking plugin for UI Config Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 21:38:03 volumio volumio[1096]: info: Saving Spotify Acccount Mar 25 21:38:03 volumio volumio[1096]: info: Got Tidal Cloud Configuration Mar 25 21:38:03 volumio volumio[1096]: info: Got it Mar 25 21:38:03 volumio volumio[1096]: info: Got it Mar 25 21:38:03 volumio volumio[1096]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 21:38:03 volumio volumio[1096]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::volumioGetBrowseSources Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::volumioGetBrowseSources Mar 25 21:38:03 volumio volumio[1096]: info: CoreCommandRouter::volumioGetBrowseSources Mar 25 21:38:04 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 21:38:04 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 25 21:38:05 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand rescan Mar 25 21:38:05 volumio volumio[1096]: info: sendMpdCommand rescan took 4 milliseconds Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:05 volumio volumio[1096]: info: Mar 25 21:38:05 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:05 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:05 volumio volumio[1096]: info: Mar 25 21:38:05 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:05 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:05 volumio volumio[1096]: info: Mar 25 21:38:05 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:05 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:05 volumio volumio[1096]: info: Mar 25 21:38:05 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:05 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:05 volumio volumio[1096]: info: sendMpdCommand status took 49 milliseconds Mar 25 21:38:05 volumio volumio[1096]: info: sendMpdCommand status took 49 milliseconds Mar 25 21:38:05 volumio volumio[1096]: info: sendMpdCommand status took 49 milliseconds Mar 25 21:38:05 volumio volumio[1096]: info: sendMpdCommand status took 49 milliseconds Mar 25 21:38:05 volumio volumio[1096]: info: sendMpdCommand status took 49 milliseconds Mar 25 21:38:05 volumio volumio[1096]: info: sendMpdCommand status took 49 milliseconds Mar 25 21:38:05 volumio volumio[1096]: info: sendMpdCommand status took 48 milliseconds Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:05 volumio volumio[1096]: info: Command Router : Notfying DB Updatetrue Mar 25 21:38:05 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:05 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: info: Command Router : Notfying DB Updatetrue Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: info: Command Router : Notfying DB Updatetrue Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: info: Command Router : Notfying DB Updatetrue Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 96 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 75 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 54 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 24 milliseconds Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":60991,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":60991,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":60991,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":60991,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.109+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=60991 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.110+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.113+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=60991 volume=55 Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 234ms Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.116+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=60991 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.117+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=60991 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.118+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 235ms Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 234ms Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 234ms Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.119+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.121+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.122+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.121+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:06 volumio sudo[2185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:06 volumio sudo[2185]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:06 volumio sudo[2187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:06 volumio sudo[2187]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:06 volumio sudo[2185]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:06 volumio sudo[2191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:06 volumio sudo[2191]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:06 volumio sudo[2187]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:06 volumio sudo[2194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:06 volumio sudo[2194]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:06 volumio sudo[2191]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:06 volumio sudo[2194]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:06 volumio sudo[2199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:06 volumio sudo[2199]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:06 volumio sudo[2197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:06 volumio sudo[2197]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:06 volumio sudo[2199]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:06 volumio sudo[2202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:06 volumio sudo[2202]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:06 volumio sudo[2197]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:06 volumio volumio[1096]: info: MPD Database updated - AlbumList cache refreshed Mar 25 21:38:06 volumio volumio[1096]: info: Mar 25 21:38:06 volumio volumio[1096]: ---------------------------- MPD announces state update: database Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio volumio[1096]: info: Mar 25 21:38:06 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio volumio[1096]: info: MPD Database updated - AlbumList cache refreshed Mar 25 21:38:06 volumio volumio[1096]: info: Mar 25 21:38:06 volumio volumio[1096]: ---------------------------- MPD announces state update: database Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio volumio[1096]: info: Mar 25 21:38:06 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:06 volumio sudo[2205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:06 volumio sudo[2205]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio volumio[1096]: info: MPD Database updated - AlbumList cache refreshed Mar 25 21:38:06 volumio volumio[1096]: info: Mar 25 21:38:06 volumio volumio[1096]: ---------------------------- MPD announces state update: database Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio volumio[1096]: info: Mar 25 21:38:06 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio sudo[2202]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:06 volumio volumio[1096]: info: MPD Database updated - AlbumList cache refreshed Mar 25 21:38:06 volumio volumio[1096]: info: Mar 25 21:38:06 volumio volumio[1096]: ---------------------------- MPD announces state update: database Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio volumio[1096]: info: Mar 25 21:38:06 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:06 volumio sudo[2205]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:06 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand status took 105 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand status took 99 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand status took 98 milliseconds Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: info: Command Router : Notfying DB Updatefalse Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand status took 175 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand status took 169 milliseconds Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: info: Command Router : Notfying DB Updatefalse Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand status took 278 milliseconds Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: info: Command Router : Notfying DB Updatefalse Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand status took 357 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand status took 358 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand status took 357 milliseconds Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: info: Command Router : Notfying DB Updatefalse Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 270 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 270 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 169 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 169 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 53 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 52 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 25 21:38:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61492,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61492,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61492,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61492,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61617,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61617,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61617,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61617,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.918+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61492 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.919+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.920+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61492 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.920+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.922+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61492 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.922+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.925+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61492 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.931+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.926+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61492 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.931+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.927+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61492 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.932+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.927+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61492 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.932+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.927+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61492 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.932+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.927+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61617 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.932+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.927+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61617 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.932+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.927+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61617 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.932+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.927+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61617 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.932+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.927+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61617 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.933+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.933+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61617 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.933+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.933+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61617 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.933+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.936+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=61617 volume=55 Mar 25 21:38:06 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:06.936+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 480ms Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 481ms Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 471ms Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 471ms Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 462ms Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 462ms Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 447ms Mar 25 21:38:06 volumio volumio[1096]: info: ------------------------------ 448ms Mar 25 21:38:06 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:06 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:06 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:06 volumio sudo[2217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:06 volumio sudo[2217]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio sudo[2217]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2220]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2223]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio sudo[2220]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio sudo[2223]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2226]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio sudo[2228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2228]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio sudo[2226]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2228]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio sudo[2232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2232]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio sudo[2234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2234]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2232]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio sudo[2234]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio sudo[2238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2238]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2238]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio sudo[2241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2241]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2241]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio sudo[2244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2244]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio sudo[2244]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2247]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2247]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio sudo[2250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2250]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2250]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2253]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio sudo[2253]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio sudo[2255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2255]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:07 volumio sudo[2259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2255]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio sudo[2259]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio sudo[2262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:07 volumio sudo[2262]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:07 volumio sudo[2259]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio sudo[2262]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:07 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:07 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:08 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 21:38:11 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Mar 25 21:38:11 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:11 volumio volumio[1096]: info: Listing playlists Mar 25 21:38:11 volumio volumio[1096]: info: Listing playlists Mar 25 21:38:11 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand update Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:11 volumio volumio[1096]: info: Mar 25 21:38:11 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:11 volumio volumio[1096]: info: sendMpdCommand update took 3 milliseconds Mar 25 21:38:11 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:11 volumio volumio[1096]: info: Mar 25 21:38:11 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:11 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:11 volumio volumio[1096]: info: Mar 25 21:38:11 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:11 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:11 volumio volumio[1096]: info: Mar 25 21:38:11 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:11 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:11 volumio volumio[1096]: info: sendMpdCommand status took 3 milliseconds Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:11 volumio volumio[1096]: info: Command Router : Notfying DB Updatetrue Mar 25 21:38:11 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:11 volumio volumio[1096]: info: Command Router : Notfying DB Updatetrue Mar 25 21:38:11 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:11 volumio volumio[1096]: info: Mar 25 21:38:11 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:11 volumio volumio[1096]: info: sendMpdCommand status took 102 milliseconds Mar 25 21:38:11 volumio volumio[1096]: info: sendMpdCommand status took 102 milliseconds Mar 25 21:38:11 volumio volumio[1096]: info: sendMpdCommand status took 102 milliseconds Mar 25 21:38:11 volumio volumio[1096]: info: sendMpdCommand status took 102 milliseconds Mar 25 21:38:11 volumio volumio[1096]: info: sendMpdCommand status took 101 milliseconds Mar 25 21:38:11 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:11 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 35 milliseconds Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:11 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:11 volumio volumio[1096]: info: Command Router : Notfying DB Updatetrue Mar 25 21:38:11 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:12 volumio volumio[1096]: info: Command Router : Notfying DB Updatetrue Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:12 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":66865,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:12 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:12 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.038+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=66865 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.038+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.039+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=66865 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.039+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio[1096]: info: ------------------------------ 165ms Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:12 volumio volumio[1096]: info: Mar 25 21:38:12 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:12 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:12 volumio volumio[1096]: info: Mar 25 21:38:12 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:12 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:12 volumio volumio[1096]: info: Mar 25 21:38:12 volumio volumio[1096]: ---------------------------- MPD announces state update: update Mar 25 21:38:12 volumio volumio[1096]: info: ControllerMpd::getState Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2311]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand status took 130 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand status took 127 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 126 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 106 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 83 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand status took 60 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand status took 59 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand status took 59 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand status took 58 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand status took 57 milliseconds Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:12 volumio sudo[2311]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio sudo[2314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2314]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio sudo[2314]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio volumio[1096]: info: Command Router : Notfying DB Updatefalse Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:12 volumio volumio[1096]: info: Command Router : Notfying DB Updatefalse Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:12 volumio volumio[1096]: info: Command Router : Notfying DB Updatefalse Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:12 volumio volumio[1096]: info: Command Router : Notfying DB Updatefalse Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::Close All Modals sent Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 21:38:12 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":66865,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:12 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:12 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":66865,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:12 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:12 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":66865,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:12 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:12 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.315+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=66865 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.315+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.316+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.316+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=66865 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.316+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.316+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=66865 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.316+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.316+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=66865 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.316+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.317+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=66865 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.317+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio[1096]: info: ------------------------------ 443ms Mar 25 21:38:12 volumio volumio[1096]: info: ------------------------------ 444ms Mar 25 21:38:12 volumio volumio[1096]: info: ------------------------------ 443ms Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 135 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 95 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 64 milliseconds Mar 25 21:38:12 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 36 milliseconds Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:12 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Mar 25 21:38:12 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":67115,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:12 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:12 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":67115,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:12 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:12 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":67115,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:12 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:12 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: ControllerMpd::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":67115,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Joyride","artist":"Roxette","album":"Joyride","uri":"USB/A715-B941/1991 - Joyride/01 - Joyride.mp3","trackType":"mp3"} Mar 25 21:38:12 volumio volumio[1096]: verbose: CURRENT POSITION 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Mar 25 21:38:12 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState Mar 25 21:38:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.334+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=67115 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.335+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.336+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=67115 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.336+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.336+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=67115 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.337+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.337+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=67115 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.337+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.337+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=67115 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.337+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.338+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=67115 volume=55 Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.338+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.338+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=67115 volume=55 Mar 25 21:38:12 volumio volumio[1096]: info: ------------------------------ 364ms Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.343+05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" state=STATUS_PLAYING positionMs=67115 volume=55 Mar 25 21:38:12 volumio volumio[1096]: info: ------------------------------ 296ms Mar 25 21:38:12 volumio volumio[1096]: info: ------------------------------ 295ms Mar 25 21:38:12 volumio volumio[1096]: info: ------------------------------ 294ms Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.346+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio5-onboarding[1475]: time=2026-03-25T21:38:12.346+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%02,192.168.0.220:38806 @ 0xc0003ad410" id="music-library/USB/A715-B941/1991 - Joyride/01 - Joyride.mp3" title=Joyride Mar 25 21:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2325]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2325]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio sudo[2328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2328]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2331]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2328]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio sudo[2331]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2334]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio sudo[2336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2336]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio sudo[2334]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2336]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio sudo[2340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2340]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2340]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio sudo[2343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2343]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2346]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio sudo[2343]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2346]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio sudo[2349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2349]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2349]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio sudo[2352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2352]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2352]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio sudo[2355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2355]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2358]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio sudo[2355]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio volumio[1096]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 25 21:38:12 volumio sudo[2358]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio sudo[2361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2361]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio sudo[2361]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio sudo[2364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 25 21:38:12 volumio sudo[2364]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 21:38:12 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:12 volumio sudo[2364]: pam_unix(sudo:session): session closed for user root Mar 25 21:38:12 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:12 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:12 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:12 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:12 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:12 volumio volumio[1096]: info: peppymeterbasic Daemon Started Mar 25 21:38:16 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 21:38:20 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 21:38:21 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Mar 25 21:38:21 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:24 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 21:38:28 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 21:38:31 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState Mar 25 21:38:31 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Mar 25 21:38:31 volumio volumio[1096]: info: Listing playlists Mar 25 21:38:31 volumio volumio[1096]: info: Listing playlists Mar 25 21:38:32 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 21:38:32 volumio volumio[1096]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 21:38:32 volumio volumio[1096]: TypeError: Cannot read property 'slice' of null Mar 25 21:38:32 volumio volumio[1096]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Mar 25 21:38:32 volumio volumio[1096]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Mar 25 21:38:32 volumio volumio[1096]: at Object.onceWrapper (events.js:520:26) Mar 25 21:38:32 volumio volumio[1096]: at ClientRequest.emit (events.js:400:28) Mar 25 21:38:32 volumio volumio[1096]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Mar 25 21:38:32 volumio volumio[1096]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Mar 25 21:38:32 volumio volumio[1096]: at TLSSocket.socketOnData (_http_client.js:515:22) Mar 25 21:38:32 volumio volumio[1096]: at TLSSocket.emit (events.js:400:28) Mar 25 21:38:32 volumio volumio[1096]: at addChunk (internal/streams/readable.js:293:12) Mar 25 21:38:32 volumio volumio[1096]: at readableAddChunk (internal/streams/readable.js:267:9) Mar 25 21:38:32 volumio volumio[1096]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Mar 25 21:38:32 volumio volumio[1096]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Mar 25 21:38:32 volumio volumio[1096]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 21:38:32 volumio sudo[2467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-25 21:37 Mar 25 21:38:32 volumio sudo[2467]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="3dada8b1e619a5feb94867e0865ace17474d7bce" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="30045b259d1a704a832ca7c1460c1fdfa4b723f9" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Mar 2026 09:58:18 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="54b3518c7dd8feba4753e0ad124ce801"