-- Logs begin at Thu 2025-07-17 20:36:07 CEST, end at Thu 2025-07-17 20:39:47 CEST. -- Jul 17 20:38:07 volumio volumio[1270]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Jul 17 20:38:07 volumio volumio[1270]: info: Restoring Previous Volume level: 100 false false Jul 17 20:38:07 volumio volumio[1270]: info: Output device has changed, restarting MPD Jul 17 20:38:07 volumio sudo[2115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 20:38:07 volumio sudo[2115]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:07 volumio sudo[2115]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:07 volumio volumio[1270]: info: Output device has changed, restarting Shairport Sync Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:07 volumio sudo[2118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 20:38:07 volumio sudo[2118]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:07 volumio systemd[1]: Stopping Music Player Daemon... Jul 17 20:38:07 volumio volumio[1270]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 20:38:07 volumio volumio[1270]: info: Volume configurations have been set Jul 17 20:38:07 volumio systemd[1]: mpd.service: Succeeded. Jul 17 20:38:07 volumio systemd[1]: Stopped Music Player Daemon. Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 20:38:07 volumio volumio[1270]: info: Updating Volume Controller Parameters: Device: 0 Name: JustBoom Digi Boards Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 17 20:38:07 volumio volumio[1270]: info: Disabling external Volume Control Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:38:07 volumio volumio[1270]: info: CoreStateMachine::pushState Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Jul 17 20:38:07 volumio systemd[1]: Starting Music Player Daemon... Jul 17 20:38:07 volumio volumio[1270]: info: MPD Permissions set Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:07 volumio sudo[2124]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 17 20:38:07 volumio sudo[2124]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:07 volumio sudo[2124]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:38:07 volumio volumio[1270]: info: Getting Alsa Cards List without I2S DAC Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 17 20:38:07 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:08 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:08 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:08 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:08 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:08 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:08 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:08 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:08 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 20:38:08 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 20:38:08 volumio volumio[1270]: info: Starting Shairport Sync Jul 17 20:38:08 volumio sudo[2141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 20:38:08 volumio sudo[2141]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 20:38:08 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 17 20:38:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 17 20:38:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 20:38:08 volumio sudo[2141]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:08 volumio volumio[1270]: info: Shairport-Sync Started Jul 17 20:38:08 volumio mpd[2133]: Jul 17 20:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 17 20:38:08 volumio systemd[1]: Started Music Player Daemon. Jul 17 20:38:08 volumio sudo[2118]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:08 volumio volumio[1270]: error: updateQueue error: null Jul 17 20:38:08 volumio volumio[1270]: error: Upnp client error: Error: This socket has been ended by the other party Jul 17 20:38:12 volumio volumio[1270]: info: VolumeController::SetAlsaVolume100 Jul 17 20:38:12 volumio volumio[1270]: info: CoreStateMachine::pushState Jul 17 20:38:12 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:38:12 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Jul 17 20:38:14 volumio volumio[1270]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Jul 17 20:38:14 volumio volumio[1270]: info: Restoring Previous Volume level: 100 false true Jul 17 20:38:14 volumio volumio[1270]: info: VolumeController::SetAlsaVolume100 Jul 17 20:38:14 volumio volumio[1270]: info: Enable softmixer device for audio device number 0 Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::volumioStop Jul 17 20:38:14 volumio volumio[1270]: info: CoreStateMachine::stop Jul 17 20:38:14 volumio volumio[1270]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:38:14 volumio volumio[1270]: info: CoreStateMachine::stPlaybackTimer Jul 17 20:38:14 volumio volumio[1270]: info: CoreStateMachine::updateTrackBlock Jul 17 20:38:14 volumio volumio[1270]: info: CorePlayQueue::getTrackBlock Jul 17 20:38:14 volumio volumio[1270]: info: CoreStateMachine::pushState Jul 17 20:38:14 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Jul 17 20:38:14 volumio volumio[1270]: info: CoreStateMachine::serviceStop Jul 17 20:38:14 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::serviceStop Jul 17 20:38:14 volumio volumio[1270]: info: [1752777494194] ControllerWebradio::stop Jul 17 20:38:14 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 20:38:14 volumio volumio[1270]: info: Enable softmixer device for audio device undefined Jul 17 20:38:14 volumio volumio[1270]: info: Output device has changed, restarting MPD Jul 17 20:38:14 volumio sudo[2160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 20:38:14 volumio sudo[2160]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:14 volumio volumio[1270]: info: Output device has changed, restarting Shairport Sync Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:14 volumio sudo[2160]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:14 volumio sudo[2163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 20:38:14 volumio sudo[2163]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:14 volumio systemd[1]: Stopping Music Player Daemon... Jul 17 20:38:14 volumio volumio[1270]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 20:38:14 volumio volumio[1270]: info: Volume configurations have been set Jul 17 20:38:14 volumio systemd[1]: mpd.service: Succeeded. Jul 17 20:38:14 volumio systemd[1]: Stopped Music Player Daemon. Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 20:38:14 volumio volumio[1270]: info: Updating Volume Controller Parameters: Device: 0 Name: JustBoom Digi Boards Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 17 20:38:14 volumio volumio[1270]: info: Disabling external Volume Control Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:38:14 volumio systemd[1]: Starting Music Player Daemon... Jul 17 20:38:14 volumio volumio[1270]: info: CoreStateMachine::pushState Jul 17 20:38:14 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Jul 17 20:38:14 volumio volumio[1270]: error: MPD error: Error: write EPIPE Jul 17 20:38:14 volumio volumio[1270]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Jul 17 20:38:14 volumio volumio[1270]: info: MPD Permissions set Jul 17 20:38:14 volumio volumio[1270]: info: Software Volume ALSA configuration written Jul 17 20:38:14 volumio volumio[1270]: info: Preparing to generate the ALSA configuration file Jul 17 20:38:14 volumio volumio[1270]: info: CoreStateMachine::pushState Jul 17 20:38:14 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:14 volumio sudo[2169]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:14 volumio sudo[2169]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:14 volumio sudo[2169]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:38:14 volumio volumio[1270]: info: Getting Alsa Cards List without I2S DAC Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 20:38:14 volumio volumio[1270]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 17 20:38:14 volumio volumio[1270]: info: Reading ALSA contributions from plugins. Jul 17 20:38:14 volumio volumio[1270]: info: Starting Shairport Sync Jul 17 20:38:14 volumio volumio[1270]: info: Asound.conf file written Jul 17 20:38:14 volumio sudo[2192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 20:38:14 volumio sudo[2192]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 20:38:14 volumio sudo[2195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 17 20:38:14 volumio sudo[2195]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:14 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 17 20:38:14 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 17 20:38:14 volumio sudo[2195]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 20:38:14 volumio sudo[2192]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:14 volumio volumio[1270]: info: Output device has changed, restarting MPD Jul 17 20:38:14 volumio sudo[2202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 20:38:14 volumio sudo[2202]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:14 volumio volumio[1270]: info: Output device has changed, restarting Shairport Sync Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:14 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:14 volumio sudo[2202]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:14 volumio sudo[2205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 20:38:14 volumio sudo[2205]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:14 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 17 20:38:14 volumio systemd[1]: mpd.service: Succeeded. Jul 17 20:38:14 volumio systemd[1]: Stopped Music Player Daemon. Jul 17 20:38:14 volumio volumio[1270]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 20:38:14 volumio systemd[1]: Starting Music Player Daemon... Jul 17 20:38:14 volumio sudo[2211]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 17 20:38:14 volumio sudo[2211]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:14 volumio sudo[2211]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:14 volumio mpd[2215]: Jul 17 20:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 17 20:38:14 volumio systemd[1]: Started Music Player Daemon. Jul 17 20:38:14 volumio sudo[2163]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:14 volumio sudo[2205]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:15 volumio volumio[1270]: Playing WAVE '/volumio/app/silence.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jul 17 20:38:15 volumio volumio[1270]: info: Output device has changed, restarting MPD Jul 17 20:38:15 volumio sudo[2235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 20:38:15 volumio sudo[2235]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:15 volumio volumio[1270]: info: Output device has changed, restarting Shairport Sync Jul 17 20:38:15 volumio sudo[2235]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:15 volumio sudo[2238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 20:38:15 volumio sudo[2238]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:15 volumio systemd[1]: Stopping Music Player Daemon... Jul 17 20:38:15 volumio volumio[1270]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 20:38:15 volumio systemd[1]: mpd.service: Succeeded. Jul 17 20:38:15 volumio systemd[1]: Stopped Music Player Daemon. Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 20:38:15 volumio volumio[1270]: info: Updating Volume Controller Parameters: Device: 0 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 17 20:38:15 volumio systemd[1]: Starting Music Player Daemon... Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 17 20:38:15 volumio volumio[1270]: info: Disabling external Volume Control Jul 17 20:38:15 volumio volumio[1270]: error: Upnp client error: Error: This socket has been ended by the other party Jul 17 20:38:15 volumio volumio[1270]: info: MPD Permissions set Jul 17 20:38:15 volumio volumio[1270]: info: MPD Permissions set Jul 17 20:38:15 volumio volumio[1270]: info: Shairport-Sync Started Jul 17 20:38:15 volumio volumio[1270]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jul 17 20:38:15 volumio volumio[1270]: info: CoreStateMachine::pushState Jul 17 20:38:15 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio sudo[2243]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 17 20:38:15 volumio sudo[2243]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:15 volumio sudo[2243]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:15 volumio volumio[1270]: info: Starting Shairport Sync Jul 17 20:38:15 volumio volumio[1270]: info: Starting Shairport Sync Jul 17 20:38:15 volumio sudo[2264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 20:38:15 volumio sudo[2264]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:15 volumio sudo[2267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 20:38:15 volumio sudo[2267]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:15 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 20:38:15 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 17 20:38:15 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 17 20:38:15 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 20:38:15 volumio sudo[2264]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:15 volumio volumio[1270]: info: Shairport-Sync Started Jul 17 20:38:15 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 20:38:15 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 17 20:38:15 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 17 20:38:15 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 17 20:38:15 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 20:38:15 volumio sudo[2267]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:15 volumio volumio[1270]: info: Shairport-Sync Started Jul 17 20:38:16 volumio mpd[2255]: Jul 17 20:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 17 20:38:16 volumio systemd[1]: Started Music Player Daemon. Jul 17 20:38:16 volumio sudo[2238]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:16 volumio volumio[1270]: error: MPD error: The expression evaluated to a falsy value: Jul 17 20:38:16 volumio volumio[1270]: assert.ok(self.idling) Jul 17 20:38:16 volumio volumio[1270]: error: The expression evaluated to a falsy value: Jul 17 20:38:16 volumio volumio[1270]: assert.ok(self.idling) Jul 17 20:38:16 volumio volumio[1270]: error: updateQueue error: null Jul 17 20:38:16 volumio volumio[1270]: error: updateQueue error: null Jul 17 20:38:17 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Jul 17 20:38:17 volumio sudo[2278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 20:38:17 volumio sudo[2278]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:17 volumio systemd[1]: Stopping Music Player Daemon... Jul 17 20:38:17 volumio systemd[1]: mpd.service: Succeeded. Jul 17 20:38:17 volumio systemd[1]: Stopped Music Player Daemon. Jul 17 20:38:17 volumio systemd[1]: Starting Music Player Daemon... Jul 17 20:38:17 volumio sudo[2280]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 17 20:38:17 volumio sudo[2280]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:38:17 volumio sudo[2280]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:17 volumio mpd[2282]: Jul 17 20:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 17 20:38:17 volumio systemd[1]: Started Music Player Daemon. Jul 17 20:38:17 volumio sudo[2278]: pam_unix(sudo:session): session closed for user root Jul 17 20:38:17 volumio volumio[1270]: error: updateQueue error: null Jul 17 20:38:17 volumio volumio[1270]: error: Upnp client error: Error: This socket has been ended by the other party Jul 17 20:38:18 volumio volumio[1270]: info: VolumeController::SetAlsaVolume100 Jul 17 20:38:18 volumio volumio[1270]: info: CoreStateMachine::pushState Jul 17 20:38:18 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:38:18 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:38:18 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Jul 17 20:38:19 volumio ntpd[992]: Soliciting pool server 162.159.200.123 Jul 17 20:38:19 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:38:20 volumio ntpd[992]: Soliciting pool server 185.51.192.62 Jul 17 20:38:22 volumio ntpd[992]: Soliciting pool server 178.239.19.63 Jul 17 20:38:25 volumio ntpd[992]: Soliciting pool server 144.21.38.190 Jul 17 20:38:26 volumio ntpd[992]: Soliciting pool server 185.51.192.63 Jul 17 20:38:27 volumio ntpd[992]: Soliciting pool server 77.175.129.186 Jul 17 20:38:28 volumio ntpd[992]: Soliciting pool server 209.250.249.159 Jul 17 20:38:36 volumio ntpd[992]: receive: Unexpected origin timestamp 0xec23c1ab.2cea22be does not match aorg 0000000000.00000000 from server@185.51.192.63 xmt 0xec23c1ac.57b38682 Jul 17 20:38:52 volumio volumio[1270]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Jul 17 20:38:52 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Jul 17 20:38:52 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Jul 17 20:38:52 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:38:52 volumio volumio[1270]: info: Restoring Previous Volume level: 100 false true Jul 17 20:38:52 volumio volumio[1270]: info: VolumeController::SetAlsaVolume100 Jul 17 20:38:52 volumio volumio[1270]: info: Volume configurations have been set Jul 17 20:38:52 volumio volumio[1270]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 20:38:52 volumio volumio[1270]: info: Updating Volume Controller Parameters: Device: 0 Name: softvolume Mixer: SoftMaster Max Vol: 50 Vol Curve; logarithmic Vol Steps: 4 Jul 17 20:38:52 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 17 20:38:52 volumio volumio[1270]: info: Disabling external Volume Control Jul 17 20:38:52 volumio volumio[1270]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:38:52 volumio volumio[1270]: info: CoreStateMachine::pushState Jul 17 20:38:52 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:38:52 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Jul 17 20:38:52 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 20:38:52 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:52 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:38:52 volumio volumio[1270]: info: Getting Alsa Cards List without I2S DAC Jul 17 20:38:52 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 17 20:38:52 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:38:53 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:53 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:53 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:53 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:53 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:53 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:53 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:38:53 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 20:38:53 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 20:38:53 volumio volumio[1270]: info: CoreStateMachine::pushState Jul 17 20:38:53 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:38:53 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:38:53 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Jul 17 20:38:57 volumio volumio[1270]: info: VolumeController::SetAlsaVolume100 Jul 17 20:38:57 volumio volumio[1270]: info: CoreStateMachine::pushState Jul 17 20:38:57 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:38:57 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:38:57 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Jul 17 20:39:21 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jul 17 20:39:21 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jul 17 20:39:21 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jul 17 20:39:21 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jul 17 20:39:21 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jul 17 20:39:21 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Jul 17 20:39:21 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:39:21 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 20:39:21 volumio volumio[1270]: info: Listing playlists Jul 17 20:39:21 volumio volumio[1270]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Jul 17 20:39:21 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Jul 17 20:39:21 volumio sudo[2560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 20:39:21 volumio sudo[2560]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:39:21 volumio sudo[2560]: pam_unix(sudo:session): session closed for user root Jul 17 20:39:21 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:39:21 volumio sudo[2563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 20:39:21 volumio sudo[2563]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:39:21 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:39:21 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:39:21 volumio systemd[1]: Stopping Music Player Daemon... Jul 17 20:39:21 volumio volumio[1270]: info: MPD Permissions set Jul 17 20:39:21 volumio systemd[1]: mpd.service: Succeeded. Jul 17 20:39:21 volumio systemd[1]: Stopped Music Player Daemon. Jul 17 20:39:21 volumio systemd[1]: Starting Music Player Daemon... Jul 17 20:39:21 volumio sudo[2569]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 17 20:39:21 volumio sudo[2569]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:39:21 volumio sudo[2569]: pam_unix(sudo:session): session closed for user root Jul 17 20:39:21 volumio mpd[2571]: Jul 17 20:39 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 17 20:39:21 volumio systemd[1]: Started Music Player Daemon. Jul 17 20:39:21 volumio sudo[2563]: pam_unix(sudo:session): session closed for user root Jul 17 20:39:21 volumio volumio[1270]: error: updateQueue error: null Jul 17 20:39:21 volumio volumio[1270]: error: Upnp client error: Error: This socket has been ended by the other party Jul 17 20:39:24 volumio ntpd[992]: Soliciting pool server 185.45.112.121 Jul 17 20:39:24 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 15; SM-A566B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jul 17 20:39:24 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 15; SM-A566B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jul 17 20:39:24 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 15; SM-A566B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jul 17 20:39:24 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 15; SM-A566B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Jul 17 20:39:24 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Jul 17 20:39:24 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:39:24 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 20:39:24 volumio volumio[1270]: info: Listing playlists Jul 17 20:39:24 volumio volumio[1270]: info: CoreCommandRouter::volumioGetQueue Jul 17 20:39:24 volumio volumio[1270]: info: CoreStateMachine::getQueue Jul 17 20:39:24 volumio volumio[1270]: info: CorePlayQueue::getQueue Jul 17 20:39:25 volumio ntpd[992]: Soliciting pool server 185.71.60.123 Jul 17 20:39:25 volumio ntpd[992]: Soliciting pool server 5.200.6.34 Jul 17 20:39:30 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jul 17 20:39:30 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Jul 17 20:39:30 volumio volumio[1270]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 15; SM-A566B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Jul 17 20:39:31 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Jul 17 20:39:31 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:39:31 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Jul 17 20:39:31 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Jul 17 20:39:31 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 20:39:31 volumio volumio[1270]: info: Listing playlists Jul 17 20:39:31 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 20:39:31 volumio volumio[1270]: info: Listing playlists Jul 17 20:39:31 volumio volumio[1270]: info: CoreCommandRouter::volumioGetQueue Jul 17 20:39:31 volumio volumio[1270]: info: CoreStateMachine::getQueue Jul 17 20:39:31 volumio volumio[1270]: info: CorePlayQueue::getQueue Jul 17 20:39:40 volumio volumio[1270]: info: CoreCommandRouter::volumioGetVisibleSources Jul 17 20:39:40 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 20:39:40 volumio volumio[1270]: info: CoreCommandRouter::volumioGetQueue Jul 17 20:39:40 volumio volumio[1270]: info: CoreStateMachine::getQueue Jul 17 20:39:40 volumio volumio[1270]: info: CorePlayQueue::getQueue Jul 17 20:39:42 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 17 20:39:42 volumio volumio[1270]: info: Preload queue cleared Jul 17 20:39:44 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 17 20:39:44 volumio volumio[1270]: info: Preload queue cleared Jul 17 20:39:45 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 17 20:39:45 volumio volumio[1270]: info: Preload queue cleared Jul 17 20:39:46 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 17 20:39:46 volumio volumio[1270]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 20:39:46 volumio volumio[1270]: TypeError: Cannot read property 'length' of undefined Jul 17 20:39:46 volumio volumio[1270]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jul 17 20:39:46 volumio volumio[1270]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jul 17 20:39:46 volumio volumio[1270]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jul 17 20:39:46 volumio volumio[1270]: at Parser.emit (events.js:315:20) Jul 17 20:39:46 volumio volumio[1270]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jul 17 20:39:46 volumio volumio[1270]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jul 17 20:39:46 volumio volumio[1270]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jul 17 20:39:46 volumio volumio[1270]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jul 17 20:39:46 volumio volumio[1270]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jul 17 20:39:46 volumio volumio[1270]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jul 17 20:39:46 volumio volumio[1270]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jul 17 20:39:46 volumio volumio[1270]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jul 17 20:39:46 volumio volumio[1270]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jul 17 20:39:46 volumio volumio[1270]: at IncomingMessage.emit (events.js:327:22) Jul 17 20:39:46 volumio volumio[1270]: at endReadableNT (internal/streams/readable.js:1327:12) Jul 17 20:39:46 volumio volumio[1270]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 17 20:39:46 volumio volumio[1270]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 20:39:47 volumio sudo[2677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-17 20:38 Jul 17 20:39:47 volumio sudo[2677]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"