-- Logs begin at Wed 2024-09-18 00:47:06 JST, end at Thu 2024-10-03 23:52:10 JST. -- Oct 03 23:51:00 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:00 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:00 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:00 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:00 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:00 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:00 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:00 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:03 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:03 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:03 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:03 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:03 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:03 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:06 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:06 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:06 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:06 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:06 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:06 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:06 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:06 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:09 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:09 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:09 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:09 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:09 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:09 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:09 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:09 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 03 23:51:10 rivo volumio[3368]: info: Retrieving Cloud Streaming UI Oct 03 23:51:10 rivo volumio[3368]: info: Getting Tidal Cloud Configuration Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 03 23:51:10 rivo volumio[3368]: info: Getting Qobuz Cloud Configuration Oct 03 23:51:10 rivo volumio[3368]: info: Asking plugin for UI Config Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 03 23:51:10 rivo volumio[3368]: info: Getting Spotify Cloud Configuration Oct 03 23:51:10 rivo volumio[3368]: info: Asking plugin for UI Config Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 03 23:51:10 rivo volumio[3368]: info: Saving Spotify Acccount Oct 03 23:51:10 rivo volumio[3368]: info: Got it Oct 03 23:51:10 rivo volumio[3368]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 03 23:51:10 rivo volumio[3368]: info: Got Tidal Cloud Configuration Oct 03 23:51:10 rivo volumio[3368]: info: Got it Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::volumioGetBrowseSources Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::volumioGetBrowseSources Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::volumioGetBrowseSources Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:10 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 03 23:51:12 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:12 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:12 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:12 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:12 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:12 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:12 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:12 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:14 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:15 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:15 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:15 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:15 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:15 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:15 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:15 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:15 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:18 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:18 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:18 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:18 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:18 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:18 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:18 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:18 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:18 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:21 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:21 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:21 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:21 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:21 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:21 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:21 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:21 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:22 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:24 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:24 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:24 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:24 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:24 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:24 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:24 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:24 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:24 rivo volumio[3368]: info: Disabling MyMusic plugin multiroom Oct 03 23:51:24 rivo volumio[3368]: info: Disabling plugin multiroom Oct 03 23:51:24 rivo volumio[3368]: info: Preparing to generate the ALSA configuration file Oct 03 23:51:24 rivo volumio[3368]: info: Asound.conf file written Oct 03 23:51:24 rivo sudo[4960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 03 23:51:24 rivo sudo[4960]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:24 rivo sudo[4960]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:24 rivo volumio[3368]: No state is present for card AMLAUGESOUNDMP1 Oct 03 23:51:24 rivo volumio[3368]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Oct 03 23:51:24 rivo volumio[3368]: Hardware is initialized using a generic method Oct 03 23:51:24 rivo volumio[3368]: No state is present for card AMLAUGESOUNDMP1 Oct 03 23:51:24 rivo volumio[3368]: No state is present for card USB Oct 03 23:51:24 rivo volumio[3368]: Found hardware: "USB-Audio" "USB Mixer" "USB34e0:0006" "" "" Oct 03 23:51:24 rivo volumio[3368]: Hardware is initialized using a generic method Oct 03 23:51:24 rivo volumio[3368]: No state is present for card USB Oct 03 23:51:24 rivo volumio[3368]: info: Output device has changed, restarting MPD Oct 03 23:51:24 rivo sudo[4965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 03 23:51:24 rivo sudo[4965]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:24 rivo volumio[3368]: info: Output device has changed, restarting Shairport Sync Oct 03 23:51:24 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:24 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:24 rivo sudo[4965]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:24 rivo sudo[4968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 03 23:51:24 rivo sudo[4968]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:24 rivo systemd[1]: Stopping Music Player Daemon... Oct 03 23:51:24 rivo volumio[3368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 03 23:51:24 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:24 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:24 rivo systemd[1]: mpd.service: Succeeded. Oct 03 23:51:24 rivo systemd[1]: Stopped Music Player Daemon. Oct 03 23:51:24 rivo systemd[1]: Starting Music Player Daemon... Oct 03 23:51:24 rivo volumio[3368]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 03 23:51:24 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:24 rivo volumio[3368]: info: Done. Oct 03 23:51:25 rivo volumio[3368]: info: MPD Permissions set Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Oct 03 23:51:25 rivo volumio[3368]: info: Starting Shairport Sync Oct 03 23:51:25 rivo volumio[3368]: info: Preparing to generate the ALSA configuration file Oct 03 23:51:25 rivo sudo[4991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 03 23:51:25 rivo sudo[4991]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:25 rivo volumio[3368]: info: Asound.conf file unchanged, so no further update is needed Oct 03 23:51:25 rivo volumio[3368]: info: Output device has changed, restarting MPD Oct 03 23:51:25 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 03 23:51:25 rivo systemd[1]: shairport-sync.service: Succeeded. Oct 03 23:51:25 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:25 rivo sudo[4974]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 03 23:51:25 rivo sudo[4974]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:25 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:25 rivo sudo[4991]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:25 rivo sudo[4974]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:25 rivo sudo[4994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 03 23:51:25 rivo sudo[4994]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:25 rivo volumio[3368]: info: Output device has changed, restarting Shairport Sync Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:25 rivo sudo[4994]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:25 rivo sudo[4999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 03 23:51:25 rivo sudo[4999]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:25 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:25 rivo systemd[1]: mpd.service: Succeeded. Oct 03 23:51:25 rivo systemd[1]: Stopped Music Player Daemon. Oct 03 23:51:25 rivo volumio[3368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 03 23:51:25 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo systemd[1]: Starting Music Player Daemon... Oct 03 23:51:25 rivo volumio[3368]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: MPD Permissions set Oct 03 23:51:25 rivo volumio[3368]: info: Shairport-Sync Started Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Oct 03 23:51:25 rivo volumio[3368]: info: Starting Shairport Sync Oct 03 23:51:25 rivo sudo[5020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 03 23:51:25 rivo sudo[5020]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:25 rivo sudo[5009]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 03 23:51:25 rivo sudo[5009]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:25 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 03 23:51:25 rivo systemd[1]: shairport-sync.service: Succeeded. Oct 03 23:51:25 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:25 rivo sudo[5009]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: Not Reporting Auto name since its the default one Oct 03 23:51:25 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 03 23:51:25 rivo sudo[5020]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:25 rivo volumio[3368]: info: Shairport-Sync Started Oct 03 23:51:25 rivo sudo[5036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 03 23:51:25 rivo sudo[5036]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:25 rivo sudo[5036]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:25 rivo sudo[5038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 03 23:51:25 rivo sudo[5038]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:25 rivo systemd[1]: Stopping RAAT DAEMON... Oct 03 23:51:25 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:25 rivo systemd[1]: raat-daemon.service: Succeeded. Oct 03 23:51:25 rivo systemd[1]: Stopped RAAT DAEMON. Oct 03 23:51:25 rivo systemd[1]: Started RAAT DAEMON. Oct 03 23:51:25 rivo sudo[5038]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:25 rivo volumio[3368]: info: Raat Daemon started successfully Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:25 rivo volumio[3368]: info: Not Reporting Auto name since its the default one Oct 03 23:51:25 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 03 23:51:26 rivo volumio[3368]: info: Executing endpoint restartRAATSocket Oct 03 23:51:26 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 03 23:51:26 rivo sudo[5057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 03 23:51:26 rivo sudo[5057]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:26 rivo volumio[3368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 03 23:51:26 rivo sudo[5057]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:26 rivo sudo[5060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 03 23:51:26 rivo sudo[5060]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:26 rivo systemd[1]: Stopping RAAT DAEMON... Oct 03 23:51:26 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:26 rivo systemd[1]: raat-daemon.service: Succeeded. Oct 03 23:51:26 rivo systemd[1]: Stopped RAAT DAEMON. Oct 03 23:51:26 rivo systemd[1]: Started RAAT DAEMON. Oct 03 23:51:26 rivo sudo[5060]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:26 rivo volumio[3368]: info: Raat Daemon started successfully Oct 03 23:51:26 rivo volumio[3368]: info: Executing endpoint restartRAATSocket Oct 03 23:51:26 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 03 23:51:26 rivo volumio[3368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 03 23:51:26 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:26 rivo volumio[3368]: error: MPD error: Error: This socket has been ended by the other party Oct 03 23:51:26 rivo volumio[3368]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 03 23:51:26 rivo volumio[3368]: error: MPD error: Error: This socket has been ended by the other party Oct 03 23:51:26 rivo volumio[3368]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 03 23:51:26 rivo volumio[3368]: error: MPD error: Error: This socket has been ended by the other party Oct 03 23:51:26 rivo volumio[3368]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 03 23:51:27 rivo mpd[5029]: Oct 03 23:51 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 03 23:51:27 rivo systemd[1]: Started Music Player Daemon. Oct 03 23:51:27 rivo sudo[4968]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:27 rivo sudo[4999]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:27 rivo volumio[3368]: error: MPD error: The expression evaluated to a falsy value: Oct 03 23:51:27 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:27 rivo volumio[3368]: error: The expression evaluated to a falsy value: Oct 03 23:51:27 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:27 rivo volumio[3368]: error: updateQueue error: null Oct 03 23:51:28 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:28 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:28 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:28 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:28 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:28 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:28 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:28 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:28 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:28 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:28 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:28 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:28 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:28 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:28 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:28 rivo volumio[3368]: info: MCU Signalled Playback Inactive Oct 03 23:51:30 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:34 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:36 rivo volumio[3368]: info: Enabling MyMusic plugin multiroom Oct 03 23:51:36 rivo volumio[3368]: info: Enabling plugin multiroom Oct 03 23:51:36 rivo volumio[3368]: info: Loading plugin "multiroom"... Oct 03 23:51:36 rivo volumio[3368]: info: Applying required configuration parameters for plugin multiroom Oct 03 23:51:36 rivo sudo[5079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Oct 03 23:51:36 rivo sudo[5079]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:36 rivo sudo[5079]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:36 rivo volumio[3368]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Oct 03 23:51:36 rivo volumio[3368]: info: MRS: MultiRoom plugin initialized Oct 03 23:51:36 rivo volumio[3368]: info: MRS: STOPPING SNAPCLIENT Oct 03 23:51:36 rivo volumio[3368]: info: MRS: Snap server stop Oct 03 23:51:36 rivo volumio[3368]: info: MRS: STOPPING volumioStreaming Oct 03 23:51:36 rivo sudo[5095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Oct 03 23:51:36 rivo sudo[5095]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:36 rivo sudo[5097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Oct 03 23:51:36 rivo sudo[5097]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:36 rivo sudo[5101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Oct 03 23:51:36 rivo sudo[5101]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:36 rivo volumio[3368]: info: Preparing to generate the ALSA configuration file Oct 03 23:51:36 rivo sudo[5095]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:36 rivo sudo[5103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Oct 03 23:51:36 rivo sudo[5103]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:36 rivo sudo[5103]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:36 rivo volumio[3368]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 03 23:51:36 rivo volumio[3368]: info: Reading ALSA contributions from plugins. Oct 03 23:51:36 rivo volumio[3368]: info: MRS: Removed streaming files Oct 03 23:51:36 rivo volumio[3368]: info: MRS: SNAPCLIENT STOPPED Oct 03 23:51:36 rivo volumio[3368]: info: Asound.conf file written Oct 03 23:51:36 rivo sudo[5097]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:36 rivo sudo[5101]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:36 rivo sudo[5109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 03 23:51:36 rivo sudo[5109]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:36 rivo sudo[5109]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:36 rivo volumio[3368]: No state is present for card AMLAUGESOUNDMP1 Oct 03 23:51:36 rivo volumio[3368]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Oct 03 23:51:36 rivo volumio[3368]: Hardware is initialized using a generic method Oct 03 23:51:36 rivo volumio[3368]: No state is present for card AMLAUGESOUNDMP1 Oct 03 23:51:36 rivo volumio[3368]: No state is present for card USB Oct 03 23:51:36 rivo volumio[3368]: Found hardware: "USB-Audio" "USB Mixer" "USB34e0:0006" "" "" Oct 03 23:51:36 rivo volumio[3368]: Hardware is initialized using a generic method Oct 03 23:51:36 rivo volumio[3368]: No state is present for card USB Oct 03 23:51:36 rivo volumio[3368]: info: Output device has changed, restarting MPD Oct 03 23:51:36 rivo sudo[5114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 03 23:51:36 rivo sudo[5114]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:36 rivo volumio[3368]: info: Output device has changed, restarting Shairport Sync Oct 03 23:51:36 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:36 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:36 rivo sudo[5114]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:36 rivo sudo[5117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 03 23:51:36 rivo sudo[5117]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:36 rivo systemd[1]: Stopping Music Player Daemon... Oct 03 23:51:36 rivo volumio[3368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 03 23:51:36 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:36 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:36 rivo volumio[3368]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 03 23:51:36 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:36 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:36 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:36 rivo systemd[1]: mpd.service: Succeeded. Oct 03 23:51:36 rivo systemd[1]: Stopped Music Player Daemon. Oct 03 23:51:36 rivo systemd[1]: Starting Music Player Daemon... Oct 03 23:51:36 rivo volumio[3368]: info: PLUGIN START: multiroom Oct 03 23:51:36 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Oct 03 23:51:36 rivo volumio[3368]: info: MRS: Pushing multiroomSync output for this device Oct 03 23:51:36 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:36 rivo volumio[3368]: info: Adding audio output: Oct 03 23:51:36 rivo volumio[3368]: error: Can't add: Oct 03 23:51:36 rivo volumio[3368]: info: Adding audio output: Oct 03 23:51:36 rivo volumio[3368]: error: Can't add: Oct 03 23:51:36 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:36 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:36 rivo volumio[3368]: info: MPD Permissions set Oct 03 23:51:37 rivo volumio[3368]: info: MRS: volumioStreaming STOPPED Oct 03 23:51:37 rivo volumio[3368]: info: MRS: SNAPSERVER STOPPED Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 03 23:51:37 rivo sudo[5126]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 03 23:51:37 rivo sudo[5126]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:37 rivo sudo[5126]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: Starting Shairport Sync Oct 03 23:51:37 rivo volumio[3368]: info: Preparing to generate the ALSA configuration file Oct 03 23:51:37 rivo sudo[5151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 03 23:51:37 rivo sudo[5151]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:37 rivo volumio[3368]: info: Done. Oct 03 23:51:37 rivo volumio[3368]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 03 23:51:37 rivo volumio[3368]: info: Reading ALSA contributions from plugins. Oct 03 23:51:37 rivo volumio[3368]: info: MRS: Found cast device: TEAC-WS-A70-44bce05201468c3e59978c4cc3bfe9bf Oct 03 23:51:37 rivo volumio[3368]: info: Adding audio output: Oct 03 23:51:37 rivo volumio[3368]: error: Can't add: Oct 03 23:51:37 rivo volumio[3368]: info: MRS: Found cast device: H600-22db6429d31bbe0274b360d0f4bda2b6 Oct 03 23:51:37 rivo volumio[3368]: info: Adding audio output: Oct 03 23:51:37 rivo volumio[3368]: error: Can't add: Oct 03 23:51:37 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 03 23:51:37 rivo systemd[1]: shairport-sync.service: Succeeded. Oct 03 23:51:37 rivo volumio[3368]: info: Asound.conf file unchanged, so no further update is needed Oct 03 23:51:37 rivo volumio[3368]: info: Output device has changed, restarting MPD Oct 03 23:51:37 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:37 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:37 rivo sudo[5151]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:37 rivo sudo[5155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 03 23:51:37 rivo sudo[5155]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:37 rivo volumio[3368]: info: Output device has changed, restarting Shairport Sync Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:37 rivo sudo[5155]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:37 rivo sudo[5158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 03 23:51:37 rivo sudo[5158]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:37 rivo volumio[3368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 03 23:51:37 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:37 rivo systemd[1]: mpd.service: Succeeded. Oct 03 23:51:37 rivo systemd[1]: Stopped Music Player Daemon. Oct 03 23:51:37 rivo systemd[1]: Starting Music Player Daemon... Oct 03 23:51:37 rivo volumio[3368]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: Preparing to generate the ALSA configuration file Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: Not Reporting Auto name since its the default one Oct 03 23:51:37 rivo volumio[3368]: info: MRS: Found cast device: H600-22db6429d31bbe0274b360d0f4bda2b6 Oct 03 23:51:37 rivo volumio[3368]: info: MRS: Found cast device: TEAC-WS-A70-44bce05201468c3e59978c4cc3bfe9bf Oct 03 23:51:37 rivo volumio[3368]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 03 23:51:37 rivo volumio[3368]: info: Reading ALSA contributions from plugins. Oct 03 23:51:37 rivo volumio[3368]: info: MPD Permissions set Oct 03 23:51:37 rivo volumio[3368]: info: Shairport-Sync Started Oct 03 23:51:37 rivo sudo[5166]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo sudo[5166]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo sudo[5166]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 03 23:51:37 rivo volumio[3368]: info: Starting Shairport Sync Oct 03 23:51:37 rivo sudo[5187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 03 23:51:37 rivo sudo[5187]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:37 rivo volumio[3368]: info: Asound.conf file unchanged, so no further update is needed Oct 03 23:51:37 rivo volumio[3368]: info: Output device has changed, restarting MPD Oct 03 23:51:37 rivo sudo[5187]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:37 rivo sudo[5190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 03 23:51:37 rivo sudo[5190]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:37 rivo sudo[5192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 03 23:51:37 rivo sudo[5192]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:37 rivo volumio[3368]: info: Output device has changed, restarting Shairport Sync Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:37 rivo sudo[5194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 03 23:51:37 rivo sudo[5194]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:37 rivo systemd[1]: Stopping RAAT DAEMON... Oct 03 23:51:37 rivo sudo[5194]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:37 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 03 23:51:37 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:37 rivo systemd[1]: raat-daemon.service: Succeeded. Oct 03 23:51:37 rivo systemd[1]: Stopped RAAT DAEMON. Oct 03 23:51:37 rivo systemd[1]: shairport-sync.service: Succeeded. Oct 03 23:51:37 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:37 rivo sudo[5197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 03 23:51:37 rivo sudo[5197]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:37 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:37 rivo volumio[3368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 03 23:51:37 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:37 rivo sudo[5190]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo systemd[1]: Started RAAT DAEMON. Oct 03 23:51:37 rivo sudo[5192]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:37 rivo volumio[3368]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:37 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:37 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: Preparing to generate the ALSA configuration file Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: Not Reporting Auto name since its the default one Oct 03 23:51:38 rivo volumio[3368]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 03 23:51:38 rivo volumio[3368]: info: Reading ALSA contributions from plugins. Oct 03 23:51:38 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:38 rivo systemd[1]: mpd.service: Succeeded. Oct 03 23:51:38 rivo systemd[1]: Stopped Music Player Daemon. Oct 03 23:51:38 rivo volumio[3368]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Oct 03 23:51:38 rivo volumio[3368]: info: MPD Permissions set Oct 03 23:51:38 rivo volumio[3368]: info: Raat Daemon started successfully Oct 03 23:51:38 rivo volumio[3368]: info: Shairport-Sync Started Oct 03 23:51:38 rivo systemd[1]: Starting Music Player Daemon... Oct 03 23:51:38 rivo volumio[3368]: info: Executing endpoint restartRAATSocket Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 03 23:51:38 rivo sudo[5225]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 03 23:51:38 rivo sudo[5225]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:38 rivo sudo[5225]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:38 rivo volumio[3368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 03 23:51:38 rivo sudo[5239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 03 23:51:38 rivo volumio[3368]: info: Starting Shairport Sync Oct 03 23:51:38 rivo sudo[5239]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:38 rivo sudo[5239]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:38 rivo volumio[3368]: info: Asound.conf file unchanged, so no further update is needed Oct 03 23:51:38 rivo volumio[3368]: info: Output device has changed, restarting MPD Oct 03 23:51:38 rivo sudo[5242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 03 23:51:38 rivo sudo[5242]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:38 rivo sudo[5243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 03 23:51:38 rivo sudo[5243]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:38 rivo volumio[3368]: info: Output device has changed, restarting Shairport Sync Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:38 rivo systemd[1]: Stopping RAAT DAEMON... Oct 03 23:51:38 rivo sudo[5247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 03 23:51:38 rivo sudo[5247]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:38 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 03 23:51:38 rivo systemd[1]: shairport-sync.service: Succeeded. Oct 03 23:51:38 rivo sudo[5247]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:38 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:38 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:38 rivo systemd[1]: raat-daemon.service: Succeeded. Oct 03 23:51:38 rivo systemd[1]: Stopped RAAT DAEMON. Oct 03 23:51:38 rivo systemd[1]: Started RAAT DAEMON. Oct 03 23:51:38 rivo sudo[5249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 03 23:51:38 rivo sudo[5243]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:38 rivo volumio[3368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 03 23:51:38 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo sudo[5249]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:38 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:38 rivo volumio[3368]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo sudo[5242]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:38 rivo volumio[3368]: info: Preparing to generate the ALSA configuration file Oct 03 23:51:38 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:38 rivo systemd[1]: mpd.service: Succeeded. Oct 03 23:51:38 rivo systemd[1]: Stopped Music Player Daemon. Oct 03 23:51:38 rivo systemd[1]: Starting Music Player Daemon... Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: Not Reporting Auto name since its the default one Oct 03 23:51:38 rivo volumio[3368]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 03 23:51:38 rivo volumio[3368]: info: Reading ALSA contributions from plugins. Oct 03 23:51:38 rivo volumio[3368]: info: Executing endpoint restartRAATSocket Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 03 23:51:38 rivo volumio[3368]: info: MPD Permissions set Oct 03 23:51:38 rivo volumio[3368]: info: Shairport-Sync Started Oct 03 23:51:38 rivo volumio[3368]: (node:3368) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 03 23:51:38 rivo volumio[3368]: (node:3368) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 03 23:51:38 rivo volumio[3368]: (node:3368) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 03 23:51:38 rivo volumio[3368]: (node:3368) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 03 23:51:38 rivo volumio[3368]: (node:3368) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 03 23:51:38 rivo volumio[3368]: info: Raat Daemon started successfully Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 03 23:51:38 rivo sudo[5275]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 03 23:51:38 rivo sudo[5275]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:38 rivo sudo[5275]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:38 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:38 rivo volumio[3368]: error: MPD error: Error: This socket has been ended by the other party Oct 03 23:51:38 rivo volumio[3368]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 03 23:51:38 rivo volumio[3368]: error: MPD error: Error: This socket has been ended by the other party Oct 03 23:51:38 rivo volumio[3368]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 03 23:51:38 rivo volumio[3368]: error: MPD error: Error: This socket has been ended by the other party Oct 03 23:51:38 rivo volumio[3368]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 03 23:51:38 rivo volumio[3368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 03 23:51:38 rivo sudo[5291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 03 23:51:38 rivo sudo[5291]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:38 rivo volumio[3368]: info: Starting Shairport Sync Oct 03 23:51:39 rivo sudo[5291]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:39 rivo volumio[3368]: info: Asound.conf file unchanged, so no further update is needed Oct 03 23:51:39 rivo volumio[3368]: info: Output device has changed, restarting MPD Oct 03 23:51:39 rivo sudo[5294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 03 23:51:39 rivo sudo[5294]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:39 rivo sudo[5296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 03 23:51:39 rivo sudo[5296]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:39 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 03 23:51:39 rivo systemd[1]: Stopping RAAT DAEMON... Oct 03 23:51:39 rivo sudo[5300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 03 23:51:39 rivo sudo[5300]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:39 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:39 rivo systemd[1]: raat-daemon.service: Succeeded. Oct 03 23:51:39 rivo systemd[1]: Stopped RAAT DAEMON. Oct 03 23:51:39 rivo volumio[3368]: info: Output device has changed, restarting Shairport Sync Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:39 rivo systemd[1]: shairport-sync.service: Succeeded. Oct 03 23:51:39 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:39 rivo sudo[5300]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:39 rivo sudo[5303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 03 23:51:39 rivo sudo[5303]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:39 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:39 rivo sudo[5296]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:39 rivo systemd[1]: Started RAAT DAEMON. Oct 03 23:51:39 rivo sudo[5294]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:39 rivo volumio[3368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 03 23:51:39 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:39 rivo systemd[1]: mpd.service: Succeeded. Oct 03 23:51:39 rivo systemd[1]: Stopped Music Player Daemon. Oct 03 23:51:39 rivo systemd[1]: Starting Music Player Daemon... Oct 03 23:51:39 rivo volumio[3368]: info: Preparing to generate the ALSA configuration file Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: Not Reporting Auto name since its the default one Oct 03 23:51:39 rivo volumio[3368]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 03 23:51:39 rivo volumio[3368]: info: Reading ALSA contributions from plugins. Oct 03 23:51:39 rivo volumio[3368]: info: MPD Permissions set Oct 03 23:51:39 rivo volumio[3368]: info: Raat Daemon started successfully Oct 03 23:51:39 rivo volumio[3368]: info: Shairport-Sync Started Oct 03 23:51:39 rivo volumio[3368]: info: Executing endpoint restartRAATSocket Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo sudo[5325]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 03 23:51:39 rivo sudo[5325]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:39 rivo sudo[5325]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 03 23:51:39 rivo volumio[3368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 03 23:51:39 rivo sudo[5345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 03 23:51:39 rivo sudo[5345]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:39 rivo volumio[3368]: info: Starting Shairport Sync Oct 03 23:51:39 rivo sudo[5345]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:39 rivo sudo[5348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 03 23:51:39 rivo sudo[5348]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:39 rivo volumio[3368]: info: Asound.conf file unchanged, so no further update is needed Oct 03 23:51:39 rivo volumio[3368]: info: Output device has changed, restarting MPD Oct 03 23:51:39 rivo sudo[5349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 03 23:51:39 rivo sudo[5349]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:39 rivo systemd[1]: Stopping RAAT DAEMON... Oct 03 23:51:39 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:39 rivo systemd[1]: raat-daemon.service: Succeeded. Oct 03 23:51:39 rivo systemd[1]: Stopped RAAT DAEMON. Oct 03 23:51:39 rivo volumio[3368]: info: Output device has changed, restarting Shairport Sync Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:39 rivo sudo[5353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 03 23:51:39 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 03 23:51:39 rivo sudo[5353]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:39 rivo sudo[5353]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:39 rivo systemd[1]: Started RAAT DAEMON. Oct 03 23:51:39 rivo sudo[5356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 03 23:51:39 rivo sudo[5356]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:39 rivo sudo[5348]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:39 rivo systemd[1]: shairport-sync.service: Succeeded. Oct 03 23:51:39 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:39 rivo volumio[3368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 03 23:51:39 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo volumio[3368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 03 23:51:39 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:39 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:39 rivo sudo[5349]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:40 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:40 rivo systemd[1]: mpd.service: Succeeded. Oct 03 23:51:40 rivo systemd[1]: Stopped Music Player Daemon. Oct 03 23:51:40 rivo systemd[1]: Starting Music Player Daemon... Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: Not Reporting Auto name since its the default one Oct 03 23:51:40 rivo volumio[3368]: info: Executing endpoint restartRAATSocket Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 03 23:51:40 rivo volumio[3368]: info: MPD Permissions set Oct 03 23:51:40 rivo volumio[3368]: info: Shairport-Sync Started Oct 03 23:51:40 rivo volumio[3368]: info: Raat Daemon started successfully Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 03 23:51:40 rivo sudo[5377]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 03 23:51:40 rivo sudo[5377]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:40 rivo sudo[5377]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:40 rivo volumio[3368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 03 23:51:40 rivo volumio[3368]: info: Starting Shairport Sync Oct 03 23:51:40 rivo sudo[5395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 03 23:51:40 rivo sudo[5395]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:40 rivo sudo[5395]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:40 rivo sudo[5398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 03 23:51:40 rivo sudo[5398]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:40 rivo sudo[5399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 03 23:51:40 rivo sudo[5399]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:40 rivo systemd[1]: Stopping RAAT DAEMON... Oct 03 23:51:40 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 03 23:51:40 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:40 rivo systemd[1]: raat-daemon.service: Succeeded. Oct 03 23:51:40 rivo systemd[1]: Stopped RAAT DAEMON. Oct 03 23:51:40 rivo systemd[1]: shairport-sync.service: Succeeded. Oct 03 23:51:40 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:40 rivo systemd[1]: shairport-sync.service: Start request repeated too quickly. Oct 03 23:51:40 rivo systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Oct 03 23:51:40 rivo systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Oct 03 23:51:40 rivo systemd[1]: Started RAAT DAEMON. Oct 03 23:51:40 rivo sudo[5399]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:40 rivo sudo[5398]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 23:51:40 rivo volumio[3368]: info: Not Reporting Auto name since its the default one Oct 03 23:51:40 rivo volumio[3368]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Oct 03 23:51:40 rivo volumio[3368]: Job for shairport-sync.service failed. Oct 03 23:51:40 rivo volumio[3368]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Oct 03 23:51:40 rivo volumio[3368]: info: Raat Daemon started successfully Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 03 23:51:40 rivo volumio[3368]: info: Executing endpoint restartRAATSocket Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 03 23:51:40 rivo sudo[5420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 03 23:51:40 rivo volumio[3368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 03 23:51:40 rivo sudo[5420]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:40 rivo sudo[5420]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:40 rivo sudo[5423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 03 23:51:40 rivo sudo[5423]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:40 rivo systemd[1]: Stopping RAAT DAEMON... Oct 03 23:51:40 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Oct 03 23:51:40 rivo systemd[1]: raat-daemon.service: Succeeded. Oct 03 23:51:40 rivo systemd[1]: Stopped RAAT DAEMON. Oct 03 23:51:40 rivo systemd[1]: Started RAAT DAEMON. Oct 03 23:51:40 rivo sudo[5423]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:40 rivo volumio[3368]: info: Raat Daemon started successfully Oct 03 23:51:40 rivo volumio[3368]: info: Executing endpoint restartRAATSocket Oct 03 23:51:40 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 03 23:51:40 rivo volumio[3368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 03 23:51:41 rivo volumio[3368]: info: MRS: Getting audio outputs on start Oct 03 23:51:41 rivo volumio[3368]: info: MRS: Requesting all other devices output Oct 03 23:51:42 rivo mpd[5393]: Oct 03 23:51 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 03 23:51:42 rivo systemd[1]: Started Music Player Daemon. Oct 03 23:51:42 rivo sudo[5356]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:42 rivo sudo[5117]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:42 rivo sudo[5249]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:42 rivo sudo[5158]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:42 rivo sudo[5303]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:42 rivo sudo[5197]: pam_unix(sudo:session): session closed for user root Oct 03 23:51:42 rivo volumio[3368]: error: MPD error: The expression evaluated to a falsy value: Oct 03 23:51:42 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:42 rivo volumio[3368]: error: The expression evaluated to a falsy value: Oct 03 23:51:42 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:42 rivo volumio[3368]: error: MPD error: The expression evaluated to a falsy value: Oct 03 23:51:42 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:42 rivo volumio[3368]: error: The expression evaluated to a falsy value: Oct 03 23:51:42 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:42 rivo volumio[3368]: error: MPD error: The expression evaluated to a falsy value: Oct 03 23:51:42 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:42 rivo volumio[3368]: error: The expression evaluated to a falsy value: Oct 03 23:51:42 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:42 rivo volumio[3368]: error: MPD error: The expression evaluated to a falsy value: Oct 03 23:51:42 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:42 rivo volumio[3368]: error: The expression evaluated to a falsy value: Oct 03 23:51:42 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:42 rivo volumio[3368]: error: MPD error: The expression evaluated to a falsy value: Oct 03 23:51:42 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:42 rivo volumio[3368]: error: The expression evaluated to a falsy value: Oct 03 23:51:42 rivo volumio[3368]: assert.ok(self.idling) Oct 03 23:51:42 rivo volumio[3368]: error: updateQueue error: null Oct 03 23:51:42 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:43 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:43 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:43 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:43 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:43 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:43 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:43 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:43 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:43 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:43 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:43 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:43 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:43 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:43 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:43 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:43 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:45 rivo volumio[3368]: info: [VRCP] preparing for control Oct 03 23:51:45 rivo volumio[3368]: info: RAAT Acquiring Control Oct 03 23:51:45 rivo volumio[3368]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 23:51:45 rivo volumio[3368]: info: CoreCommandRouter::volumioStop Oct 03 23:51:45 rivo volumio[3368]: info: CoreStateMachine::stop Oct 03 23:51:45 rivo volumio[3368]: info: CoreStateMachine::serviceStop Oct 03 23:51:45 rivo volumio[3368]: info: CoreCommandRouter::serviceStop Oct 03 23:51:45 rivo volumio[3368]: info: RAAT Control Acquired Oct 03 23:51:45 rivo volumio[3368]: info: [VRCP] prepared for control Oct 03 23:51:45 rivo volumio[3368]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 23:51:45 rivo volumio[3368]: info: [VRCP] acknowledged control Oct 03 23:51:45 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:45 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:45 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:45 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:45 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:45 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:45 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:45 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:45 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:45 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:45 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:45 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:45 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:45 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:45 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:45 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:45 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:46 rivo volumio[3368]: info: MCU Signalled Playback Active Oct 03 23:51:46 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:49 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:49 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:49 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:49 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:49 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:49 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:49 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:49 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:49 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:49 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:50 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:52 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:52 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:52 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:52 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:52 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:52 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:52 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:52 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:52 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:52 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:52 rivo volumio[3368]: info: Disabling MyMusic plugin upnp Oct 03 23:51:52 rivo sudo[5442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Oct 03 23:51:52 rivo sudo[5442]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 23:51:52 rivo systemd[1]: Stopping UPnP Renderer front-end to MPD... Oct 03 23:51:52 rivo volumio[3368]: error: Upnp client error: Error: This socket has been ended by the other party Oct 03 23:51:54 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:56 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:56 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:56 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:56 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:56 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:56 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:56 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:56 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:56 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:56 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:51:58 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:51:59 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:51:59 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:51:59 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:51:59 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:51:59 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:59 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:59 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:51:59 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:51:59 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:51:59 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:52:02 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:52:03 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:52:03 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:52:03 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:52:03 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:52:03 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:52:03 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:52:03 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:52:03 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:52:03 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:52:03 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:52:06 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 03 23:52:07 rivo volumio[3368]: info: CoreCommandRouter::servicePushState Oct 03 23:52:07 rivo volumio[3368]: info: CoreStateMachine::pushState Oct 03 23:52:07 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 23:52:07 rivo volumio[3368]: info: CoreCommandRouter::volumioPushState Oct 03 23:52:07 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:52:07 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:52:07 rivo volumio[3368]: info: MRS: Pushing multiroomSync output update for this device Oct 03 23:52:07 rivo volumio[3368]: info: MRS: Pushing multiroomSync output Oct 03 23:52:07 rivo volumio[3368]: info: Signalling Playback active due to playback status change Oct 03 23:52:07 rivo volumio[3368]: info: Updating RAAT Signal Path Oct 03 23:52:09 rivo volumio[3368]: info: Enabling MyMusic plugin upnp Oct 03 23:52:09 rivo volumio[3368]: info: Enabling plugin upnp Oct 03 23:52:09 rivo volumio[3368]: info: Loading plugin "upnp"... Oct 03 23:52:09 rivo volumio[3368]: info: [1727967129717] Starting Upmpd Daemon Oct 03 23:52:09 rivo volumio[3368]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 03 23:52:09 rivo volumio[3368]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 23:52:09 rivo volumio[3368]: Error: listen EADDRINUSE: address already in use :::6599 Oct 03 23:52:09 rivo volumio[3368]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Oct 03 23:52:09 rivo volumio[3368]: at listenInCluster (net.js:1379:12) Oct 03 23:52:09 rivo volumio[3368]: at Server.listen (net.js:1465:7) Oct 03 23:52:09 rivo volumio[3368]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Oct 03 23:52:09 rivo volumio[3368]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Oct 03 23:52:09 rivo volumio[3368]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 03 23:52:09 rivo volumio[3368]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 03 23:52:09 rivo volumio[3368]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Oct 03 23:52:09 rivo volumio[3368]: code: 'EADDRINUSE', Oct 03 23:52:09 rivo volumio[3368]: errno: -98, Oct 03 23:52:09 rivo volumio[3368]: syscall: 'listen', Oct 03 23:52:09 rivo volumio[3368]: address: '::', Oct 03 23:52:09 rivo volumio[3368]: port: 6599 Oct 03 23:52:09 rivo volumio[3368]: } Oct 03 23:52:09 rivo volumio[3368]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 23:52:10 rivo sudo[5488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-03 23:51 Oct 03 23:52:10 rivo sudo[5488]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:47:06 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="b3e08c3e210a64867536255c2503fb09"