-- Logs begin at Mon 2024-04-29 13:29:58 CEST, end at Mon 2024-04-29 13:44:41 CEST. -- Apr 29 13:43:55 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 13:43:55 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 13:43:55 volumio volumio[618]: info: Discovery: Getting this device information Apr 29 13:43:55 volumio volumio[618]: info: CoreCommandRouter::volumioGetState Apr 29 13:43:55 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:43:55 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 13:43:55 volumio volumio[618]: verbose: New Socket.io Connection to 192.168.1.11 from 192.168.1.65 UA: okhttp/4.9.2 Total Clients: 6 Apr 29 13:43:55 volumio volumio[618]: info: CoreCommandRouter::volumioGetState Apr 29 13:43:55 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:43:55 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 29 13:43:55 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 29 13:43:57 volumio sudo[2441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 13:43:57 volumio sudo[2441]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:43:57 volumio sudo[2441]: pam_unix(sudo:session): session closed for user root Apr 29 13:43:57 volumio sudo[2444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 13:43:57 volumio sudo[2444]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:43:57 volumio sudo[2444]: pam_unix(sudo:session): session closed for user root Apr 29 13:43:57 volumio volumio[618]: verbose: New Socket.io Connection to 192.168.1.11 from 192.168.1.65 UA: okhttp/4.9.2 Total Clients: 7 Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::volumioGetVisibleSources Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::volumioGetState Apr 29 13:43:57 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 29 13:43:57 volumio volumio[618]: info: Received Get System Info Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 13:43:57 volumio volumio[618]: info: Discovery: Getting this device information Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::volumioGetState Apr 29 13:43:57 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 13:43:57 volumio volumio[618]: info: CoreCommandRouter::volumioGetState Apr 29 13:43:57 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:43:57 volumio volumio[618]: info: Listing playlists Apr 29 13:43:58 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 29 13:43:58 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 29 13:43:59 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 29 13:43:59 volumio volumio[618]: info: Received Get System Info Apr 29 13:43:59 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 13:43:59 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 13:43:59 volumio volumio[618]: info: Discovery: Getting this device information Apr 29 13:43:59 volumio volumio[618]: info: CoreCommandRouter::volumioGetState Apr 29 13:43:59 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:43:59 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 13:44:00 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 29 13:44:02 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 29 13:44:02 volumio volumio[618]: info: Received Get System Info Apr 29 13:44:02 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 13:44:02 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 13:44:02 volumio volumio[618]: info: Discovery: Getting this device information Apr 29 13:44:02 volumio volumio[618]: info: CoreCommandRouter::volumioGetState Apr 29 13:44:02 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:02 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 13:44:03 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 29 13:44:03 volumio volumio[618]: info: Received Get System Info Apr 29 13:44:03 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 13:44:03 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 13:44:03 volumio volumio[618]: info: Discovery: Getting this device information Apr 29 13:44:03 volumio volumio[618]: info: CoreCommandRouter::volumioGetState Apr 29 13:44:03 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:03 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 29 13:44:04 volumio volumio[618]: info: Received Get System Info Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 13:44:04 volumio volumio[618]: info: Discovery: Getting this device information Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::volumioGetState Apr 29 13:44:04 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 29 13:44:04 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 29 13:44:10 volumio volumio[618]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 29 13:44:10 volumio volumio[618]: info: Setting mixer Expert Pro USB Audio 2.0 for card Expert Pro USB Audio 2.0 Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 29 13:44:10 volumio volumio[618]: info: Updating Volume Controller Parameters: Device: 5 Name: Expert Pro USB Audio 2.0 Mixer: Expert Pro USB Audio 2.0 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 2 Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 29 13:44:10 volumio volumio[618]: info: Disabling external Volume Control Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 13:44:10 volumio volumio[618]: info: Preparing to generate the ALSA configuration file Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 29 13:44:10 volumio volumio[618]: info: VolumeController:: Volume=73 Mute =false Apr 29 13:44:10 volumio volumio[618]: info: CoreStateMachine::pushState Apr 29 13:44:10 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::volumioPushState Apr 29 13:44:10 volumio volumio[618]: info: Asound.conf file written Apr 29 13:44:10 volumio sudo[2514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 29 13:44:10 volumio sudo[2514]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:10 volumio sudo[2514]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:10 volumio volumio[618]: info: Output device has changed, restarting MPD Apr 29 13:44:10 volumio sudo[2521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 13:44:10 volumio sudo[2521]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:10 volumio sudo[2521]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:10 volumio volumio[618]: info: Output device has changed, restarting Shairport Sync Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:10 volumio sudo[2524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 13:44:10 volumio sudo[2524]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:10 volumio systemd[1]: Stopping Music Player Daemon... Apr 29 13:44:10 volumio volumio[618]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 13:44:10 volumio volumio[618]: info: Output device has changed, restarting MPD Apr 29 13:44:10 volumio sudo[2530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 13:44:10 volumio sudo[2530]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:10 volumio sudo[2530]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:10 volumio volumio[618]: info: Output device has changed, restarting Shairport Sync Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:10 volumio systemd[1]: mpd.service: Succeeded. Apr 29 13:44:10 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 13:44:10 volumio sudo[2533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 13:44:10 volumio sudo[2533]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:10 volumio volumio[618]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 13:44:10 volumio volumio[618]: info: MPD Permissions set Apr 29 13:44:10 volumio volumio[618]: info: MPD Permissions set Apr 29 13:44:10 volumio volumio[618]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Apr 29 13:44:10 volumio volumio[618]: SPOTIFY: SPOTIFY VOLUME 100 Apr 29 13:44:10 volumio volumio[618]: SPOTIFY: VOLUMIO VOLUME 73 Apr 29 13:44:10 volumio volumio[618]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 29 13:44:10 volumio volumio[618]: info: Setting Spotify Volume from Volumio: 73 Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio systemd[1]: Starting Music Player Daemon... Apr 29 13:44:10 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 29 13:44:10 volumio systemd[1]: mpd.service: Succeeded. Apr 29 13:44:10 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 13:44:10 volumio systemd[1]: Starting Music Player Daemon... Apr 29 13:44:10 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:10 volumio volumio[618]: info: Starting Shairport Sync Apr 29 13:44:10 volumio volumio[618]: info: Starting Shairport Sync Apr 29 13:44:10 volumio sudo[2553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 13:44:10 volumio sudo[2553]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 13:44:10 volumio sudo[2555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 13:44:10 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 13:44:10 volumio sudo[2555]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 13:44:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 13:44:10 volumio sudo[2553]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:10 volumio volumio[618]: info: Shairport-Sync Started Apr 29 13:44:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 13:44:10 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 29 13:44:10 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 13:44:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 13:44:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 13:44:10 volumio sudo[2555]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:10 volumio volumio[618]: info: Shairport-Sync Started Apr 29 13:44:11 volumio mpd[2549]: Apr 29 13:44 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 29 13:44:11 volumio systemd[1]: Started Music Player Daemon. Apr 29 13:44:11 volumio sudo[2533]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:11 volumio sudo[2524]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:11 volumio volumio[618]: error: MPD error: The expression evaluated to a falsy value: Apr 29 13:44:11 volumio volumio[618]: assert.ok(self.idling) Apr 29 13:44:11 volumio volumio[618]: error: The expression evaluated to a falsy value: Apr 29 13:44:11 volumio volumio[618]: assert.ok(self.idling) Apr 29 13:44:11 volumio volumio[618]: error: updateQueue error: null Apr 29 13:44:12 volumio volumio[618]: SPOTIFY: SETTING SPOTIFY VOLUME 73 Apr 29 13:44:12 volumio volumio[618]: info: Sending Spotify command with payload to local API: /player/volume Apr 29 13:44:12 volumio go-librespot[2236]: time="2024-04-29T13:44:12+02:00" level=debug msg="update volume to 47840/65535" Apr 29 13:44:12 volumio go-librespot[2236]: time="2024-04-29T13:44:12+02:00" level=debug msg="put connect state because VOLUME_CHANGED" Apr 29 13:44:12 volumio go-librespot[2236]: time="2024-04-29T13:44:12+02:00" level=trace msg="emitting websocket event: volume" Apr 29 13:44:12 volumio volumio[618]: SPOTIFY: received: {"type":"volume","data":{"value":73,"max":100}} Apr 29 13:44:12 volumio volumio[618]: SPOTIFY: RECEIVED SPOTIFY VOLUME 73 Apr 29 13:44:14 volumio volumio[618]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 29 13:44:14 volumio volumio[618]: info: Setting mixer Expert Pro USB Audio 2.0 for card Expert Pro USB Audio 2.0 Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 29 13:44:14 volumio volumio[618]: info: Updating Volume Controller Parameters: Device: 5 Name: Expert Pro USB Audio 2.0 Mixer: Expert Pro USB Audio 2.0 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 2 Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 29 13:44:14 volumio volumio[618]: info: Disabling external Volume Control Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 13:44:14 volumio volumio[618]: info: Preparing to generate the ALSA configuration file Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 29 13:44:14 volumio volumio[618]: info: Asound.conf file unchanged, so no further update is needed Apr 29 13:44:14 volumio volumio[618]: info: Output device has changed, restarting MPD Apr 29 13:44:14 volumio sudo[2581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 13:44:14 volumio sudo[2581]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:14 volumio volumio[618]: info: Output device has changed, restarting Shairport Sync Apr 29 13:44:14 volumio sudo[2581]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:14 volumio sudo[2584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 13:44:14 volumio sudo[2584]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:14 volumio systemd[1]: Stopping Music Player Daemon... Apr 29 13:44:14 volumio volumio[618]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 13:44:14 volumio volumio[618]: info: VolumeController:: Volume=73 Mute =false Apr 29 13:44:14 volumio systemd[1]: mpd.service: Succeeded. Apr 29 13:44:14 volumio volumio[618]: info: CoreStateMachine::pushState Apr 29 13:44:14 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::volumioPushState Apr 29 13:44:14 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 13:44:14 volumio volumio[618]: info: MPD Permissions set Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:14 volumio volumio[618]: info: Starting Shairport Sync Apr 29 13:44:14 volumio volumio[618]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Apr 29 13:44:14 volumio sudo[2597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 13:44:14 volumio sudo[2597]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:14 volumio systemd[1]: Starting Music Player Daemon... Apr 29 13:44:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 13:44:14 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 13:44:14 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 13:44:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 13:44:14 volumio sudo[2597]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:14 volumio volumio[618]: info: Shairport-Sync Started Apr 29 13:44:14 volumio mpd[2589]: Apr 29 13:44 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 29 13:44:14 volumio systemd[1]: Started Music Player Daemon. Apr 29 13:44:14 volumio sudo[2584]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:14 volumio volumio[618]: error: updateQueue error: null Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 29 13:44:14 volumio volumio[618]: info: CoreStateMachine::getcurrentVolume Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 13:44:14 volumio volumio[618]: info: VolumeController:: Volume=73 Mute =false Apr 29 13:44:14 volumio volumio[618]: info: CoreStateMachine::pushState Apr 29 13:44:14 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::volumioPushState Apr 29 13:44:14 volumio volumio[618]: info: CoreStateMachine::updateTrackBlock Apr 29 13:44:14 volumio volumio[618]: info: CorePlayQueue::getTrackBlock Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 13:44:14 volumio volumio[618]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Apr 29 13:44:14 volumio volumio[618]: info: VolumeController:: Volume=73 Mute =false Apr 29 13:44:14 volumio volumio[618]: info: CoreStateMachine::pushState Apr 29 13:44:14 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:14 volumio volumio[618]: info: CoreCommandRouter::volumioPushState Apr 29 13:44:14 volumio volumio[618]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Apr 29 13:44:16 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 29 13:44:16 volumio volumio[618]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 29 13:44:16 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 29 13:44:16 volumio volumio[618]: info: Received Get System Version Apr 29 13:44:16 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 13:44:16 volumio volumio[618]: info: Received Get System Info Apr 29 13:44:16 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 13:44:16 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 13:44:16 volumio volumio[618]: info: Discovery: Getting this device information Apr 29 13:44:16 volumio volumio[618]: info: CoreCommandRouter::volumioGetState Apr 29 13:44:16 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:16 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 13:44:18 volumio volumio[618]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 29 13:44:18 volumio volumio[618]: info: CoreStateMachine::getcurrentVolume Apr 29 13:44:18 volumio volumio[618]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 13:44:18 volumio volumio[618]: info: VolumeController:: Volume=73 Mute =false Apr 29 13:44:18 volumio volumio[618]: info: CoreStateMachine::pushState Apr 29 13:44:18 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:18 volumio volumio[618]: info: CoreCommandRouter::volumioPushState Apr 29 13:44:18 volumio volumio[618]: info: CoreStateMachine::updateTrackBlock Apr 29 13:44:18 volumio volumio[618]: info: CorePlayQueue::getTrackBlock Apr 29 13:44:18 volumio volumio[618]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 13:44:18 volumio volumio[618]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Apr 29 13:44:18 volumio volumio[618]: info: VolumeController:: Volume=73 Mute =false Apr 29 13:44:18 volumio volumio[618]: info: CoreStateMachine::pushState Apr 29 13:44:18 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:18 volumio volumio[618]: info: CoreCommandRouter::volumioPushState Apr 29 13:44:18 volumio volumio[618]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Apr 29 13:44:22 volumio volumio[618]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 29 13:44:22 volumio volumio[618]: info: Setting mixer Expert Pro USB Audio 2.0 for card Expert Pro USB Audio 2.0 Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 29 13:44:22 volumio volumio[618]: info: Updating Volume Controller Parameters: Device: 5 Name: Expert Pro USB Audio 2.0 Mixer: Expert Pro USB Audio 2.0 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 2 Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 29 13:44:22 volumio volumio[618]: info: Disabling external Volume Control Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 13:44:22 volumio volumio[618]: info: Preparing to generate the ALSA configuration file Apr 29 13:44:22 volumio volumio[618]: info: Asound.conf file unchanged, so no further update is needed Apr 29 13:44:22 volumio volumio[618]: info: Output device has changed, restarting MPD Apr 29 13:44:22 volumio sudo[2624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 13:44:22 volumio sudo[2624]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:22 volumio volumio[618]: info: Output device has changed, restarting Shairport Sync Apr 29 13:44:22 volumio sudo[2624]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:22 volumio sudo[2627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 13:44:22 volumio sudo[2627]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:22 volumio systemd[1]: Stopping Music Player Daemon... Apr 29 13:44:22 volumio volumio[618]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 13:44:22 volumio systemd[1]: mpd.service: Succeeded. Apr 29 13:44:22 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 29 13:44:22 volumio volumio[618]: info: MPD Permissions set Apr 29 13:44:22 volumio volumio[618]: info: VolumeController:: Volume=73 Mute =false Apr 29 13:44:22 volumio volumio[618]: info: CoreStateMachine::pushState Apr 29 13:44:22 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::volumioPushState Apr 29 13:44:22 volumio systemd[1]: Starting Music Player Daemon... Apr 29 13:44:22 volumio volumio[618]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 13:44:22 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:44:22 volumio volumio[618]: info: Starting Shairport Sync Apr 29 13:44:22 volumio sudo[2644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 13:44:22 volumio sudo[2644]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:22 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 13:44:22 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 13:44:22 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 13:44:22 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 13:44:22 volumio sudo[2644]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:22 volumio volumio[618]: info: Shairport-Sync Started Apr 29 13:44:22 volumio mpd[2633]: Apr 29 13:44 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 29 13:44:22 volumio systemd[1]: Started Music Player Daemon. Apr 29 13:44:22 volumio sudo[2627]: pam_unix(sudo:session): session closed for user root Apr 29 13:44:22 volumio volumio[618]: error: updateQueue error: null Apr 29 13:44:26 volumio volumio[618]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 29 13:44:26 volumio volumio[618]: info: CoreStateMachine::getcurrentVolume Apr 29 13:44:26 volumio volumio[618]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 13:44:26 volumio volumio[618]: info: VolumeController:: Volume=73 Mute =false Apr 29 13:44:26 volumio volumio[618]: info: CoreStateMachine::pushState Apr 29 13:44:26 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:26 volumio volumio[618]: info: CoreCommandRouter::volumioPushState Apr 29 13:44:26 volumio volumio[618]: info: CoreStateMachine::updateTrackBlock Apr 29 13:44:26 volumio volumio[618]: info: CorePlayQueue::getTrackBlock Apr 29 13:44:26 volumio volumio[618]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 13:44:26 volumio volumio[618]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Apr 29 13:44:26 volumio volumio[618]: info: VolumeController:: Volume=73 Mute =false Apr 29 13:44:26 volumio volumio[618]: info: CoreStateMachine::pushState Apr 29 13:44:26 volumio volumio[618]: info: CorePlayQueue::getTrack 0 Apr 29 13:44:26 volumio volumio[618]: info: CoreCommandRouter::volumioPushState Apr 29 13:44:26 volumio volumio[618]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Apr 29 13:44:33 volumio ntpd[1575]: 193.52.136.2 local addr 192.168.1.11 -> Apr 29 13:44:33 volumio ntpd[1575]: 37.187.150.174 local addr 192.168.1.11 -> Apr 29 13:44:33 volumio ntpd[1575]: 5.39.80.51 local addr 192.168.1.11 -> Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 13:44:35 volumio volumio[618]: info: Retrieving Cloud Streaming UI Apr 29 13:44:35 volumio volumio[618]: info: Getting Tidal Cloud Configuration Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 13:44:35 volumio volumio[618]: info: Getting Qobuz Cloud Configuration Apr 29 13:44:35 volumio volumio[618]: info: Asking plugin for UI Config Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 13:44:35 volumio volumio[618]: info: Getting Spotify Cloud Configuration Apr 29 13:44:35 volumio volumio[618]: info: Asking plugin for UI Config Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 13:44:35 volumio volumio[618]: info: Saving Spotify Acccount Apr 29 13:44:35 volumio volumio[618]: info: Got Tidal Cloud Configuration Apr 29 13:44:35 volumio volumio[618]: info: Got it Apr 29 13:44:35 volumio volumio[618]: info: Got it Apr 29 13:44:35 volumio volumio[618]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 13:44:35 volumio volumio[618]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::volumioGetBrowseSources Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::volumioGetBrowseSources Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::volumioGetBrowseSources Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 13:44:35 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 29 13:44:38 volumio volumio[618]: info: Disabling MyMusic plugin upnp Apr 29 13:44:38 volumio sudo[2657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 29 13:44:38 volumio sudo[2657]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:44:38 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Apr 29 13:44:38 volumio volumio[618]: error: Upnp client error: Error: This socket has been ended by the other party Apr 29 13:44:39 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 29 13:44:40 volumio volumio[618]: info: Enabling MyMusic plugin upnp Apr 29 13:44:40 volumio volumio[618]: info: Enabling plugin upnp Apr 29 13:44:40 volumio volumio[618]: info: Loading plugin "upnp"... Apr 29 13:44:40 volumio volumio[618]: info: [1714391080997] Starting Upmpd Daemon Apr 29 13:44:40 volumio volumio[618]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 13:44:40 volumio volumio[618]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 13:44:41 volumio volumio[618]: Error: listen EADDRINUSE: address already in use :::6599 Apr 29 13:44:41 volumio volumio[618]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Apr 29 13:44:41 volumio volumio[618]: at listenInCluster (net.js:1379:12) Apr 29 13:44:41 volumio volumio[618]: at Server.listen (net.js:1465:7) Apr 29 13:44:41 volumio volumio[618]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Apr 29 13:44:41 volumio volumio[618]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Apr 29 13:44:41 volumio volumio[618]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 29 13:44:41 volumio volumio[618]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 29 13:44:41 volumio volumio[618]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Apr 29 13:44:41 volumio volumio[618]: code: 'EADDRINUSE', Apr 29 13:44:41 volumio volumio[618]: errno: -98, Apr 29 13:44:41 volumio volumio[618]: syscall: 'listen', Apr 29 13:44:41 volumio volumio[618]: address: '::', Apr 29 13:44:41 volumio volumio[618]: port: 6599 Apr 29 13:44:41 volumio volumio[618]: } Apr 29 13:44:41 volumio volumio[618]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 13:44:41 volumio sudo[2668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-29 13:43 Apr 29 13:44:41 volumio sudo[2668]: 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="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET" VOLUMIO_VERSION="3.634" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"