Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: MPD Permissions set Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: Starting Shairport Sync Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: Starting Shairport Sync Oct 03 13:22:00 volumior-pi-4 sudo[2802]: volumio : unable to resolve host volumior-pi-4: System error Oct 03 13:22:00 volumior-pi-4 sudo[2803]: volumio : unable to resolve host volumior-pi-4: System error Oct 03 13:22:00 volumior-pi-4 sudo[2802]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 03 13:22:00 volumior-pi-4 sudo[2802]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 13:22:00 volumior-pi-4 sudo[2803]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 03 13:22:00 volumior-pi-4 sudo[2803]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 13:22:00 volumior-pi-4 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 03 13:22:00 volumior-pi-4 systemd[1]: shairport-sync.service: Deactivated successfully. Oct 03 13:22:00 volumior-pi-4 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 03 13:22:00 volumior-pi-4 systemd[1]: shairport-sync.service: Consumed 3.973s CPU time. Oct 03 13:22:00 volumior-pi-4 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 03 13:22:00 volumior-pi-4 sudo[2802]: pam_unix(sudo:session): session closed for user root Oct 03 13:22:00 volumior-pi-4 sudo[2803]: pam_unix(sudo:session): session closed for user root Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: Shairport-Sync Started Oct 03 13:22:00 volumior-pi-4 volumio[1068]: info: Shairport-Sync Started Oct 03 13:22:00 volumior-pi-4 systemd[1]: mpd.service: Deactivated successfully. Oct 03 13:22:00 volumior-pi-4 systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 03 13:22:00 volumior-pi-4 systemd[1]: mpd.service: Consumed 8.297s CPU time. Oct 03 13:22:00 volumior-pi-4 systemd[1]: mpd.socket: Deactivated successfully. Oct 03 13:22:00 volumior-pi-4 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 03 13:22:00 volumior-pi-4 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 03 13:22:00 volumior-pi-4 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 03 13:22:00 volumior-pi-4 systemd[1]: Starting mpd.service - Music Player Daemon... Oct 03 13:22:00 volumior-pi-4 sudo[2822]: root : unable to resolve host volumior-pi-4: System error Oct 03 13:22:00 volumior-pi-4 sudo[2822]: sudo: unable to resolve host volumior-pi-4: System error Oct 03 13:22:00 volumior-pi-4 sudo[2822]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 03 13:22:00 volumior-pi-4 sudo[2822]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 03 13:22:00 volumior-pi-4 sudo[2822]: pam_unix(sudo:session): session closed for user root Oct 03 13:22:02 volumior-pi-4 mpd[2825]: 2026-10-03T13:22:02 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 03 13:22:03 volumior-pi-4 systemd[1]: Started mpd.service - Music Player Daemon. Oct 03 13:22:03 volumior-pi-4 sudo[2781]: pam_unix(sudo:session): session closed for user root Oct 03 13:22:03 volumior-pi-4 sudo[2770]: pam_unix(sudo:session): session closed for user root Oct 03 13:22:03 volumior-pi-4 volumio[1068]: error: MPD error: The expression evaluated to a falsy value: Oct 03 13:22:03 volumior-pi-4 volumio[1068]: assert.ok(self.idling) Oct 03 13:22:03 volumior-pi-4 volumio[1068]: error: The expression evaluated to a falsy value: Oct 03 13:22:03 volumior-pi-4 volumio[1068]: assert.ok(self.idling) Oct 03 13:22:03 volumior-pi-4 volumio[1068]: error: updateQueue error: null Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CoreStateMachine::getcurrentVolume Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioRetrievevolume Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: VolumeController:: Volume=100 Mute =false Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CoreStateMachine::pushState Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioPushState Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CoreStateMachine::updateTrackBlock Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrackBlock Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioRetrievevolume Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: VolumeController:: Volume=100 Mute =false Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CoreStateMachine::pushState Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 13:22:03 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioPushState Oct 03 13:22:04 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioGetState Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: Restoring Previous Volume level: 100 false false Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: Output device has changed, restarting MPD Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: Output device has changed, restarting Shairport Sync Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 13:22:10 volumior-pi-4 sudo[2847]: volumio : unable to resolve host volumior-pi-4: System error Oct 03 13:22:10 volumior-pi-4 sudo[2847]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 03 13:22:10 volumior-pi-4 sudo[2847]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 03 13:22:10 volumior-pi-4 sudo[2847]: pam_unix(sudo:session): session closed for user root Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: Volume configurations have been set Oct 03 13:22:10 volumior-pi-4 sudo[2850]: volumio : unable to resolve host volumior-pi-4: System error Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: Updating Volume Controller Parameters: Device: 5 Name: Combo384 Amanero Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 03 13:22:10 volumior-pi-4 sudo[2850]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 03 13:22:10 volumior-pi-4 sudo[2850]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: Disabling external Volume Control Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreStateMachine::pushState Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioPushState Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: MPD Permissions set Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: VolumeController:: alsactl monitor closed, code: 0 Oct 03 13:22:10 volumior-pi-4 systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 13:22:10 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 03 13:22:11 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 13:22:11 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 13:22:11 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 13:22:11 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 13:22:11 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 13:22:11 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 13:22:11 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 13:22:11 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 03 13:22:11 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 03 13:22:11 volumior-pi-4 volumio[1068]: info: Starting Shairport Sync Oct 03 13:22:11 volumior-pi-4 sudo[2872]: volumio : unable to resolve host volumior-pi-4: System error Oct 03 13:22:11 volumior-pi-4 sudo[2872]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 03 13:22:11 volumior-pi-4 sudo[2872]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 13:22:11 volumior-pi-4 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 03 13:22:11 volumior-pi-4 systemd[1]: shairport-sync.service: Deactivated successfully. Oct 03 13:22:11 volumior-pi-4 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 03 13:22:11 volumior-pi-4 systemd[1]: shairport-sync.service: Consumed 1.600s CPU time. Oct 03 13:22:11 volumior-pi-4 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 03 13:22:11 volumior-pi-4 sudo[2872]: pam_unix(sudo:session): session closed for user root Oct 03 13:22:11 volumior-pi-4 volumio[1068]: info: Shairport-Sync Started Oct 03 13:22:11 volumior-pi-4 systemd[1]: mpd.service: Deactivated successfully. Oct 03 13:22:11 volumior-pi-4 systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 03 13:22:11 volumior-pi-4 systemd[1]: mpd.service: Consumed 3.095s CPU time. Oct 03 13:22:11 volumior-pi-4 systemd[1]: mpd.socket: Deactivated successfully. Oct 03 13:22:11 volumior-pi-4 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 03 13:22:11 volumior-pi-4 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 03 13:22:11 volumior-pi-4 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 03 13:22:11 volumior-pi-4 systemd[1]: Starting mpd.service - Music Player Daemon... Oct 03 13:22:11 volumior-pi-4 sudo[2876]: root : unable to resolve host volumior-pi-4: System error Oct 03 13:22:11 volumior-pi-4 sudo[2876]: sudo: unable to resolve host volumior-pi-4: System error Oct 03 13:22:11 volumior-pi-4 sudo[2876]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 03 13:22:11 volumior-pi-4 sudo[2876]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 03 13:22:11 volumior-pi-4 sudo[2876]: pam_unix(sudo:session): session closed for user root Oct 03 13:22:12 volumior-pi-4 mpd[2892]: 2026-10-03T13:22:12 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 03 13:22:14 volumior-pi-4 systemd[1]: Started mpd.service - Music Player Daemon. Oct 03 13:22:14 volumior-pi-4 sudo[2850]: pam_unix(sudo:session): session closed for user root Oct 03 13:22:14 volumior-pi-4 volumio[1068]: error: updateQueue error: null Oct 03 13:22:15 volumior-pi-4 volumio[1068]: info: VolumeController::SetAlsaVolume100 Oct 03 13:22:15 volumior-pi-4 volumio[1068]: info: CoreStateMachine::pushState Oct 03 13:22:15 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:22:15 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 13:22:15 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioPushState Oct 03 13:22:20 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioGetState Oct 03 13:22:20 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:22:23 volumior-pi-4 ntpd[975]: PROTO: 194.0.5.123 unlink local addr 192.168.0.27 -> Oct 03 13:22:27 volumior-pi-4 ntpd[975]: PROTO: 1.230.135.74 unlink local addr 192.168.0.27 -> Oct 03 13:22:30 volumior-pi-4 ntpd[975]: PROTO: 211.222.238.30 unlink local addr 192.168.0.27 -> Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioPlay Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: CoreStateMachine::play index undefined Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: CoreStateMachine::startPlaybackTimer Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:23:25 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::clearAddPlayTracks NAS/DSD_MUSIC/JAZZROCKWORLDETC/[DSD - DFF] Christie Winn - C'est Magnifique (2011) [DSD·64]/01 - You Don't Know What Love Is.dff Oct 03 13:23:25 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::sendMpdCommand stop Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: sendMpdCommand stop took 1 milliseconds Oct 03 13:23:25 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::sendMpdCommand clear Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: Oct 03 13:23:25 volumior-pi-4 volumio[1068]: ---------------------------- MPD announces system playlist update Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: Ignoring MPD Status Update Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: sendMpdCommand clear took 1 milliseconds Oct 03 13:23:25 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::sendMpdCommand add "NAS/DSD_MUSIC/JAZZROCKWORLDETC/[DSD - DFF] Christie Winn - C'est Magnifique (2011) [DSD·64]/01 - You Don't Know What Love Is.dff" Oct 03 13:23:25 volumior-pi-4 volumio[1068]: error: updateQueue error: null Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: Oct 03 13:23:25 volumior-pi-4 volumio[1068]: ---------------------------- MPD announces system playlist update Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: Ignoring MPD Status Update Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: ------------------------------ 3ms Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: sendMpdCommand add "NAS/DSD_MUSIC/JAZZROCKWORLDETC/[DSD - DFF] Christie Winn - C'est Magnifique (2011) [DSD·64]/01 - You Don't Know What Love Is.dff" took 2 milliseconds Oct 03 13:23:25 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::sendMpdCommand play Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: ------------------------------ 2ms Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: sendMpdCommand play took 2 milliseconds Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: Oct 03 13:23:25 volumior-pi-4 volumio[1068]: ---------------------------- MPD announces state update: player Oct 03 13:23:25 volumior-pi-4 volumio[1068]: info: ControllerMpd::getState Oct 03 13:23:25 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::sendMpdCommand status Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: Oct 03 13:23:26 volumior-pi-4 volumio[1068]: ---------------------------- MPD announces state update: player Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: sendMpdCommand status took 301 milliseconds Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: ControllerMpd::getState Oct 03 13:23:26 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::sendMpdCommand status Oct 03 13:23:26 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::parseState Oct 03 13:23:26 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: sendMpdCommand status took 4 milliseconds Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 03 13:23:26 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::parseState Oct 03 13:23:26 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 03 13:23:26 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::parseTrackInfo Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: ControllerMpd::pushState Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::servicePushState Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:23:26 volumior-pi-4 volumio[1068]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":180,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 - You Don't Know What Love Is.dff","artist":null,"album":null,"uri":"NAS/DSD_MUSIC/JAZZROCKWORLDETC/[DSD - DFF] Christie Winn - C'est Magnifique (2011) [DSD·64]/01 - You Don't Know What Love Is.dff","trackType":"dff"} Oct 03 13:23:26 volumior-pi-4 volumio[1068]: verbose: CURRENT POSITION 0 Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CoreStateMachine::syncState stateService play Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CoreStateMachine::syncState currentStatus stop Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: ------------------------------ 309ms Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 03 13:23:26 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::parseTrackInfo Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: ControllerMpd::pushState Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::servicePushState Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:23:26 volumior-pi-4 volumio[1068]: verbose: STATE SERVICE {"status":"play","position":0,"seek":991,"duration":180,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 - You Don't Know What Love Is.dff","artist":null,"album":null,"uri":"NAS/DSD_MUSIC/JAZZROCKWORLDETC/[DSD - DFF] Christie Winn - C'est Magnifique (2011) [DSD·64]/01 - You Don't Know What Love Is.dff","trackType":"dff"} Oct 03 13:23:26 volumior-pi-4 volumio[1068]: verbose: CURRENT POSITION 0 Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CoreStateMachine::syncState stateService play Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CoreStateMachine::syncState currentStatus play Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: Received an update from plugin. extracting info from payload Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CoreStateMachine::pushState Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioPushState Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CoreStateMachine::pushState Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioPushState Oct 03 13:23:26 volumior-pi-4 volumio[1068]: info: ------------------------------ 29ms Oct 03 13:23:30 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioGetQueue Oct 03 13:23:30 volumior-pi-4 volumio[1068]: info: CoreStateMachine::getQueue Oct 03 13:23:30 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getQueue Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: Preload queue cleared Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreStateMachine::ClearQueue Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreStateMachine::stop Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreStateMachine::stPlaybackTimer Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreStateMachine::updateTrackBlock Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrackBlock Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreStateMachine::pushState Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioPushState Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreStateMachine::serviceStop Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CorePlayQueue::getTrack 0 Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::serviceStop Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: ControllerMpd::stop Oct 03 13:23:49 volumior-pi-4 volumio[1068]: verbose: ControllerMpd::sendMpdCommand stop Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CorePlayQueue::clearPlayQueue Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CorePlayQueue::saveQueue Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreCommandRouter::volumioPushQueue Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CoreStateMachine::addQueueItems Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: CorePlayQueue::addQueueItems Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: Preload queue cleared Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: Adding Item to queue: music-library/NAS/DSD_MUSIC/JAZZROCKWORLDETC/[DSD - DFF] Mark Knopfler-Shangri-La (2004) [DSD·64] Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: Exploding uri music-library/NAS/DSD_MUSIC/JAZZROCKWORLDETC/[DSD - DFF] Mark Knopfler-Shangri-La (2004) [DSD·64] in service mpd Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: sendMpdCommand stop took 47 milliseconds Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: Oct 03 13:23:49 volumior-pi-4 volumio[1068]: ---------------------------- MPD announces state update: player Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: ALBUMART /albumart?cacheid=566&web=/Fucked%20album/extralarge&path=%2Fmnt%2FNAS%2FDSD_MUSIC%2FJAZZROCKWORLDETC%2F%5BDSD%20-%20DFF%5D%20Mark%20Knopfler-Shangri-La%20(2004)%20%5BDSD%C2%B764%5D%2FShangri-La%202.0%20%5BDSD%C2%B764%5D%2FCDImage.cue&metadata=false Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: URI /mnt/NAS/DSD_MUSIC/JAZZROCKWORLDETC/[DSD - DFF] Mark Knopfler-Shangri-La (2004) [DSD·64]/Shangri-La 2.0 [DSD·64]/CDImage.cue Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: ALBUMART /albumart?cacheid=566&web=/Fucked%20album/extralarge&path=%2Fmnt%2FNAS%2FDSD_MUSIC%2FJAZZROCKWORLDETC%2F%5BDSD%20-%20DFF%5D%20Mark%20Knopfler-Shangri-La%20(2004)%20%5BDSD%C2%B764%5D%2FShangri-La%202.0%20%5BDSD%C2%B764%5D%2FCDImage.cue&metadata=false Oct 03 13:23:49 volumior-pi-4 volumio[1068]: info: URI /mnt/NAS/DSD_MUSIC/JAZZROCKWORLDETC/[DSD - DFF] Mark Knopfler-Shangri-La (2004) [DSD·64]/Shangri-La 2.0 [DSD·64]/CDImage.cue Oct 03 13:23:49 volumior-pi-4 volumio[1068]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 13:23:49 volumior-pi-4 volumio[1068]: Error: Unable to resolve or reject the same promise twice Oct 03 13:23:49 volumior-pi-4 volumio[1068]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 03 13:23:49 volumior-pi-4 volumio[1068]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Oct 03 13:23:49 volumior-pi-4 volumio[1068]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 03 13:23:49 volumior-pi-4 volumio[1068]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 03 13:23:49 volumior-pi-4 volumio[1068]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 03 13:23:49 volumior-pi-4 volumio[1068]: at Socket.emit (node:events:514:28) Oct 03 13:23:49 volumior-pi-4 volumio[1068]: at addChunk (node:internal/streams/readable:343:12) Oct 03 13:23:49 volumior-pi-4 volumio[1068]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 03 13:23:49 volumior-pi-4 volumio[1068]: at Readable.push (node:internal/streams/readable:253:10) Oct 03 13:23:49 volumior-pi-4 volumio[1068]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 03 13:23:49 volumior-pi-4 volumio[1068]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 13:23:50 volumior-pi-4 sudo[3069]: volumio : unable to resolve host volumior-pi-4: System error Oct 03 13:23:50 volumior-pi-4 sudo[3069]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-03 13:22' Oct 03 13:23:50 volumior-pi-4 sudo[3069]: 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="ebd772339e193fb4b3a98c68e63a0009e72d6f27" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0a52c1fb90959ba1872a2fb0225e56fe615b19ac" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Sep 14 07:39:23 UTC 2026" VOLUMIO_VERSION="4.204" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="915e71dafc26fd850574d238b4f947d5"