Dec 18 12:50:14 volumio sudo[2128]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 12:50:14 volumio sudo[2128]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:14 volumio sudo[2130]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 12:50:14 volumio sudo[2130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:14 volumio sudo[2128]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:14 volumio sudo[2130]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:14 volumio volumio[1150]: verbose: New Socket.io Connection to 192.168.1.78 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 18 12:50:16 volumio sudo[2139]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 12:50:16 volumio sudo[2139]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:16 volumio sudo[2137]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 12:50:16 volumio sudo[2137]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:16 volumio sudo[2137]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:16 volumio sudo[2139]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:17 volumio volumio[1150]: verbose: New Socket.io Connection to 192.168.1.78 from 192.168.1.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::volumioGetVisibleSources Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:18 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 18 12:50:18 volumio volumio[1150]: info: Received Get System Info Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 12:50:18 volumio volumio[1150]: info: Discovery: Getting this device information Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:18 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:18 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:18 volumio volumio[1150]: info: Listing playlists Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 18 12:50:18 volumio volumio[1150]: info: Received Get System Info Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 12:50:18 volumio volumio[1150]: info: Discovery: Getting this device information Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:18 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 12:50:19 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:19 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:19 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 18 12:50:19 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 18 12:50:20 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 18 12:50:21 volumio upmpdcli[2168]: writing RSA key Dec 18 12:50:23 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 18 12:50:23 volumio volumio[1150]: info: Received Get System Info Dec 18 12:50:23 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 12:50:23 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 12:50:23 volumio volumio[1150]: info: Discovery: Getting this device information Dec 18 12:50:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:23 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:23 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 12:50:27 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 18 12:50:33 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 18 12:50:34 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 18 12:50:34 volumio volumio[1150]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 18 12:50:34 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 18 12:50:34 volumio volumio[1150]: info: Received Get System Version Dec 18 12:50:34 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 18 12:50:34 volumio volumio[1150]: info: Received Get System Info Dec 18 12:50:34 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 12:50:34 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 12:50:34 volumio volumio[1150]: info: Discovery: Getting this device information Dec 18 12:50:34 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:34 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:34 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 12:50:36 volumio volumio[1150]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 18 12:50:36 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 18 12:50:36 volumio volumio[1150]: info: Preparing to save Alsa Options, stopping services first Dec 18 12:50:36 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:36 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:36 volumio volumio[1150]: info: CoreCommandRouter::volumioPause Dec 18 12:50:36 volumio volumio[1150]: info: CoreStateMachine::pause Dec 18 12:50:36 volumio volumio[1150]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"G5"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Dec 18 12:50:36 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 12:50:36 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 12:50:36 volumio volumio[1150]: info: Setting mixer G5 for card G5 Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 18 12:50:37 volumio volumio[1150]: info: Updating Volume Controller Parameters: Device: 5 Name: G5 Mixer: G5 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 18 12:50:37 volumio volumio[1150]: info: Disabling external Volume Control Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 12:50:37 volumio volumio[1150]: info: Preparing to generate the ALSA configuration file Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 18 12:50:37 volumio volumio[1150]: info: Asound.conf file unchanged, so no further update is needed Dec 18 12:50:37 volumio volumio[1150]: info: Output device has changed, restarting MPD Dec 18 12:50:37 volumio volumio[1150]: info: Output device has changed, restarting Shairport Sync Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:37 volumio sudo[2222]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 18 12:50:37 volumio sudo[2222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:37 volumio sudo[2222]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:37 volumio sudo[2225]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 18 12:50:38 volumio sudo[2225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:38 volumio volumio[1150]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 18 12:50:38 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 18 12:50:38 volumio volumio[1150]: info: MPD Permissions set Dec 18 12:50:38 volumio volumio[1150]: info: VolumeController:: Volume=100 Mute =false Dec 18 12:50:38 volumio volumio[1150]: info: [squeezelite_mc] Setting Squeezelite volume to 100 Dec 18 12:50:38 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 18 12:50:38 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 18 12:50:38 volumio systemd[1]: mpd.service: Consumed 3.039s CPU time. Dec 18 12:50:38 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 18 12:50:38 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 18 12:50:38 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 18 12:50:38 volumio volumio[1150]: info: CoreStateMachine::pushState Dec 18 12:50:38 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Dec 18 12:50:38 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 18 12:50:38 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:38 volumio sudo[2232]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 18 12:50:38 volumio sudo[2232]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 18 12:50:38 volumio sudo[2232]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:38 volumio volumio[1150]: info: Starting Shairport Sync Dec 18 12:50:38 volumio sudo[2241]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 18 12:50:38 volumio sudo[2241]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:38 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:38 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:39 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 18 12:50:39 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 18 12:50:39 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 12:50:39 volumio systemd[1]: shairport-sync.service: Consumed 1.498s CPU time. Dec 18 12:50:39 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 12:50:39 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'disconnect' Dec 18 12:50:39 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'disconnect' Dec 18 12:50:39 volumio sudo[2241]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:39 volumio volumio[1150]: info: Shairport-Sync Started Dec 18 12:50:39 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:39 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:39 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:39 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:40 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'connect' Dec 18 12:50:40 volumio volumio[1150]: info: [squeezelite_mc] Getting players connected to QNAP-TS251A (192.168.1.25) Dec 18 12:50:40 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'connect' Dec 18 12:50:40 volumio volumio[1150]: info: [squeezelite_mc] Getting players connected to QNAP-TS251A (192.168.1.25) Dec 18 12:50:40 volumio volumio[1150]: info: [squeezelite_mc] Players connected to QNAP-TS251A (192.168.1.25): [{"id":"aa:aa:4d:40:0f:df","uuid":null,"ip":"172.29.0.1","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}},{"id":"b8:27:eb:0a:1b:63","uuid":null,"ip":"192.168.1.78","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}}] Dec 18 12:50:40 volumio volumio[1150]: info: [squeezelite_mc] Players connected to QNAP-TS251A (192.168.1.25): [{"id":"aa:aa:4d:40:0f:df","uuid":null,"ip":"172.29.0.1","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}},{"id":"b8:27:eb:0a:1b:63","uuid":null,"ip":"192.168.1.78","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}}] Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 18 12:50:41 volumio volumio[1150]: info: CoreStateMachine::getcurrentVolume Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::volumioRetrievevolume Dec 18 12:50:41 volumio volumio[1150]: info: VolumeController:: Volume=100 Mute =false Dec 18 12:50:41 volumio volumio[1150]: info: [squeezelite_mc] Setting Squeezelite volume to 100 Dec 18 12:50:41 volumio mpd[2239]: 2025-12-18T12:50:41 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 18 12:50:41 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 18 12:50:41 volumio sudo[2225]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:41 volumio volumio[1150]: info: CoreStateMachine::pushState Dec 18 12:50:41 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Dec 18 12:50:41 volumio volumio[1150]: info: CoreStateMachine::updateTrackBlock Dec 18 12:50:41 volumio volumio[1150]: info: CorePlayQueue::getTrackBlock Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::volumioRetrievevolume Dec 18 12:50:41 volumio volumio[1150]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 18 12:50:41 volumio volumio[1150]: info: Preparing to save Alsa Options, stopping services first Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:41 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::volumioPause Dec 18 12:50:41 volumio volumio[1150]: info: CoreStateMachine::pause Dec 18 12:50:41 volumio volumio[1150]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"G5"},"i2s":true,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:41 volumio volumio[1150]: info: Enabling I2S DAC: Adafruit MAX98357 Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Dec 18 12:50:41 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:42 volumio sudo[2280]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Dec 18 12:50:42 volumio sudo[2280]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:42 volumio sudo[2280]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:42 volumio volumio[1150]: info: No Overlays Loaded Dec 18 12:50:42 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:42 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Dec 18 12:50:42 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:42 volumio sudo[2284]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay max98357a Dec 18 12:50:42 volumio sudo[2284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:42 volumio volumio[1150]: warn: Unable to locate the device G5 a reboot may be required. Dec 18 12:50:42 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Dec 18 12:50:42 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Dec 18 12:50:42 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/simple-audio-card,format Dec 18 12:50:42 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/simple-audio-card,name Dec 18 12:50:42 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Dec 18 12:50:42 volumio sudo[2284]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:42 volumio (udev-worker)[2295]: controlC2: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 2' failed with exit code 99. Dec 18 12:50:42 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 12:50:42 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Dec 18 12:50:42 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:42 volumio volumio[1150]: info: Device 2 does not have any Mixer Control Available Dec 18 12:50:43 volumio volumio[1150]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 18 12:50:43 volumio volumio[1150]: info: Updating Volume Controller Parameters: Device: 2 Name: Adafruit MAX98357 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 18 12:50:43 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 18 12:50:43 volumio volumio[1150]: info: Disabling external Volume Control Dec 18 12:50:43 volumio volumio[1150]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 12:50:43 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Dec 18 12:50:43 volumio volumio[1150]: info: [squeezelite_mc] Setting Squeezelite volume to 100 Dec 18 12:50:43 volumio volumio[1150]: info: CoreStateMachine::pushState Dec 18 12:50:43 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:43 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 12:50:43 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Dec 18 12:50:43 volumio volumio[1150]: info: Preparing to generate the ALSA configuration file Dec 18 12:50:43 volumio volumio[1150]: error: updateQueue error: null Dec 18 12:50:43 volumio volumio[1150]: info: I2S Param [object Object] successfully enabled Dec 18 12:50:43 volumio volumio[1150]: info: VolumeController:: Volume=100 Mute =false Dec 18 12:50:43 volumio volumio[1150]: info: [squeezelite_mc] Setting Squeezelite volume to 100 Dec 18 12:50:43 volumio volumio[1150]: info: CoreStateMachine::pushState Dec 18 12:50:43 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:43 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 12:50:43 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Dec 18 12:50:43 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 18 12:50:43 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:43 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 12:50:43 volumio volumio[1150]: info: Getting Alsa Cards List without I2S DAC Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:44 volumio volumio[1150]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true Dec 18 12:50:44 volumio volumio[1150]: info: [squeezelite_mc] Card 2 supports the following ALSA formats: ["S16_LE","S24_LE","S32_LE"] Dec 18 12:50:44 volumio volumio[1150]: info: [squeezelite_mc] Restarting Squeezelite service with params: {"type":"basic","playerName":"volumio","dsdFormat":null,"card":"2","mixerType":"None","mixer":null} Dec 18 12:50:44 volumio volumio[1150]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Dec 18 12:50:44 volumio volumio[1150]: info: Asound.conf file written Dec 18 12:50:44 volumio sudo[2327]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 18 12:50:44 volumio sudo[2327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:44 volumio sudo[2328]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Dec 18 12:50:44 volumio sudo[2331]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 18 12:50:44 volumio sudo[2328]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:44 volumio sudo[2331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:44 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 18 12:50:44 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 18 12:50:44 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 18 12:50:44 volumio sudo[2331]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:44 volumio sudo[2328]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:44 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 18 12:50:44 volumio mpd_monitor.sh[2335]: MPD Monitor Service: Starting MPD Monitor Service Dec 18 12:50:44 volumio sudo[2327]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:45 volumio volumio[1150]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 18 12:50:45 volumio volumio[1150]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 18 12:50:45 volumio volumio[1150]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Dec 18 12:50:45 volumio volumio[1150]: No state is present for card MAX98357A Dec 18 12:50:45 volumio volumio[1150]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Dec 18 12:50:45 volumio volumio[1150]: Found hardware: "simple-card" "" "" "" "" Dec 18 12:50:45 volumio volumio[1150]: Hardware is initialized using a generic method Dec 18 12:50:45 volumio volumio[1150]: No state is present for card MAX98357A Dec 18 12:50:45 volumio volumio[1150]: No state is present for card G5 Dec 18 12:50:45 volumio volumio[1150]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:8750" "" "" Dec 18 12:50:45 volumio volumio[1150]: Hardware is initialized using a generic method Dec 18 12:50:45 volumio volumio[1150]: No state is present for card G5 Dec 18 12:50:45 volumio volumio[1150]: info: Output device has changed, restarting MPD Dec 18 12:50:45 volumio sudo[2343]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 18 12:50:45 volumio volumio[1150]: info: Output device has changed, restarting Shairport Sync Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:45 volumio sudo[2343]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:45 volumio sudo[2343]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:45 volumio sudo[2345]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 18 12:50:45 volumio sudo[2345]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:45 volumio volumio[1150]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 18 12:50:45 volumio volumio[1150]: info: Output device has changed, restarting MPD Dec 18 12:50:45 volumio volumio[1150]: info: Output device has changed, restarting Shairport Sync Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:45 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 18 12:50:45 volumio sudo[2353]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 18 12:50:45 volumio sudo[2353]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:45 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 18 12:50:45 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 18 12:50:45 volumio systemd[1]: mpd.service: Consumed 2.886s CPU time. Dec 18 12:50:45 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 18 12:50:45 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 18 12:50:45 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 18 12:50:45 volumio sudo[2353]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:45 volumio sudo[2357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 18 12:50:45 volumio sudo[2357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:45 volumio volumio[1150]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 18 12:50:45 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 18 12:50:45 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:45 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:45 volumio volumio[1150]: info: MPD Permissions set Dec 18 12:50:45 volumio volumio[1150]: info: MPD Permissions set Dec 18 12:50:45 volumio volumio[1150]: info: Successfully started MPD Monitor Dec 18 12:50:45 volumio volumio[1150]: info: [squeezelite_mc] Executing alsactl -L -R nrestore Dec 18 12:50:45 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 18 12:50:45 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 18 12:50:45 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 18 12:50:45 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 18 12:50:45 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 18 12:50:45 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 18 12:50:45 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:45 volumio sudo[2367]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Dec 18 12:50:45 volumio sudo[2367]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:45 volumio sudo[2368]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 18 12:50:45 volumio sudo[2368]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 18 12:50:46 volumio sudo[2368]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:46 volumio sudo[2367]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:46 volumio volumio[1150]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Dec 18 12:50:46 volumio volumio[1150]: info: Starting Shairport Sync Dec 18 12:50:46 volumio volumio[1150]: info: Starting Shairport Sync Dec 18 12:50:46 volumio sudo[2384]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Dec 18 12:50:46 volumio sudo[2384]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:46 volumio sudo[2386]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 18 12:50:46 volumio sudo[2386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:46 volumio sudo[2384]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:46 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Dec 18 12:50:46 volumio sudo[2388]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 18 12:50:46 volumio sudo[2388]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:46 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 18 12:50:46 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 18 12:50:46 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 12:50:46 volumio systemd[1]: shairport-sync.service: Consumed 1.389s CPU time. Dec 18 12:50:46 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 12:50:46 volumio sudo[2386]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:46 volumio volumio[1150]: info: Shairport-Sync Started Dec 18 12:50:46 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 18 12:50:46 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 18 12:50:46 volumio sudo[2393]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Dec 18 12:50:46 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'disconnect' Dec 18 12:50:46 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 12:50:46 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'disconnect' Dec 18 12:50:46 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 12:50:46 volumio sudo[2388]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:46 volumio sudo[2393]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:46 volumio volumio[1150]: info: Shairport-Sync Started Dec 18 12:50:47 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:47 volumio systemd[1]: Reloading. Dec 18 12:50:47 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:50:47 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:50:47 volumio volumio[1150]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 18 12:50:47 volumio volumio[1150]: info: CoreStateMachine::getcurrentVolume Dec 18 12:50:47 volumio volumio[1150]: info: CoreCommandRouter::volumioRetrievevolume Dec 18 12:50:47 volumio volumio[1150]: info: [squeezelite_mc] Setting Squeezelite volume to 100 Dec 18 12:50:47 volumio volumio[1150]: info: CoreStateMachine::pushState Dec 18 12:50:47 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:47 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 12:50:47 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Dec 18 12:50:47 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'connect' Dec 18 12:50:47 volumio volumio[1150]: info: [squeezelite_mc] Getting players connected to QNAP-TS251A (192.168.1.25) Dec 18 12:50:47 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'connect' Dec 18 12:50:47 volumio volumio[1150]: info: [squeezelite_mc] Getting players connected to QNAP-TS251A (192.168.1.25) Dec 18 12:50:48 volumio volumio[1150]: info: [squeezelite_mc] Players connected to QNAP-TS251A (192.168.1.25): [{"id":"aa:aa:4d:40:0f:df","uuid":null,"ip":"172.29.0.1","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}},{"id":"b8:27:eb:0a:1b:63","uuid":null,"ip":"192.168.1.78","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}}] Dec 18 12:50:48 volumio volumio[1150]: info: [squeezelite_mc] Players connected to QNAP-TS251A (192.168.1.25): [{"id":"aa:aa:4d:40:0f:df","uuid":null,"ip":"172.29.0.1","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}},{"id":"b8:27:eb:0a:1b:63","uuid":null,"ip":"192.168.1.78","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}}] Dec 18 12:50:48 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:48 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:48 volumio systemd[1]: /lib/systemd/system/roonbridge.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 12:50:48 volumio systemd[1]: /lib/systemd/system/roonbridge.service:8: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 12:50:49 volumio mpd[2376]: 2025-12-18T12:50:49 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 18 12:50:49 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 18 12:50:49 volumio sudo[2393]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:49 volumio sudo[2345]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:49 volumio sudo[2357]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:49 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 18 12:50:49 volumio volumio[1150]: error: MPD error: The expression evaluated to a falsy value: Dec 18 12:50:49 volumio volumio[1150]: assert.ok(self.idling) Dec 18 12:50:49 volumio volumio[1150]: error: The expression evaluated to a falsy value: Dec 18 12:50:49 volumio volumio[1150]: assert.ok(self.idling) Dec 18 12:50:49 volumio volumio[1150]: error: updateQueue error: null Dec 18 12:50:49 volumio sudo[2431]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 18 12:50:49 volumio sudo[2431]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:49 volumio sudo[2431]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:49 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true Dec 18 12:50:49 volumio sudo[2434]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite Dec 18 12:50:49 volumio sudo[2434]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:49 volumio systemd[1]: Stopping squeezelite.service - Squeezelite lightweight headless Squeezebox emulator... Dec 18 12:50:49 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'disconnect' Dec 18 12:50:49 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'disconnect' Dec 18 12:50:49 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:49 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:49 volumio systemd[1]: squeezelite.service: Deactivated successfully. Dec 18 12:50:49 volumio systemd[1]: Stopped squeezelite.service - Squeezelite lightweight headless Squeezebox emulator. Dec 18 12:50:49 volumio sudo[2434]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:50 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 18 12:50:50 volumio sudo[2451]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 18 12:50:50 volumio sudo[2451]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:50 volumio sudo[2451]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:50 volumio volumio[1150]: info: [squeezelite_mc] Executing rm /tmp/squeezelite.log Dec 18 12:50:50 volumio sudo[2455]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm /tmp/squeezelite.log Dec 18 12:50:50 volumio sudo[2455]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:50 volumio sudo[2455]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:50 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true Dec 18 12:50:50 volumio sudo[2458]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite Dec 18 12:50:50 volumio sudo[2458]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:51 volumio systemd[1]: Starting squeezelite.service - Squeezelite lightweight headless Squeezebox emulator... Dec 18 12:50:51 volumio systemd[1]: Started squeezelite.service - Squeezelite lightweight headless Squeezebox emulator. Dec 18 12:50:51 volumio sudo[2458]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:51 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'connect' Dec 18 12:50:51 volumio volumio[1150]: info: [squeezelite_mc] Getting players connected to QNAP-TS251A (192.168.1.25) Dec 18 12:50:51 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'connect' Dec 18 12:50:51 volumio volumio[1150]: info: [squeezelite_mc] Getting players connected to QNAP-TS251A (192.168.1.25) Dec 18 12:50:51 volumio volumio[1150]: info: [squeezelite_mc] Players connected to QNAP-TS251A (192.168.1.25): [{"id":"aa:aa:4d:40:0f:df","uuid":null,"ip":"172.29.0.1","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}},{"id":"b8:27:eb:0a:1b:63","uuid":null,"ip":"192.168.1.78","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}}] Dec 18 12:50:51 volumio volumio[1150]: info: [squeezelite_mc] Player found: {"id":"b8:27:eb:0a:1b:63","uuid":null,"ip":"192.168.1.78","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}} Dec 18 12:50:51 volumio volumio[1150]: info: [squeezelite_mc] Players connected to QNAP-TS251A (192.168.1.25): [{"id":"aa:aa:4d:40:0f:df","uuid":null,"ip":"172.29.0.1","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}},{"id":"b8:27:eb:0a:1b:63","uuid":null,"ip":"192.168.1.78","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}}] Dec 18 12:50:51 volumio volumio[1150]: info: [squeezelite_mc] Player found: {"id":"b8:27:eb:0a:1b:63","uuid":null,"ip":"192.168.1.78","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}} Dec 18 12:50:51 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 18 12:50:51 volumio sudo[2465]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 18 12:50:51 volumio sudo[2465]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:52 volumio sudo[2465]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:52 volumio sudo[2468]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 18 12:50:52 volumio sudo[2468]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:52 volumio sudo[2470]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 18 12:50:52 volumio sudo[2470]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:52 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 18 12:50:52 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 18 12:50:52 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 18 12:50:52 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 18 12:50:52 volumio mpd_monitor.sh[2473]: MPD Monitor Service: Starting MPD Monitor Service Dec 18 12:50:52 volumio sudo[2468]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:52 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 18 12:50:52 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 18 12:50:52 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 18 12:50:52 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 18 12:50:52 volumio mpd_monitor.sh[2476]: MPD Monitor Service: Starting MPD Monitor Service Dec 18 12:50:52 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 18 12:50:52 volumio sudo[2470]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:52 volumio volumio[1150]: info: Successfully started MPD Monitor Dec 18 12:50:52 volumio volumio[1150]: info: Successfully started MPD Monitor Dec 18 12:50:52 volumio sudo[2481]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 18 12:50:52 volumio sudo[2481]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:52 volumio sudo[2481]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:53 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:53 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:53 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 18 12:50:53 volumio sudo[2484]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 18 12:50:53 volumio sudo[2484]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:53 volumio sudo[2484]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:53 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:50:53 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:50:54 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 18 12:50:54 volumio sudo[2487]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 18 12:50:54 volumio sudo[2487]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:54 volumio sudo[2487]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:55 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 18 12:50:55 volumio sudo[2490]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 18 12:50:55 volumio sudo[2490]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:55 volumio sudo[2490]: pam_unix(sudo:session): session closed for user root Dec 18 12:50:55 volumio volumio[1150]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 12:50:55 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 18 12:50:55 volumio sudo[2493]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 18 12:50:55 volumio sudo[2493]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:50:55 volumio sudo[2493]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:02 volumio volumio[1150]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 12:51:02 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 18 12:51:02 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:51:02 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 12:51:02 volumio volumio[1150]: info: Getting Alsa Cards List without I2S DAC Dec 18 12:51:03 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Dec 18 12:51:03 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:51:03 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:03 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:03 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:03 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:03 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:03 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:03 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:03 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 18 12:51:03 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 18 12:51:10 volumio volumio[1150]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 18 12:51:10 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 18 12:51:10 volumio volumio[1150]: info: Preparing to save Alsa Options, stopping services first Dec 18 12:51:10 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:51:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:51:10 volumio volumio[1150]: info: CoreCommandRouter::volumioPause Dec 18 12:51:10 volumio volumio[1150]: info: CoreStateMachine::pause Dec 18 12:51:10 volumio volumio[1150]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"G5"},"i2s":false,"i2sid":{"value":"max98357a","label":"Adafruit MAX98357"}} Dec 18 12:51:10 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 12:51:10 volumio volumio[1150]: info: Disabling I2S DAC: Dec 18 12:51:10 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC Dec 18 12:51:10 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:51:10 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 12:51:10 volumio volumio[1150]: info: Setting mixer G5 for card G5 Dec 18 12:51:10 volumio volumio[1150]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 18 12:51:10 volumio volumio[1150]: info: Updating Volume Controller Parameters: Device: 5 Name: G5 Mixer: G5 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 18 12:51:10 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 18 12:51:10 volumio volumio[1150]: info: Disabling external Volume Control Dec 18 12:51:10 volumio volumio[1150]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 12:51:10 volumio volumio[1150]: info: Preparing to generate the ALSA configuration file Dec 18 12:51:11 volumio sudo[2551]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Dec 18 12:51:11 volumio sudo[2551]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:11 volumio sudo[2551]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:11 volumio sudo[2555]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r max98357a Dec 18 12:51:11 volumio sudo[2555]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:11 volumio kernel: OF: ERROR: memory leak, expected refcount 1 instead of 2, of_node_get()/of_node_put() unbalanced - destroy cset entry: attach overlay node /max98357a Dec 18 12:51:11 volumio sudo[2555]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:11 volumio volumio[1150]: info: Removed overlay max98357a Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 18 12:51:11 volumio volumio[1150]: info: VolumeController:: Volume=100 Mute =false Dec 18 12:51:11 volumio volumio[1150]: info: [squeezelite_mc] Setting Squeezelite volume to 100 Dec 18 12:51:11 volumio volumio[1150]: info: CoreStateMachine::pushState Dec 18 12:51:11 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 12:51:11 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Dec 18 12:51:12 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:12 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:12 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:12 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:12 volumio volumio[1150]: info: [squeezelite_mc] Restarting Squeezelite service with params: {"type":"basic","playerName":"volumio","dsdFormat":"DSD_U32_BE","card":"5","mixerType":"Hardware","mixer":"G5 "} Dec 18 12:51:12 volumio volumio[1150]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Dec 18 12:51:12 volumio volumio[1150]: info: Asound.conf file written Dec 18 12:51:12 volumio sudo[2575]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Dec 18 12:51:12 volumio sudo[2575]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:12 volumio sudo[2578]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 18 12:51:12 volumio sudo[2578]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:12 volumio sudo[2575]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:12 volumio sudo[2578]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:12 volumio volumio[1150]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 18 12:51:12 volumio volumio[1150]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 18 12:51:12 volumio volumio[1150]: No state is present for card G5 Dec 18 12:51:12 volumio volumio[1150]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:8750" "" "" Dec 18 12:51:12 volumio volumio[1150]: Hardware is initialized using a generic method Dec 18 12:51:12 volumio volumio[1150]: No state is present for card G5 Dec 18 12:51:12 volumio volumio[1150]: info: Output device has changed, restarting MPD Dec 18 12:51:12 volumio volumio[1150]: info: Output device has changed, restarting Shairport Sync Dec 18 12:51:12 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:12 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:51:12 volumio sudo[2590]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 18 12:51:12 volumio sudo[2590]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:12 volumio volumio[1150]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 18 12:51:12 volumio sudo[2585]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 18 12:51:12 volumio sudo[2585]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:12 volumio volumio[1150]: info: Output device has changed, restarting MPD Dec 18 12:51:12 volumio sudo[2585]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:12 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 18 12:51:12 volumio volumio[1150]: info: Output device has changed, restarting Shairport Sync Dec 18 12:51:12 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:12 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:51:12 volumio sudo[2598]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 18 12:51:12 volumio sudo[2598]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:12 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 18 12:51:12 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 18 12:51:12 volumio systemd[1]: mpd.service: Consumed 3.039s CPU time. Dec 18 12:51:12 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 18 12:51:12 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 18 12:51:12 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 18 12:51:13 volumio sudo[2598]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:13 volumio sudo[2602]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 18 12:51:13 volumio sudo[2602]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:13 volumio volumio[1150]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 18 12:51:13 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 18 12:51:13 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 18 12:51:13 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 18 12:51:13 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 18 12:51:13 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 18 12:51:13 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 18 12:51:13 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 18 12:51:13 volumio volumio[1150]: info: MPD Permissions set Dec 18 12:51:13 volumio volumio[1150]: info: MPD Permissions set Dec 18 12:51:13 volumio volumio[1150]: info: [squeezelite_mc] Executing alsactl -L -R nrestore Dec 18 12:51:13 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 18 12:51:13 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio sudo[2610]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 18 12:51:13 volumio sudo[2610]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 18 12:51:13 volumio sudo[2610]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio sudo[2616]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Dec 18 12:51:13 volumio sudo[2616]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 12:51:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:13 volumio sudo[2616]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:13 volumio volumio[1150]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Dec 18 12:51:13 volumio volumio[1150]: info: Starting Shairport Sync Dec 18 12:51:14 volumio sudo[2631]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 18 12:51:14 volumio sudo[2631]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:14 volumio volumio[1150]: info: Starting Shairport Sync Dec 18 12:51:14 volumio sudo[2629]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Dec 18 12:51:14 volumio sudo[2629]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:14 volumio sudo[2629]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:14 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:51:14 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:51:14 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Dec 18 12:51:14 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 18 12:51:14 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 18 12:51:14 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 12:51:14 volumio systemd[1]: shairport-sync.service: Consumed 1.229s CPU time. Dec 18 12:51:14 volumio sudo[2636]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 18 12:51:14 volumio sudo[2636]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:14 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 12:51:14 volumio sudo[2631]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:14 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'disconnect' Dec 18 12:51:14 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'disconnect' Dec 18 12:51:14 volumio volumio[1150]: info: Shairport-Sync Started Dec 18 12:51:14 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 18 12:51:14 volumio volumio[1150]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 18 12:51:14 volumio volumio[1150]: info: CoreStateMachine::getcurrentVolume Dec 18 12:51:14 volumio volumio[1150]: info: CoreCommandRouter::volumioRetrievevolume Dec 18 12:51:14 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 18 12:51:14 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 12:51:14 volumio sudo[2640]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Dec 18 12:51:14 volumio sudo[2640]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:14 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:14 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:14 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:14 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 12:51:14 volumio sudo[2636]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:14 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 12:51:14 volumio volumio[1150]: info: Shairport-Sync Started Dec 18 12:51:14 volumio systemd[1]: Reloading. Dec 18 12:51:15 volumio volumio[1150]: info: VolumeController:: Volume=100 Mute =false Dec 18 12:51:15 volumio volumio[1150]: info: [squeezelite_mc] Setting Squeezelite volume to 100 Dec 18 12:51:15 volumio volumio[1150]: info: CoreStateMachine::pushState Dec 18 12:51:15 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:51:15 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Dec 18 12:51:15 volumio volumio[1150]: info: CoreStateMachine::updateTrackBlock Dec 18 12:51:15 volumio volumio[1150]: info: CorePlayQueue::getTrackBlock Dec 18 12:51:15 volumio volumio[1150]: info: CoreCommandRouter::volumioRetrievevolume Dec 18 12:51:15 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 12:51:15 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'connect' Dec 18 12:51:15 volumio volumio[1150]: info: [squeezelite_mc] Getting players connected to QNAP-TS251A (192.168.1.25) Dec 18 12:51:16 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'connect' Dec 18 12:51:16 volumio volumio[1150]: info: [squeezelite_mc] Getting players connected to QNAP-TS251A (192.168.1.25) Dec 18 12:51:16 volumio volumio[1150]: info: VolumeController:: Volume=100 Mute =false Dec 18 12:51:16 volumio volumio[1150]: info: [squeezelite_mc] Setting Squeezelite volume to 100 Dec 18 12:51:16 volumio volumio[1150]: info: CoreStateMachine::pushState Dec 18 12:51:16 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:51:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Dec 18 12:51:16 volumio systemd[1]: /lib/systemd/system/roonbridge.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 12:51:16 volumio systemd[1]: /lib/systemd/system/roonbridge.service:8: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 12:51:16 volumio mpd[2620]: 2025-12-18T12:51:16 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 18 12:51:16 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 18 12:51:16 volumio sudo[2640]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:17 volumio sudo[2602]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:17 volumio volumio[1150]: info: [squeezelite_mc] Players connected to QNAP-TS251A (192.168.1.25): [{"id":"aa:aa:4d:40:0f:df","uuid":null,"ip":"172.29.0.1","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}},{"id":"b8:27:eb:0a:1b:63","uuid":null,"ip":"192.168.1.78","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}}] Dec 18 12:51:17 volumio volumio[1150]: info: [squeezelite_mc] Players connected to QNAP-TS251A (192.168.1.25): [{"id":"aa:aa:4d:40:0f:df","uuid":null,"ip":"172.29.0.1","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}},{"id":"b8:27:eb:0a:1b:63","uuid":null,"ip":"192.168.1.78","name":"volumio","server":{"ip":"192.168.1.25","name":"QNAP-TS251A","ver":"9.0.4","uuid":"40f40893-20a1-4cfc-81aa-aba27af0015d","jsonPort":"9001","cliPort":"9090"}}] Dec 18 12:51:17 volumio sudo[2590]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:17 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 18 12:51:17 volumio volumio[1150]: error: MPD error: The expression evaluated to a falsy value: Dec 18 12:51:17 volumio volumio[1150]: assert.ok(self.idling) Dec 18 12:51:17 volumio volumio[1150]: error: The expression evaluated to a falsy value: Dec 18 12:51:17 volumio volumio[1150]: assert.ok(self.idling) Dec 18 12:51:17 volumio sudo[2695]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 18 12:51:17 volumio sudo[2695]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:17 volumio volumio[1150]: error: updateQueue error: null Dec 18 12:51:17 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:51:17 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:51:17 volumio sudo[2695]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:17 volumio volumio[1150]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true Dec 18 12:51:17 volumio sudo[2698]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite Dec 18 12:51:17 volumio sudo[2698]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 12:51:17 volumio systemd[1]: Stopping squeezelite.service - Squeezelite lightweight headless Squeezebox emulator... Dec 18 12:51:17 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'disconnect' Dec 18 12:51:17 volumio volumio[1150]: info: [squeezelite_mc] 'client' notification received from QNAP-TS251A (192.168.1.25); type is 'disconnect' Dec 18 12:51:17 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Dec 18 12:51:17 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Dec 18 12:51:17 volumio volumio[1150]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 12:51:18 volumio volumio[1150]: TypeError: Cannot read properties of null (reading 'removeAllListeners') Dec 18 12:51:18 volumio volumio[1150]: at ControllerSqueezeliteMC._ControllerSqueezeliteMC_clearPlayerStatusMonitor (/data/plugins/music_service/squeezelite_mc/dist/index.js:784:88) Dec 18 12:51:18 volumio volumio[1150]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Dec 18 12:51:18 volumio volumio[1150]: at async /data/plugins/music_service/squeezelite_mc/dist/index.js:799:9 Dec 18 12:51:18 volumio volumio[1150]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 12:51:18 volumio systemd[1]: squeezelite.service: Deactivated successfully. Dec 18 12:51:18 volumio systemd[1]: Stopped squeezelite.service - Squeezelite lightweight headless Squeezebox emulator. Dec 18 12:51:18 volumio sudo[2698]: pam_unix(sudo:session): session closed for user root Dec 18 12:51:23 volumio sudo[2728]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-18 12:50' Dec 18 12:51:23 volumio sudo[2728]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"