Dec 31 09:42:55 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29:3000 from 192.168.86.237 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 31 09:42:55 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29:3000 from 192.168.86.237 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:55 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:55 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:55 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:55 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:55 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29:3000 from 192.168.86.237 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:55 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:55 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:55 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:55 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:55 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29:3000 from 192.168.86.237 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:55 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:55 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 31 09:42:55 acer-volumio sudo[3758]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 31 09:42:55 acer-volumio sudo[3758]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:42:55 acer-volumio sudo[3765]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 31 09:42:55 acer-volumio sudo[3765]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:42:55 acer-volumio sudo[3758]: pam_unix(sudo:session): session closed for user root Dec 31 09:42:55 acer-volumio sudo[3765]: pam_unix(sudo:session): session closed for user root Dec 31 09:42:55 acer-volumio sudo[3772]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 31 09:42:55 acer-volumio sudo[3772]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:42:55 acer-volumio sudo[3771]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 31 09:42:55 acer-volumio sudo[3771]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:42:55 acer-volumio sudo[3781]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 31 09:42:55 acer-volumio sudo[3786]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 31 09:42:55 acer-volumio sudo[3781]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:42:55 acer-volumio sudo[3786]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:42:55 acer-volumio sudo[3781]: pam_unix(sudo:session): session closed for user root Dec 31 09:42:55 acer-volumio sudo[3771]: pam_unix(sudo:session): session closed for user root Dec 31 09:42:55 acer-volumio sudo[3772]: pam_unix(sudo:session): session closed for user root Dec 31 09:42:55 acer-volumio sudo[3786]: pam_unix(sudo:session): session closed for user root Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:55 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:55 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:55 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:55 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:55 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:55 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29:3000 from 192.168.86.237 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 31 09:42:55 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 31 09:42:56 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29:3000 from 192.168.86.237 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 31 09:42:56 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:56 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:56 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:56 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:56 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:56 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:56 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:56 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:56 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:56 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:56 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:56 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:56 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29:3000 from 192.168.86.237 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 31 09:42:56 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 31 09:42:56 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 31 09:42:57 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 31 09:42:57 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 31 09:42:57 acer-volumio sudo[3822]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 31 09:42:57 acer-volumio sudo[3822]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:42:57 acer-volumio sudo[3822]: pam_unix(sudo:session): session closed for user root Dec 31 09:42:57 acer-volumio sudo[3824]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 31 09:42:57 acer-volumio sudo[3824]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:42:57 acer-volumio sudo[3824]: pam_unix(sudo:session): session closed for user root Dec 31 09:42:57 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29 from 192.168.86.237 UA: Mozilla/5.0 (Linux; Android 16; SM-S721B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Dec 31 09:42:58 acer-volumio sudo[3830]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 31 09:42:58 acer-volumio sudo[3830]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:42:58 acer-volumio sudo[3830]: pam_unix(sudo:session): session closed for user root Dec 31 09:42:58 acer-volumio sudo[3833]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 31 09:42:58 acer-volumio sudo[3833]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:42:58 acer-volumio sudo[3833]: pam_unix(sudo:session): session closed for user root Dec 31 09:42:58 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29 from 192.168.86.237 UA: Mozilla/5.0 (Linux; Android 16; SM-S721B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetVisibleSources Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:58 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 31 09:42:58 acer-volumio volumio[1561]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 31 09:42:58 acer-volumio volumio[1561]: info: Received Get System Info Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:58 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:58 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:58 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:58 acer-volumio volumio[1561]: info: Listing playlists Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 31 09:42:58 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29:3000 from 192.168.86.237 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:58 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:58 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:58 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29:3000 from 192.168.86.237 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:58 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:58 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:58 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:42:59 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 31 09:42:59 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29:3000 from 192.168.86.237 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Dec 31 09:42:59 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:42:59 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:42:59 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:42:59 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:42:59 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:42:59 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:43:00 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 31 09:43:00 acer-volumio volumio[1561]: info: Received Get System Info Dec 31 09:43:00 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:43:00 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:43:00 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:43:00 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:00 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:00 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:43:01 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 31 09:43:01 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 31 09:43:01 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 31 09:43:01 acer-volumio volumio[1561]: info: Received Get System Info Dec 31 09:43:01 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:43:01 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:43:01 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:43:01 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:01 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:01 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:43:01 acer-volumio volumio[1561]: verbose: New Socket.io Connection to 192.168.86.29:3000 from 192.168.86.237 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Dec 31 09:43:01 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:43:01 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:43:01 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:43:01 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:01 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:01 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:43:08 acer-volumio volumio[1561]: info: Enabling plugin squeezelite_mc Dec 31 09:43:08 acer-volumio volumio[1561]: info: Loading plugin "squeezelite_mc"... Dec 31 09:43:08 acer-volumio volumio[1561]: info: PLUGIN START: squeezelite_mc Dec 31 09:43:08 acer-volumio volumio[1561]: info: [squeezelite_mc] Starting proxy server... Dec 31 09:43:08 acer-volumio volumio[1561]: info: [squeezelite_mc] Proxy server started on port 36151 Dec 31 09:43:08 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioRetrievevolume Dec 31 09:43:08 acer-volumio volumio[1561]: info: [squeezelite_mc] Setting Squeezelite volume to 100 Dec 31 09:43:08 acer-volumio volumio[1561]: info: CoreStateMachine::pushState Dec 31 09:43:08 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:08 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioPushState Dec 31 09:43:08 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output update for this device Dec 31 09:43:08 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output Dec 31 09:43:08 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:08 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:08 acer-volumio volumio[1561]: info: Error: Error: Discovery service is already running Dec 31 09:43:08 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 31 09:43:13 acer-volumio volumio[1561]: error: [squeezelite_mc] Caught error in sendVolume(): fetch failed Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 31 09:43:16 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 31 09:43:17 acer-volumio volumio[1561]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 31 09:43:17 acer-volumio volumio[1561]: info: Received Get System Version Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 31 09:43:17 acer-volumio volumio[1561]: info: Received Get System Info Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 31 09:43:17 acer-volumio volumio[1561]: info: Discovery: Getting this device information Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:17 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 31 09:43:17 acer-volumio volumio[1561]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 31 09:43:17 acer-volumio volumio[1561]: info: Preparing to save Alsa Options, stopping services first Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:17 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioPause Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreStateMachine::pause Dec 31 09:43:17 acer-volumio volumio[1561]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"USB D/A Converter DA-250"}} Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 31 09:43:17 acer-volumio volumio[1561]: info: Device 5 does not have any Mixer Control Available Dec 31 09:43:17 acer-volumio volumio[1561]: info: QobuzConnect: setDeactiveState invoked Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:17 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:17 acer-volumio vtcs[2539]: [2025-12-31 09:43:17.979] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 31 09:43:17 acer-volumio vtcs[2539]: [2025-12-31 09:43:17.981] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=5 errorno=104 error=Connection reset by peer Dec 31 09:43:17 acer-volumio vtcs[2539]: [2025-12-31 09:43:17.981] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 31 09:43:17 acer-volumio vtcs[2539]: [2025-12-31 09:43:17.981] [tisoc] [error] [SpkconServer.cpp:472] socket write error. fd=3 errorno=32 error=Broken pipe Dec 31 09:43:17 acer-volumio sudo[3910]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 31 09:43:17 acer-volumio sudo[3910]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:17 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 31 09:43:17 acer-volumio volumio[1561]: info: Updating Volume Controller Parameters: Device: 5 Name: USB D/A Converter DA-250 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 31 09:43:18 acer-volumio volumio[1561]: info: Disabling external Volume Control Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 31 09:43:18 acer-volumio volumio[1561]: info: [squeezelite_mc] Setting Squeezelite volume to 100 Dec 31 09:43:18 acer-volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 31 09:43:18 acer-volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 31 09:43:18 acer-volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreStateMachine::pushState Dec 31 09:43:18 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioPushState Dec 31 09:43:18 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output update for this device Dec 31 09:43:18 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:18 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:18 acer-volumio sudo[3910]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:18 acer-volumio volumio[1561]: info: Preparing to generate the ALSA configuration file Dec 31 09:43:18 acer-volumio sudo[3916]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 31 09:43:18 acer-volumio sudo[3916]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 31 09:43:18 acer-volumio volumio[1561]: info: Reading ALSA contributions from plugins. Dec 31 09:43:18 acer-volumio sudo[3916]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:18 acer-volumio sudo[3923]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 31 09:43:18 acer-volumio sudo[3923]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 31 09:43:18 acer-volumio sudo[3923]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:18 acer-volumio sudo[3930]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 31 09:43:18 acer-volumio sudo[3930]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 31 09:43:18 acer-volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 31 09:43:18 acer-volumio qobuz-connect[2580]: 20251231 09:43:18.135 [2580.2580] INFO SampleApp: Stopping Local configuration server Dec 31 09:43:18 acer-volumio volumio[1561]: info: Asound.conf file unchanged, so no further update is needed Dec 31 09:43:18 acer-volumio volumio[1561]: info: Output device has changed, restarting MPD Dec 31 09:43:18 acer-volumio volumio[1561]: info: Output device has changed, restarting Shairport Sync Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:18 acer-volumio sudo[3938]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 31 09:43:18 acer-volumio sudo[3938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:18 acer-volumio sudo[3935]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 31 09:43:18 acer-volumio sudo[3935]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:18 acer-volumio volumio[1561]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 31 09:43:18 acer-volumio volumio[1561]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:18 acer-volumio sudo[3935]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:18 acer-volumio volumio[1561]: info: QobuzConnect: setDeactiveState invoked Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:18 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:18 acer-volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 31 09:43:18 acer-volumio sudo[3948]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 31 09:43:18 acer-volumio sudo[3948]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:18 acer-volumio sudo[3949]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 31 09:43:18 acer-volumio sudo[3949]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:18 acer-volumio systemd[1]: mpd.service: Deactivated successfully. Dec 31 09:43:18 acer-volumio volumio[1561]: info: MPD Permissions set Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:18 acer-volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 31 09:43:18 acer-volumio systemd[1]: mpd.service: Consumed 1.084s CPU time. Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:18 acer-volumio sudo[3948]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:18 acer-volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 31 09:43:18 acer-volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 31 09:43:18 acer-volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 31 09:43:18 acer-volumio sudo[3957]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 31 09:43:18 acer-volumio sudo[3957]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:18 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:18 acer-volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 31 09:43:18 acer-volumio volumio[1561]: info: Starting Shairport Sync Dec 31 09:43:18 acer-volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 31 09:43:18 acer-volumio sudo[3972]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 31 09:43:18 acer-volumio sudo[3972]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:18 acer-volumio sudo[3957]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:18 acer-volumio sudo[3949]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:18 acer-volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 31 09:43:18 acer-volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 31 09:43:18 acer-volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 31 09:43:18 acer-volumio systemd[1]: shairport-sync.service: Consumed 5.030s CPU time. Dec 31 09:43:18 acer-volumio sudo[3974]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 31 09:43:18 acer-volumio sudo[3974]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:18 acer-volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 31 09:43:18 acer-volumio sudo[3972]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:18 acer-volumio volumio[1561]: info: Shairport-Sync Started Dec 31 09:43:18 acer-volumio sudo[3970]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 31 09:43:18 acer-volumio sudo[3970]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 31 09:43:18 acer-volumio sudo[3970]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:18 acer-volumio mpd[3979]: 2025-12-31T09:43:18 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 31 09:43:19 acer-volumio qobuz-connect[2580]: 20251231 09:43:19.127 [2580.2580] INFO SampleApp: shat down connection on UNIX socket Dec 31 09:43:19 acer-volumio volumio[1561]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 31 09:43:19 acer-volumio volumio[1561]: info: QobuzConnect: setDeactiveState invoked Dec 31 09:43:19 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:19 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:19 acer-volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 31 09:43:19 acer-volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 31 09:43:19 acer-volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 31 09:43:19 acer-volumio sudo[3974]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:19 acer-volumio sudo[3930]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:19 acer-volumio volumio[1561]: info: Executing endpoint qc_getconfig Dec 31 09:43:19 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 31 09:43:19 acer-volumio qobuz-connect[3995]: 20251231 09:43:19.223 [3995.3995] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 31 09:43:19 acer-volumio qobuz-connect[3995]: 20251231 09:43:19.225 [3995.3995] INFO VolumeManager: [0x55bb234b0840]: Setting new playback volume: 75 Dec 31 09:43:19 acer-volumio qobuz-connect[3995]: 20251231 09:43:19.225 [3995.3995] INFO VolumeManager: [0x55bb234b0840]: Setting new mute state: 0 Dec 31 09:43:19 acer-volumio qobuz-connect[3995]: 20251231 09:43:19.225 [3995.3995] INFO QobuzConnect: [0x55bb234b1a60]: Client initialized! Dec 31 09:43:19 acer-volumio qobuz-connect[3995]: 20251231 09:43:19.225 [3995.3995] INFO SampleApp: Starting Avahi advertising, name: ACER VOLUMIO, service name: _qobuz-connect._tcp Dec 31 09:43:19 acer-volumio volumio[1561]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 31 09:43:19 acer-volumio volumio[1561]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 31 09:43:19 acer-volumio qobuz-connect[3995]: 20251231 09:43:19.233 [3995.3995] INFO LocalConfigManager: [0x55bb234afb30]: Starting Local Configuration server Dec 31 09:43:19 acer-volumio qobuz-connect[3995]: 20251231 09:43:19.233 [3995.3995] INFO SampleApp: Starting Local configuration server Dec 31 09:43:19 acer-volumio qobuz-connect[3995]: 20251231 09:43:19.234 [3995.3995] INFO SampleApp: Connected to UNIX socket client 0x55bb23486990 Dec 31 09:43:19 acer-volumio qobuz-connect[3995]: 20251231 09:43:19.373 [3995.3995] INFO SampleApp: Playback volume changed: 75 Dec 31 09:43:19 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:19 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:19 acer-volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 31 09:43:19 acer-volumio sudo[3938]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:19 acer-volumio volumio[1561]: error: updateQueue error: null Dec 31 09:43:19 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:19 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:19 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:21 acer-volumio volumio[1561]: info: TidalConnect service stoped! Dec 31 09:43:21 acer-volumio volumio[1561]: info: TidalConnect service stoped! Dec 31 09:43:21 acer-volumio volumio[1561]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 31 09:43:21 acer-volumio volumio[1561]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 31 09:43:21 acer-volumio volumio[1561]: error: [squeezelite_mc] Caught error in sendVolume(): fetch failed Dec 31 09:43:21 acer-volumio sudo[4018]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 31 09:43:21 acer-volumio sudo[4018]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:21 acer-volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 31 09:43:21 acer-volumio sudo[4018]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:21 acer-volumio volumio[1561]: info: Executing endpoint tc_getconfig Dec 31 09:43:21 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 31 09:43:21 acer-volumio vtcs[4021]: STARTING TidalConnect services, version: 1.5.2.56 Dec 31 09:43:21 acer-volumio vtcs[4021]: STARTED TidalConnect services. Dec 31 09:43:21 acer-volumio volumio[1561]: info: Executing endpoint tc_connect Dec 31 09:43:21 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 31 09:43:21 acer-volumio volumio[1561]: info: Connecting to TidalConnect Dec 31 09:43:21 acer-volumio volumio[1561]: info: CoreCommandRouter::servicePushState Dec 31 09:43:21 acer-volumio volumio[1561]: info: CoreStateMachine::pushState Dec 31 09:43:21 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:21 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioPushState Dec 31 09:43:21 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output update for this device Dec 31 09:43:21 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output Dec 31 09:43:21 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:21 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:21 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:21 acer-volumio volumio[1561]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Dec 31 09:43:21 acer-volumio volumio[1561]: info: CoreCommandRouter::servicePushState Dec 31 09:43:21 acer-volumio volumio[1561]: info: CoreStateMachine::pushState Dec 31 09:43:21 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:21 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioPushState Dec 31 09:43:21 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output update for this device Dec 31 09:43:21 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output Dec 31 09:43:21 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:21 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:21 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:21 acer-volumio volumio[1561]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Dec 31 09:43:21 acer-volumio volumio[1561]: info: TidalConnect service stoped! Dec 31 09:43:21 acer-volumio volumio[1561]: info: TidalConnect service stoped! Dec 31 09:43:21 acer-volumio volumio[1561]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 31 09:43:21 acer-volumio volumio[1561]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 31 09:43:21 acer-volumio sudo[4046]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 31 09:43:21 acer-volumio sudo[4046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:21 acer-volumio sudo[4046]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:22 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 31 09:43:22 acer-volumio volumio[1561]: info: CoreStateMachine::getcurrentVolume Dec 31 09:43:22 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioRetrievevolume Dec 31 09:43:22 acer-volumio volumio[1561]: info: [squeezelite_mc] Setting Squeezelite volume to 100 Dec 31 09:43:22 acer-volumio volumio[1561]: info: CoreStateMachine::pushState Dec 31 09:43:22 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:22 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioPushState Dec 31 09:43:22 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output update for this device Dec 31 09:43:22 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output Dec 31 09:43:22 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:22 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:22 acer-volumio sudo[4051]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 31 09:43:22 acer-volumio sudo[4051]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:22 acer-volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 31 09:43:22 acer-volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 31 09:43:22 acer-volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 31 09:43:22 acer-volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 31 09:43:22 acer-volumio sudo[4051]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:22 acer-volumio mpd_monitor.sh[4053]: MPD Monitor Service: Starting MPD Monitor Service Dec 31 09:43:22 acer-volumio volumio[1561]: info: Successfully started MPD Monitor Dec 31 09:43:24 acer-volumio volumio[1561]: info: TidalConnect service started! Dec 31 09:43:24 acer-volumio volumio[1561]: info: TidalConnect service started! Dec 31 09:43:25 acer-volumio volumio[1561]: error: [squeezelite_mc] Caught error in sendVolume(): fetch failed Dec 31 09:43:25 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 31 09:43:25 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 31 09:43:29 acer-volumio volumio[1561]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true Dec 31 09:43:29 acer-volumio volumio[1561]: info: [squeezelite_mc] Proxy server stopped Dec 31 09:43:29 acer-volumio sudo[4081]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite Dec 31 09:43:29 acer-volumio sudo[4081]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:29 acer-volumio systemd[1]: Stopping squeezelite.service - Squeezelite lightweight headless Squeezebox emulator... Dec 31 09:43:30 acer-volumio systemd[1]: squeezelite.service: Deactivated successfully. Dec 31 09:43:30 acer-volumio systemd[1]: Stopped squeezelite.service - Squeezelite lightweight headless Squeezebox emulator. Dec 31 09:43:30 acer-volumio sudo[4081]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:30 acer-volumio volumio[1561]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 31 09:43:30 acer-volumio sudo[4084]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 31 09:43:30 acer-volumio sudo[4084]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:30 acer-volumio sudo[4084]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:30 acer-volumio volumio[1561]: info: Disabling plugin squeezelite_mc Dec 31 09:43:30 acer-volumio volumio[1561]: info: Done. Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 31 09:43:40 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 31 09:43:41 acer-volumio volumio[1561]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 31 09:43:41 acer-volumio volumio[1561]: info: Preparing to save Alsa Options, stopping services first Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:41 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioPause Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreStateMachine::pause Dec 31 09:43:41 acer-volumio volumio[1561]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"USB D/A Converter DA-250"}} Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 31 09:43:41 acer-volumio volumio[1561]: info: Device 5 does not have any Mixer Control Available Dec 31 09:43:41 acer-volumio volumio[1561]: info: QobuzConnect: setDeactiveState invoked Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:41 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:41 acer-volumio vtcs[4021]: [2025-12-31 09:43:41.923] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 31 09:43:41 acer-volumio vtcs[4021]: [2025-12-31 09:43:41.923] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 31 09:43:41 acer-volumio sudo[4128]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 31 09:43:41 acer-volumio sudo[4128]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 31 09:43:41 acer-volumio volumio[1561]: info: Updating Volume Controller Parameters: Device: 5 Name: USB D/A Converter DA-250 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 31 09:43:41 acer-volumio volumio[1561]: info: Disabling external Volume Control Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 31 09:43:41 acer-volumio volumio[1561]: error: Help! Some callbacks for volumioupdatevolume are crashing! Dec 31 09:43:41 acer-volumio volumio[1561]: error: Cannot read properties of null (reading 'logger') Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreStateMachine::pushState Dec 31 09:43:41 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioPushState Dec 31 09:43:41 acer-volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 31 09:43:41 acer-volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 31 09:43:41 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output update for this device Dec 31 09:43:41 acer-volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 31 09:43:41 acer-volumio volumio[1561]: info: MRS: Pushing multiroomSync output Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:41 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:41 acer-volumio volumio[1561]: info: Preparing to generate the ALSA configuration file Dec 31 09:43:41 acer-volumio sudo[4128]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:41 acer-volumio sudo[4135]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 31 09:43:41 acer-volumio sudo[4135]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:41 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:41 acer-volumio volumio[1561]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 31 09:43:42 acer-volumio volumio[1561]: info: Reading ALSA contributions from plugins. Dec 31 09:43:42 acer-volumio sudo[4135]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:42 acer-volumio sudo[4142]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 31 09:43:42 acer-volumio sudo[4142]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 31 09:43:42 acer-volumio sudo[4142]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:42 acer-volumio sudo[4149]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 31 09:43:42 acer-volumio sudo[4149]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 31 09:43:42 acer-volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 31 09:43:42 acer-volumio qobuz-connect[3995]: 20251231 09:43:42.074 [3995.3995] INFO SampleApp: Stopping Local configuration server Dec 31 09:43:42 acer-volumio volumio[1561]: info: Asound.conf file unchanged, so no further update is needed Dec 31 09:43:42 acer-volumio volumio[1561]: info: Output device has changed, restarting MPD Dec 31 09:43:42 acer-volumio volumio[1561]: info: Output device has changed, restarting Shairport Sync Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:42 acer-volumio sudo[4155]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 31 09:43:42 acer-volumio sudo[4155]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:42 acer-volumio sudo[4155]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:42 acer-volumio sudo[4156]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 31 09:43:42 acer-volumio sudo[4156]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:42 acer-volumio volumio[1561]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 31 09:43:42 acer-volumio volumio[1561]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: QobuzConnect: setDeactiveState invoked Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:42 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:42 acer-volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 31 09:43:42 acer-volumio sudo[4167]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 31 09:43:42 acer-volumio sudo[4167]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:42 acer-volumio sudo[4168]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 31 09:43:42 acer-volumio sudo[4168]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:42 acer-volumio systemd[1]: mpd.service: Deactivated successfully. Dec 31 09:43:42 acer-volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 31 09:43:42 acer-volumio systemd[1]: mpd.service: Consumed 1.058s CPU time. Dec 31 09:43:42 acer-volumio volumio[1561]: info: MPD Permissions set Dec 31 09:43:42 acer-volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 31 09:43:42 acer-volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 31 09:43:42 acer-volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:42 acer-volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 31 09:43:42 acer-volumio sudo[4176]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 31 09:43:42 acer-volumio sudo[4176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:42 acer-volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 31 09:43:42 acer-volumio sudo[4168]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:42 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 31 09:43:42 acer-volumio sudo[4167]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:42 acer-volumio volumio[1561]: info: Starting Shairport Sync Dec 31 09:43:42 acer-volumio sudo[4176]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:42 acer-volumio sudo[4192]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 31 09:43:42 acer-volumio sudo[4192]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:42 acer-volumio sudo[4191]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 31 09:43:42 acer-volumio sudo[4191]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 31 09:43:42 acer-volumio sudo[4184]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 31 09:43:42 acer-volumio sudo[4184]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 31 09:43:42 acer-volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 31 09:43:42 acer-volumio sudo[4184]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:42 acer-volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 31 09:43:42 acer-volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 31 09:43:42 acer-volumio systemd[1]: shairport-sync.service: Consumed 1.672s CPU time. Dec 31 09:43:42 acer-volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 31 09:43:42 acer-volumio sudo[4192]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:42 acer-volumio volumio[1561]: info: Shairport-Sync Started Dec 31 09:43:42 acer-volumio mpd[4196]: 2025-12-31T09:43:42 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 31 09:43:43 acer-volumio qobuz-connect[3995]: 20251231 09:43:43.262 [3995.3995] INFO SampleApp: shat down connection on UNIX socket Dec 31 09:43:43 acer-volumio volumio[1561]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 31 09:43:43 acer-volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 31 09:43:43 acer-volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 31 09:43:43 acer-volumio volumio[1561]: info: QobuzConnect: setDeactiveState invoked Dec 31 09:43:43 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:43 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:43 acer-volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 31 09:43:43 acer-volumio sudo[4149]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:43 acer-volumio sudo[4191]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:43 acer-volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 31 09:43:43 acer-volumio sudo[4156]: pam_unix(sudo:session): session closed for user root Dec 31 09:43:43 acer-volumio volumio[1561]: info: Executing endpoint qc_getconfig Dec 31 09:43:43 acer-volumio volumio[1561]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 31 09:43:43 acer-volumio qobuz-connect[4217]: 20251231 09:43:43.341 [4217.4217] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 31 09:43:43 acer-volumio qobuz-connect[4217]: 20251231 09:43:43.348 [4217.4217] INFO VolumeManager: [0x564201785840]: Setting new playback volume: 75 Dec 31 09:43:43 acer-volumio qobuz-connect[4217]: 20251231 09:43:43.348 [4217.4217] INFO VolumeManager: [0x564201785840]: Setting new mute state: 0 Dec 31 09:43:43 acer-volumio qobuz-connect[4217]: 20251231 09:43:43.348 [4217.4217] INFO QobuzConnect: [0x564201786a60]: Client initialized! Dec 31 09:43:43 acer-volumio qobuz-connect[4217]: 20251231 09:43:43.348 [4217.4217] INFO SampleApp: Starting Avahi advertising, name: ACER VOLUMIO, service name: _qobuz-connect._tcp Dec 31 09:43:43 acer-volumio volumio[1561]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 31 09:43:43 acer-volumio volumio[1561]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 31 09:43:43 acer-volumio qobuz-connect[4217]: 20251231 09:43:43.352 [4217.4217] INFO LocalConfigManager: [0x564201784b30]: Starting Local Configuration server Dec 31 09:43:43 acer-volumio qobuz-connect[4217]: 20251231 09:43:43.352 [4217.4217] INFO SampleApp: Starting Local configuration server Dec 31 09:43:43 acer-volumio qobuz-connect[4217]: 20251231 09:43:43.353 [4217.4217] INFO SampleApp: Connected to UNIX socket client 0x56420175b990 Dec 31 09:43:43 acer-volumio volumio[1561]: error: updateQueue error: null Dec 31 09:43:43 acer-volumio qobuz-connect[4217]: 20251231 09:43:43.491 [4217.4217] INFO SampleApp: Playback volume changed: 75 Dec 31 09:43:43 acer-volumio volumio[1561]: info: CoreCommandRouter::volumioGetState Dec 31 09:43:43 acer-volumio volumio[1561]: info: CorePlayQueue::getTrack 0 Dec 31 09:43:43 acer-volumio volumio[1561]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 31 09:43:43 acer-volumio volumio[1561]: TypeError: Cannot read properties of null (reading 'logger') Dec 31 09:43:43 acer-volumio volumio[1561]: at SqueezeliteMCContext.getLogger (/data/plugins/music_service/squeezelite_mc/dist/lib/SqueezeliteMCContext.js:65:86) Dec 31 09:43:43 acer-volumio volumio[1561]: at ControllerSqueezeliteMC._ControllerSqueezeliteMC_stdLogError (/data/plugins/music_service/squeezelite_mc/dist/index.js:716:36) Dec 31 09:43:43 acer-volumio volumio[1561]: at /data/plugins/music_service/squeezelite_mc/dist/index.js:1216:121 Dec 31 09:43:43 acer-volumio volumio[1561]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 31 09:43:43 acer-volumio sudo[4242]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-31 09:42' Dec 31 09:43:43 acer-volumio sudo[4242]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"