Feb 23 21:28:04 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:28:04 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 25
Feb 23 21:28:10 rpivolumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 179.
Feb 23 21:28:10 rpivolumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 23 21:28:10 rpivolumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 23 21:28:10 rpivolumio upmpdcli[9239]: Could not open config: /tmp/upmpdcli.conf
Feb 23 21:28:10 rpivolumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 23 21:28:10 rpivolumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 23 21:28:14 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:28:14 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 25
Feb 23 21:28:14 rpivolumio volumio[1275]: info: Listing playlists
Feb 23 21:28:14 rpivolumio volumio[1275]: info: Listing playlists
Feb 23 21:28:24 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:28:24 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 25
Feb 23 21:28:25 rpivolumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 180.
Feb 23 21:28:25 rpivolumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 23 21:28:25 rpivolumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 23 21:28:25 rpivolumio upmpdcli[9254]: Could not open config: /tmp/upmpdcli.conf
Feb 23 21:28:25 rpivolumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 23 21:28:25 rpivolumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 23 21:28:34 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:28:34 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 25
Feb 23 21:28:34 rpivolumio volumio[1275]: info: Listing playlists
Feb 23 21:28:34 rpivolumio volumio[1275]: info: Listing playlists
Feb 23 21:28:35 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 23 21:28:35 rpivolumio volumio[1275]: info: Received Get System Info
Feb 23 21:28:35 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 21:28:35 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 21:28:35 rpivolumio volumio[1275]: info: Discovery: Getting this device information
Feb 23 21:28:35 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:28:35 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 25
Feb 23 21:28:35 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioNext
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::next
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::stop
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::stPlaybackTimer
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::updateTrackBlock
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrackBlock
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 25
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::serviceStop
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 25
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::serviceStop
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::stop
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand stop
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces state update: player
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand stop took 15 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::getState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::play index undefined
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::startPlaybackTimer
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::clearAddPlayTracks NAS/Data2/For Music player/VA - Aperitivo In Italy (CONTEMPORARY & TRADITIONAL ITALIAN VIBES) (2025) [FLAC]/Emanuela Campana - Gente distratta.flac
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand stop
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::updateTrackBlock
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrackBlock
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces state update: player
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::getState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces state update: player
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::getState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand status took 5 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand stop took 6 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand status took 6 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand status took 5 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand clear
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseTrackInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::servicePushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: 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":"Malamore","artist":"Danny Losito","album":"Aperitivo In Italy (CONTEMPORARY & TRADITIONAL ITALIAN VIBES)","uri":"NAS/Data2/For Music player/VA - Aperitivo In Italy (CONTEMPORARY & TRADITIONAL ITALIAN VIBES) (2025) [FLAC]/Papik, Danny Losito - Malamore.flac","trackType":"flac"}
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: CURRENT POSITION 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState stateService stop
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState currentStatus stop
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: No code
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 30ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces system playlist update
Feb 23 21:28:38 rpivolumio volumio[1275]: info: Ignoring MPD Status Update
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand clear took 23 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand playlistinfo took 22 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand playlistinfo took 23 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand add "NAS/Data2/For Music player/VA - Aperitivo In Italy (CONTEMPORARY & TRADITIONAL ITALIAN VIBES) (2025) [FLAC]/Emanuela Campana - Gente distratta.flac"
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseTrackInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseTrackInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Feb 23 21:28:38 rpivolumio volumio[1275]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 31ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 30ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces system playlist update
Feb 23 21:28:38 rpivolumio volumio[1275]: info: Ignoring MPD Status Update
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces system playlist update
Feb 23 21:28:38 rpivolumio volumio[1275]: info: Ignoring MPD Status Update
Feb 23 21:28:38 rpivolumio volumio[1275]: info: touch_display: Setting screensaver timeout to 0 seconds.
Feb 23 21:28:38 rpivolumio volumio[1275]: error: updateQueue error: null
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces system playlist update
Feb 23 21:28:38 rpivolumio volumio[1275]: info: Ignoring MPD Status Update
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 17ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand add "NAS/Data2/For Music player/VA - Aperitivo In Italy (CONTEMPORARY & TRADITIONAL ITALIAN VIBES) (2025) [FLAC]/Emanuela Campana - Gente distratta.flac" took 16 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 13ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 13ms
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand play
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces system playlist update
Feb 23 21:28:38 rpivolumio volumio[1275]: info: Ignoring MPD Status Update
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces system playlist update
Feb 23 21:28:38 rpivolumio volumio[1275]: info: Ignoring MPD Status Update
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 12ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand play took 11 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 11ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 10ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces state update: player
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::getState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces state update: player
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::getState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces state update: player
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::getState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces state update: player
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::getState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces state update: player
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand status took 6 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::getState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand status took 5 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand status took 6 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand status took 22 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand status took 21 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand playlistinfo took 20 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand playlistinfo took 20 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand playlistinfo took 20 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseTrackInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseTrackInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseTrackInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::servicePushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: STATE SERVICE {"status":"play","position":0,"seek":206,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"732 Kbps","isStreaming":false,"title":"Gente distratta","artist":"Emanuela Campana","album":"Italian Vibes For Dinner (Best Italian Music To Enjoy Your Food)","uri":"NAS/Data2/For Music player/VA - Aperitivo In Italy (CONTEMPORARY & TRADITIONAL ITALIAN VIBES) (2025) [FLAC]/Emanuela Campana - Gente distratta.flac","trackType":"flac"}
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: CURRENT POSITION 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState stateService play
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState currentStatus stop
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::servicePushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: STATE SERVICE {"status":"play","position":0,"seek":573,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"717 Kbps","isStreaming":false,"title":"Gente distratta","artist":"Emanuela Campana","album":"Italian Vibes For Dinner (Best Italian Music To Enjoy Your Food)","uri":"NAS/Data2/For Music player/VA - Aperitivo In Italy (CONTEMPORARY & TRADITIONAL ITALIAN VIBES) (2025) [FLAC]/Emanuela Campana - Gente distratta.flac","trackType":"flac"}
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: CURRENT POSITION 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState stateService play
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState currentStatus play
Feb 23 21:28:38 rpivolumio volumio[1275]: info: Received an update from plugin. extracting info from payload
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::servicePushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: STATE SERVICE {"status":"play","position":0,"seek":664,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"717 Kbps","isStreaming":false,"title":"Gente distratta","artist":"Emanuela Campana","album":"Italian Vibes For Dinner (Best Italian Music To Enjoy Your Food)","uri":"NAS/Data2/For Music player/VA - Aperitivo In Italy (CONTEMPORARY & TRADITIONAL ITALIAN VIBES) (2025) [FLAC]/Emanuela Campana - Gente distratta.flac","trackType":"flac"}
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: CURRENT POSITION 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState stateService play
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState currentStatus play
Feb 23 21:28:38 rpivolumio volumio[1275]: info: Received an update from plugin. extracting info from payload
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 67ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 74ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 74ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info:
Feb 23 21:28:38 rpivolumio volumio[1275]: ---------------------------- MPD announces state update: player
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::getState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand playlistinfo took 55 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand playlistinfo took 56 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand status took 7 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseTrackInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseTrackInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseState
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::servicePushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"445 Kbps","isStreaming":false,"title":"Gente distratta","artist":"Emanuela Campana","album":"Italian Vibes For Dinner (Best Italian Music To Enjoy Your Food)","uri":"NAS/Data2/For Music player/VA - Aperitivo In Italy (CONTEMPORARY & TRADITIONAL ITALIAN VIBES) (2025) [FLAC]/Emanuela Campana - Gente distratta.flac","trackType":"flac"}
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: CURRENT POSITION 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState stateService play
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState currentStatus play
Feb 23 21:28:38 rpivolumio volumio[1275]: info: Received an update from plugin. extracting info from payload
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::servicePushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"445 Kbps","isStreaming":false,"title":"Gente distratta","artist":"Emanuela Campana","album":"Italian Vibes For Dinner (Best Italian Music To Enjoy Your Food)","uri":"NAS/Data2/For Music player/VA - Aperitivo In Italy (CONTEMPORARY & TRADITIONAL ITALIAN VIBES) (2025) [FLAC]/Emanuela Campana - Gente distratta.flac","trackType":"flac"}
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: CURRENT POSITION 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState stateService play
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState currentStatus play
Feb 23 21:28:38 rpivolumio volumio[1275]: info: Received an update from plugin. extracting info from payload
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 105ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 104ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info: sendMpdCommand playlistinfo took 67 milliseconds
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: ControllerMpd::parseTrackInfo
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ControllerMpd::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::servicePushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":329,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"445 Kbps","isStreaming":false,"title":"Gente distratta","artist":"Emanuela Campana","album":"Italian Vibes For Dinner (Best Italian Music To Enjoy Your Food)","uri":"NAS/Data2/For Music player/VA - Aperitivo In Italy (CONTEMPORARY & TRADITIONAL ITALIAN VIBES) (2025) [FLAC]/Emanuela Campana - Gente distratta.flac","trackType":"flac"}
Feb 23 21:28:38 rpivolumio volumio[1275]: verbose: CURRENT POSITION 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState stateService play
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::syncState currentStatus play
Feb 23 21:28:38 rpivolumio volumio[1275]: info: Received an update from plugin. extracting info from payload
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:38 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:28:38 rpivolumio volumio[1275]: info: ------------------------------ 84ms
Feb 23 21:28:38 rpivolumio volumio[1275]: info: touch_display: Setting screensaver timeout to 0 seconds.
Feb 23 21:28:40 rpivolumio dhcpcd[909]: eth0: failed to renew DHCP, rebinding
Feb 23 21:28:40 rpivolumio dhcpcd[909]: eth0: NAK: address not available from 192.168.62.1
Feb 23 21:28:40 rpivolumio dhcpcd[909]: eth0: message: address not available
Feb 23 21:28:40 rpivolumio avahi-daemon[778]: Withdrawing address record for 192.168.62.25 on eth0.
Feb 23 21:28:40 rpivolumio avahi-daemon[778]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.62.25.
Feb 23 21:28:40 rpivolumio dhcpcd[759]: eth0: pid 909 deleted IP address 192.168.62.25/24
Feb 23 21:28:40 rpivolumio dhcpcd[759]: eth0: deleting route to 192.168.62.0/24
Feb 23 21:28:40 rpivolumio avahi-daemon[778]: Interface eth0.IPv4 no longer relevant for mDNS.
Feb 23 21:28:40 rpivolumio dhcpcd[759]: eth0: deleting default route via 192.168.62.4
Feb 23 21:28:40 rpivolumio dhcpcd[909]: eth0: deleting route to 192.168.62.0/24
Feb 23 21:28:40 rpivolumio dhcpcd[909]: eth0: deleting default route via 192.168.62.4
Feb 23 21:28:40 rpivolumio volumio[1275]: info: Discovery: A device disappeared from network
Feb 23 21:28:40 rpivolumio volumio[1275]: info: Discovery: Device rpivolumio disappeared from network
Feb 23 21:28:40 rpivolumio dhcpcd[909]: eth0: soliciting a DHCP lease
Feb 23 21:28:40 rpivolumio dhcpcd[759]: eth0: soliciting a DHCP lease
Feb 23 21:28:40 rpivolumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Feb 23 21:28:40 rpivolumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Feb 23 21:28:40 rpivolumio systemd[1]: welcome.service: Deactivated successfully.
Feb 23 21:28:40 rpivolumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Feb 23 21:28:40 rpivolumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Feb 23 21:28:40 rpivolumio dhcpcd[759]: eth0: offered 192.168.62.25 from 192.168.62.4
Feb 23 21:28:40 rpivolumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Feb 23 21:28:40 rpivolumio dhcpcd[759]: eth0: probing address 192.168.62.25/24
Feb 23 21:28:40 rpivolumio welcome[9313]: Resolved ip:[0]
Feb 23 21:28:40 rpivolumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Feb 23 21:28:40 rpivolumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Feb 23 21:28:40 rpivolumio dhcpcd[909]: eth0: offered 192.168.62.25 from 192.168.62.4
Feb 23 21:28:40 rpivolumio dhcpcd[909]: eth0: probing address 192.168.62.25/24
Feb 23 21:28:40 rpivolumio volumio[1275]: info: Received Get System Info
Feb 23 21:28:40 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 21:28:40 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 21:28:40 rpivolumio volumio[1275]: info: Discovery: Getting this device information
Feb 23 21:28:40 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:28:40 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:40 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 21:28:40 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 23 21:28:40 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 23 21:28:40 rpivolumio volumio5-onboarding[1700]: time=2026-02-23T21:28:40.576+02:00 level=INFO msg="enabling BLE discovery"
Feb 23 21:28:40 rpivolumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 181.
Feb 23 21:28:40 rpivolumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 23 21:28:40 rpivolumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 23 21:28:40 rpivolumio upmpdcli[9319]: Could not open config: /tmp/upmpdcli.conf
Feb 23 21:28:40 rpivolumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 23 21:28:40 rpivolumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 23 21:28:41 rpivolumio ntpd[1110]: IO: Deleting interface #27 eth0, 192.168.62.25#123, interface stats: received=4, sent=4, dropped=1, active_time=105 secs
Feb 23 21:28:41 rpivolumio ntpd[1110]: PROTO: 77.236.182.128 unlink local addr 192.168.62.25 ->
Feb 23 21:28:41 rpivolumio ntpd[1110]: PROTO: 78.83.137.244 unlink local addr 192.168.62.25 ->
Feb 23 21:28:41 rpivolumio ntpd[1110]: PROTO: 195.85.215.8 unlink local addr 192.168.62.25 ->
Feb 23 21:28:41 rpivolumio ntpd[1110]: PROTO: 185.117.82.71 unlink local addr 192.168.62.25 ->
Feb 23 21:28:41 rpivolumio ntpd[1110]: PROTO: 162.159.200.1 unlink local addr 192.168.62.25 ->
Feb 23 21:28:41 rpivolumio ntpd[1110]: PROTO: 88.203.195.14 unlink local addr 192.168.62.25 ->
Feb 23 21:28:41 rpivolumio ntpd[1110]: PROTO: 162.159.200.123 unlink local addr 192.168.62.25 ->
Feb 23 21:28:44 rpivolumio dhcpcd[759]: eth0: leased 192.168.62.25 for 120 seconds
Feb 23 21:28:44 rpivolumio avahi-daemon[778]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.62.25.
Feb 23 21:28:44 rpivolumio avahi-daemon[778]: New relevant interface eth0.IPv4 for mDNS.
Feb 23 21:28:44 rpivolumio avahi-daemon[778]: Registering new address record for 192.168.62.25 on eth0.IPv4.
Feb 23 21:28:44 rpivolumio dhcpcd[759]: eth0: adding route to 192.168.62.0/24
Feb 23 21:28:44 rpivolumio dhcpcd[759]: eth0: adding default route via 192.168.62.4
Feb 23 21:28:44 rpivolumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Feb 23 21:28:44 rpivolumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Feb 23 21:28:44 rpivolumio systemd[1]: welcome.service: Deactivated successfully.
Feb 23 21:28:44 rpivolumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Feb 23 21:28:44 rpivolumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Feb 23 21:28:44 rpivolumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Feb 23 21:28:44 rpivolumio welcome[9338]: Resolved ip:[1] 192.168.62.25
Feb 23 21:28:44 rpivolumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Feb 23 21:28:44 rpivolumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Feb 23 21:28:44 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:28:44 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:44 rpivolumio dhcpcd[909]: eth0: leased 192.168.62.25 for 120 seconds
Feb 23 21:28:44 rpivolumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Feb 23 21:28:44 rpivolumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Feb 23 21:28:44 rpivolumio systemd[1]: welcome.service: Deactivated successfully.
Feb 23 21:28:44 rpivolumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Feb 23 21:28:44 rpivolumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Feb 23 21:28:44 rpivolumio dhcpcd[909]: eth0: adding route to 192.168.62.0/24
Feb 23 21:28:44 rpivolumio dhcpcd[909]: eth0: adding default route via 192.168.62.4
Feb 23 21:28:44 rpivolumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Feb 23 21:28:44 rpivolumio welcome[9366]: Resolved ip:[1] 192.168.62.25
Feb 23 21:28:44 rpivolumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Feb 23 21:28:44 rpivolumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Feb 23 21:28:45 rpivolumio volumio[1275]: info: Discovery: adding 90f22a5f-9c21-4268-9963-dbbec66ea672
Feb 23 21:28:45 rpivolumio volumio[1275]: info: Discovery: Found device RpiVolumio
Feb 23 21:28:45 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:28:45 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:45 rpivolumio volumio[1275]: info: Received Get System Info
Feb 23 21:28:45 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 21:28:45 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 21:28:45 rpivolumio volumio[1275]: info: Discovery: Getting this device information
Feb 23 21:28:45 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:28:45 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:45 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 21:28:45 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 23 21:28:45 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 23 21:28:45 rpivolumio volumio5-onboarding[1700]: time=2026-02-23T21:28:45.369+02:00 level=INFO msg="disabling BLE discovery"
Feb 23 21:28:45 rpivolumio volumio5-onboarding[1700]: time=2026-02-23T21:28:45.375+02:00 level=INFO msg="connection closed, stopping read loop" component=conn/multi net=ble addr=E4:5F:01:0E:93:3F%00
Feb 23 21:28:46 rpivolumio ntpd[1110]: IO: Listen normally on 28 eth0 192.168.62.25:123
Feb 23 21:28:46 rpivolumio ntpd[1110]: IO: new interface(s) found: waking up resolver
Feb 23 21:28:46 rpivolumio nmbd[1162]: [2026/02/23 21:28:46.714573, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Feb 23 21:28:46 rpivolumio nmbd[1162]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.62.25 for name WORKGROUP<1d>.
Feb 23 21:28:46 rpivolumio nmbd[1162]: This response was from IP 192.168.62.20, reporting an IP address of 192.168.62.20.
Feb 23 21:28:54 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:28:54 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:28:54 rpivolumio volumio[1275]: info: Listing playlists
Feb 23 21:28:54 rpivolumio volumio[1275]: info: Listing playlists
Feb 23 21:28:55 rpivolumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 182.
Feb 23 21:28:55 rpivolumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 23 21:28:55 rpivolumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 23 21:28:55 rpivolumio upmpdcli[9388]: Could not open config: /tmp/upmpdcli.conf
Feb 23 21:28:55 rpivolumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 23 21:28:55 rpivolumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 23 21:29:04 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:29:04 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:29:11 rpivolumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 183.
Feb 23 21:29:11 rpivolumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 23 21:29:11 rpivolumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 23 21:29:11 rpivolumio upmpdcli[9419]: Could not open config: /tmp/upmpdcli.conf
Feb 23 21:29:11 rpivolumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 23 21:29:11 rpivolumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 23 21:29:14 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioGetState
Feb 23 21:29:14 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:29:14 rpivolumio volumio[1275]: info: Listing playlists
Feb 23 21:29:14 rpivolumio volumio[1275]: info: Listing playlists
Feb 23 21:29:17 rpivolumio volumio[1275]: info: Preload queue cleared
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreStateMachine::ClearQueue
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreStateMachine::stop
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreStateMachine::stPlaybackTimer
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreStateMachine::updateTrackBlock
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CorePlayQueue::getTrackBlock
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreStateMachine::pushState
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushState
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreStateMachine::serviceStop
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CorePlayQueue::getTrack 8
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreCommandRouter::serviceStop
Feb 23 21:29:17 rpivolumio volumio[1275]: info: ControllerMpd::stop
Feb 23 21:29:17 rpivolumio volumio[1275]: verbose: ControllerMpd::sendMpdCommand stop
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CorePlayQueue::clearPlayQueue
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CorePlayQueue::saveQueue
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreCommandRouter::volumioPushQueue
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CoreStateMachine::addQueueItems
Feb 23 21:29:17 rpivolumio volumio[1275]: info: CorePlayQueue::addQueueItems
Feb 23 21:29:17 rpivolumio volumio[1275]: info: Preload queue cleared
Feb 23 21:29:17 rpivolumio volumio[1275]: info: Adding Item to queue: music-library/NAS/Data2/For Music player/George Michael-Ladies & Gentlemen The Best Of George Michael (2 CD) (1998)
Feb 23 21:29:17 rpivolumio volumio[1275]: info: Exploding uri music-library/NAS/Data2/For Music player/George Michael-Ladies & Gentlemen The Best Of George Michael (2 CD) (1998) in service mpd
Feb 23 21:29:17 rpivolumio volumio[1275]: info:
Feb 23 21:29:17 rpivolumio volumio[1275]: ---------------------------- MPD announces state update: player
Feb 23 21:29:17 rpivolumio volumio[1275]: info: ALBUMART /albumart?cacheid=849&web=George%20Michael/Ladies%20%26%20Gentlemen%3A%20The%20Best%20Of%20George%20Michael%20CD%201%20%20%20/mega&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FGeorge%20Michael-Ladies%20%26%20Gentlemen%20The%20Best%20Of%20George%20Michael%20(2%20CD)%20(1998)%2FCD%201%2FGeorge%20Michael%20-%20Ladies%20%26%20Gentlemen-%20The%20Best%20Of%20George%20Michael%20CD%201.cue&metadata=false
Feb 23 21:29:17 rpivolumio volumio[1275]: info: URI /mnt/NAS/Data2/For Music player/George Michael-Ladies & Gentlemen The Best Of George Michael (2 CD) (1998)/CD 1/George Michael - Ladies & Gentlemen- The Best Of George Michael CD 1.cue
Feb 23 21:29:17 rpivolumio volumio[1275]: info: ALBUMART /albumart?cacheid=849&web=George%20Michael/Ladies%20%26%20Gentlemen%3A%20The%20Best%20Of%20George%20Michael%20CD%201%20%20%20/mega&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FGeorge%20Michael-Ladies%20%26%20Gentlemen%20The%20Best%20Of%20George%20Michael%20(2%20CD)%20(1998)%2FCD%201%2FGeorge%20Michael%20-%20Ladies%20%26%20Gentlemen-%20The%20Best%20Of%20George%20Michael%20CD%201.cue&metadata=false
Feb 23 21:29:17 rpivolumio volumio[1275]: info: URI /mnt/NAS/Data2/For Music player/George Michael-Ladies & Gentlemen The Best Of George Michael (2 CD) (1998)/CD 1/George Michael - Ladies & Gentlemen- The Best Of George Michael CD 1.cue
Feb 23 21:29:17 rpivolumio volumio[1275]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 23 21:29:17 rpivolumio volumio[1275]: Error: Unable to resolve or reject the same promise twice
Feb 23 21:29:17 rpivolumio volumio[1275]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Feb 23 21:29:17 rpivolumio volumio[1275]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21
Feb 23 21:29:17 rpivolumio volumio[1275]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Feb 23 21:29:17 rpivolumio volumio[1275]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Feb 23 21:29:17 rpivolumio volumio[1275]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Feb 23 21:29:17 rpivolumio volumio[1275]: at Socket.emit (node:events:514:28)
Feb 23 21:29:17 rpivolumio volumio[1275]: at addChunk (node:internal/streams/readable:343:12)
Feb 23 21:29:17 rpivolumio volumio[1275]: at readableAddChunk (node:internal/streams/readable:312:11)
Feb 23 21:29:17 rpivolumio volumio[1275]: at Readable.push (node:internal/streams/readable:253:10)
Feb 23 21:29:17 rpivolumio volumio[1275]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
Feb 23 21:29:17 rpivolumio volumio[1275]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 23 21:29:18 rpivolumio sudo[9449]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-23 21:28'
Feb 23 21:29:18 rpivolumio sudo[9449]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"