Feb 08 15:22:01 volumio volumio[1177]: verbose: New Socket.io Connection to 192.168.0.194 from 192.168.0.126 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:03 volumio volumio[1177]: info: Received Get System Info Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:22:03 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::volumioGetVisibleSources Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 08 15:22:03 volumio volumio[1177]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 08 15:22:03 volumio volumio[1177]: info: Received Get System Info Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:22:03 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:03 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: Listing playlists Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetQueue Feb 08 15:22:04 volumio volumio[1177]: info: CoreStateMachine::getQueue Feb 08 15:22:04 volumio volumio[1177]: info: CorePlayQueue::getQueue Feb 08 15:22:04 volumio volumio[1177]: info: Received Get System Info Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:22:04 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetVisibleSources Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 08 15:22:04 volumio volumio[1177]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 08 15:22:04 volumio volumio[1177]: info: Received Get System Info Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:22:04 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: Listing playlists Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetQueue Feb 08 15:22:04 volumio volumio[1177]: info: CoreStateMachine::getQueue Feb 08 15:22:04 volumio volumio[1177]: info: CorePlayQueue::getQueue Feb 08 15:22:04 volumio volumio[1177]: info: Received Get System Info Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:22:04 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetVisibleSources Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 08 15:22:04 volumio volumio[1177]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 08 15:22:04 volumio volumio[1177]: info: Received Get System Info Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:22:04 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:04 volumio volumio[1177]: info: Listing playlists Feb 08 15:22:04 volumio volumio[1177]: info: CoreCommandRouter::volumioGetQueue Feb 08 15:22:04 volumio volumio[1177]: info: CoreStateMachine::getQueue Feb 08 15:22:04 volumio volumio[1177]: info: CorePlayQueue::getQueue Feb 08 15:22:05 volumio volumio[1177]: info: Received Get System Info Feb 08 15:22:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:22:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:22:05 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:22:05 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:22:05 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 08 15:22:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 08 15:22:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 08 15:22:06 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 15:22:06 volumio volumio[1177]: info: Received Get System Info Feb 08 15:22:06 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:22:06 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:22:06 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:22:06 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:06 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:22:38 volumio volumio[1177]: verbose: New Socket.io Connection to 192.168.0.194:3000 from 192.168.0.30 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Feb 08 15:22:38 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:22:38 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:22:38 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:22:38 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:38 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:22:38 volumio sudo[2317]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 15:22:38 volumio sudo[2317]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:38 volumio sudo[2317]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:38 volumio sudo[2320]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 15:22:38 volumio sudo[2320]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:38 volumio sudo[2320]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:38 volumio volumio[1177]: verbose: New Socket.io Connection to 192.168.0.194 from 192.168.0.30 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Feb 08 15:22:38 volumio volumio[1177]: verbose: New Socket.io Connection to 192.168.0.194 from 192.168.0.30 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Feb 08 15:22:38 volumio volumio[1177]: info: CoreCommandRouter::volumioGetVisibleSources Feb 08 15:22:38 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 15:22:38 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Feb 08 15:22:38 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Feb 08 15:22:39 volumio volumio[1177]: info: Received Get System Info Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:22:39 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:22:39 volumio volumio-remote-updater[821]: Test mode disabled Feb 08 15:22:39 volumio volumio-remote-updater[821]: Alpha mode disabled Feb 08 15:22:39 volumio volumio-remote-updater[821]: Alpha legacy test mode disabled Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:39 volumio volumio[1177]: info: Retrieving Cloud Streaming UI Feb 08 15:22:39 volumio volumio[1177]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::volumioGetVisibleSources Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:39 volumio volumio[1177]: info: Retrieving Cloud Streaming UI Feb 08 15:22:39 volumio volumio[1177]: info: Getting Tidal Cloud Configuration Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:39 volumio volumio[1177]: info: Getting Qobuz Cloud Configuration Feb 08 15:22:39 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:39 volumio volumio[1177]: info: Getting Spotify Cloud Configuration Feb 08 15:22:39 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:39 volumio volumio[1177]: info: Saving Spotify Acccount Feb 08 15:22:39 volumio volumio[1177]: info: Got it Feb 08 15:22:39 volumio volumio[1177]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 08 15:22:39 volumio volumio[1177]: info: Getting Tidal Cloud Configuration Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:39 volumio volumio[1177]: info: Getting Qobuz Cloud Configuration Feb 08 15:22:39 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:39 volumio volumio[1177]: info: Getting Spotify Cloud Configuration Feb 08 15:22:39 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:39 volumio volumio[1177]: info: Saving Spotify Acccount Feb 08 15:22:39 volumio volumio[1177]: info: Got it Feb 08 15:22:39 volumio volumio[1177]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 08 15:22:39 volumio volumio[1177]: info: Got Tidal Cloud Configuration Feb 08 15:22:39 volumio volumio[1177]: info: Got it Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:39 volumio volumio[1177]: info: Got Tidal Cloud Configuration Feb 08 15:22:39 volumio volumio[1177]: info: Got it Feb 08 15:22:39 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:40 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 08 15:22:40 volumio volumio[1177]: info: Loading i18n strings for locale pl Feb 08 15:22:40 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 08 15:22:40 volumio volumio[1177]: info: Setting timezone to Europe/Warsaw Feb 08 15:22:40 volumio sudo[2329]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 08 15:22:40 volumio sudo[2329]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:40 volumio sudo[2329]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:40 volumio sudo[2333]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Feb 08 15:22:40 volumio sudo[2333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:40 volumio sudo[2333]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:40 volumio sudo[2337]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 08 15:22:40 volumio sudo[2337]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:40 volumio sudo[2337]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:40 volumio sudo[2341]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Feb 08 15:22:40 volumio sudo[2341]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:41 volumio dbus-daemon[809]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.34' (uid=0 pid=2342 comm="/usr/bin/timedatectl set-timezone Europe/Warsaw") Feb 08 15:22:41 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Feb 08 15:22:41 volumio dbus-daemon[809]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 08 15:22:41 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Feb 08 15:22:41 volumio sudo[2341]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:41 volumio volumio[1177]: info: Fetching Streaming Services browse cache Feb 08 15:22:41 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 15:22:41 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 08 15:22:41 volumio volumio[1177]: info: Loading i18n strings for locale pl Feb 08 15:22:41 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 08 15:22:41 volumio volumio[1177]: info: Setting timezone to Europe/Warsaw Feb 08 15:22:41 volumio sudo[2348]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 08 15:22:41 volumio sudo[2348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:41 volumio sudo[2348]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:41 volumio sudo[2352]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Feb 08 15:22:41 volumio sudo[2352]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:41 volumio sudo[2352]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:42 volumio sudo[2356]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 08 15:22:42 volumio sudo[2356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:42 volumio sudo[2356]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:42 volumio sudo[2360]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Feb 08 15:22:42 volumio sudo[2360]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:42 volumio sudo[2360]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:42 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Feb 08 15:22:42 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Feb 08 15:22:42 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 15:22:42 volumio sudo[2363]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 08 15:22:42 volumio volumio[1177]: info: Fetching Streaming Services browse cache Feb 08 15:22:42 volumio sudo[2363]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:42 volumio volumio[1177]: Updating browse sources language Feb 08 15:22:42 volumio volumio[1177]: Cannot find translation for source RADIO 357 Feb 08 15:22:42 volumio volumio[1177]: Cannot find translation for source Radio Paradise Feb 08 15:22:42 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 15:22:42 volumio volumio[1177]: Cannot find translation for source RADIO 357 Feb 08 15:22:42 volumio volumio[1177]: Cannot find translation for source Radio Paradise Feb 08 15:22:42 volumio volumio[1177]: Updating browse sources language Feb 08 15:22:42 volumio volumio[1177]: Cannot find translation for source RADIO 357 Feb 08 15:22:42 volumio volumio[1177]: Cannot find translation for source Radio Paradise Feb 08 15:22:42 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 15:22:42 volumio volumio[1177]: Cannot find translation for source RADIO 357 Feb 08 15:22:42 volumio volumio[1177]: Cannot find translation for source Radio Paradise Feb 08 15:22:43 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Feb 08 15:22:43 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Feb 08 15:22:43 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 08 15:22:43 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:43 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 08 15:22:45 volumio sudo[2363]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:50 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Feb 08 15:22:50 volumio volumio[1177]: info: Preparing to save Alsa Options, stopping services first Feb 08 15:22:50 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:50 volumio volumio[1177]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"value":"generic-dac","label":"Generic I2S DAC"},"output_device":{"value":1,"label":"Generic I2S DAC"},"disallowPush":true} Feb 08 15:22:50 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 08 15:22:50 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Feb 08 15:22:50 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:50 volumio volumio[1177]: info: Enabling I2S DAC: Generic I2S DAC Feb 08 15:22:50 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Feb 08 15:22:50 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:50 volumio sudo[2386]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Feb 08 15:22:50 volumio sudo[2386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:50 volumio sudo[2386]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:50 volumio volumio[1177]: info: No Overlays Loaded Feb 08 15:22:50 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:51 volumio sudo[2389]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-dac Feb 08 15:22:51 volumio sudo[2389]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:51 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Feb 08 15:22:51 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Feb 08 15:22:51 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Feb 08 15:22:51 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Feb 08 15:22:51 volumio volumio[1177]: warn: Unable to locate the device Generic I2S DAC a reboot may be required. Feb 08 15:22:51 volumio sudo[2389]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:51 volumio (udev-worker)[2401]: controlC2: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 2' failed with exit code 99. Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:51 volumio volumio[1177]: info: Device 2 does not have any Mixer Control Available Feb 08 15:22:51 volumio volumio[1177]: info: QobuzConnect: setDeactiveState invoked Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:51 volumio vtcs[2044]: [2026-02-08 15:22:51.593] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Feb 08 15:22:51 volumio vtcs[2044]: [2026-02-08 15:22:51.605] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 08 15:22:51 volumio volumio[1177]: info: Updating Volume Controller Parameters: Device: 2 Name: Generic I2S DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 08 15:22:51 volumio sudo[2410]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 08 15:22:51 volumio volumio[1177]: info: Disabling external Volume Control Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:51 volumio sudo[2410]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Feb 08 15:22:51 volumio volumio[1177]: info: CoreStateMachine::pushState Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::volumioPushState Feb 08 15:22:51 volumio volumio[1177]: info: MRS: Pushing multiroomSync output update for this device Feb 08 15:22:51 volumio volumio[1177]: info: MRS: Pushing multiroomSync output Feb 08 15:22:51 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Feb 08 15:22:51 volumio systemd[1]: vtcs.service: Killing process 2049 (vtcs) with signal SIGKILL. Feb 08 15:22:51 volumio systemd[1]: vtcs.service: Deactivated successfully. Feb 08 15:22:51 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Feb 08 15:22:51 volumio sudo[2410]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:51 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:52 volumio volumio[1177]: info: Preparing to generate the ALSA configuration file Feb 08 15:22:52 volumio sudo[2418]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 08 15:22:52 volumio sudo[2418]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:52 volumio volumio[1177]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 08 15:22:52 volumio volumio[1177]: info: Reading ALSA contributions from plugins. Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:52 volumio volumio[1177]: info: Retrieving Cloud Streaming UI Feb 08 15:22:52 volumio sudo[2418]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Feb 08 15:22:52 volumio sudo[2425]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 08 15:22:52 volumio sudo[2425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:52 volumio sudo[2425]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Feb 08 15:22:52 volumio sudo[2433]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 08 15:22:52 volumio sudo[2433]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:52 volumio qobuz-connect[1976]: 20260208 15:22:52.533 [1976.1976] INFO SampleApp: Stopping Local configuration server Feb 08 15:22:52 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 08 15:22:52 volumio volumio[1177]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Feb 08 15:22:52 volumio volumio[1177]: info: I2S Param [object Object] successfully enabled Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:52 volumio volumio[1177]: info: Retrieving Cloud Streaming UI Feb 08 15:22:52 volumio volumio[1177]: info: Getting Tidal Cloud Configuration Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:52 volumio volumio[1177]: info: Getting Qobuz Cloud Configuration Feb 08 15:22:52 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:52 volumio volumio[1177]: info: Getting Spotify Cloud Configuration Feb 08 15:22:52 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:52 volumio volumio[1177]: info: Saving Spotify Acccount Feb 08 15:22:52 volumio volumio[1177]: info: Got it Feb 08 15:22:52 volumio volumio[1177]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:52 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 08 15:22:52 volumio volumio[1177]: info: Getting Alsa Cards List without I2S DAC Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 08 15:22:53 volumio volumio[1177]: info: Getting Tidal Cloud Configuration Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:53 volumio volumio[1177]: info: Getting Qobuz Cloud Configuration Feb 08 15:22:53 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:53 volumio volumio[1177]: info: Getting Spotify Cloud Configuration Feb 08 15:22:53 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:53 volumio volumio[1177]: info: Saving Spotify Acccount Feb 08 15:22:53 volumio volumio[1177]: info: Got it Feb 08 15:22:53 volumio volumio[1177]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 08 15:22:53 volumio volumio[1177]: info: Got Tidal Cloud Configuration Feb 08 15:22:53 volumio volumio[1177]: info: Got it Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:53 volumio volumio[1177]: info: Got Tidal Cloud Configuration Feb 08 15:22:53 volumio volumio[1177]: info: Got it Feb 08 15:22:53 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:53 volumio volumio[1177]: info: Asound.conf file written Feb 08 15:22:53 volumio sudo[2468]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 08 15:22:53 volumio sudo[2468]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:53 volumio sudo[2468]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:54 volumio volumio[1177]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Feb 08 15:22:54 volumio volumio[1177]: No state is present for card b1 Feb 08 15:22:54 volumio volumio[1177]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Feb 08 15:22:54 volumio volumio[1177]: /usr/share/alsa/init/bcm2835:14: control element not found Feb 08 15:22:54 volumio volumio[1177]: No state is present for card b1 Feb 08 15:22:54 volumio volumio[1177]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Feb 08 15:22:54 volumio volumio[1177]: No state is present for card Headphones Feb 08 15:22:54 volumio volumio[1177]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Feb 08 15:22:54 volumio volumio[1177]: /usr/share/alsa/init/bcm2835:20: control element not found Feb 08 15:22:54 volumio volumio[1177]: No state is present for card Headphones Feb 08 15:22:54 volumio volumio[1177]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Feb 08 15:22:54 volumio volumio[1177]: No state is present for card sndrpihifiberry Feb 08 15:22:54 volumio volumio[1177]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Feb 08 15:22:54 volumio volumio[1177]: Found hardware: "RPi-simple" "" "" "" "" Feb 08 15:22:54 volumio volumio[1177]: Hardware is initialized using a generic method Feb 08 15:22:54 volumio volumio[1177]: No state is present for card sndrpihifiberry Feb 08 15:22:54 volumio volumio[1177]: info: Output device has changed, restarting MPD Feb 08 15:22:54 volumio volumio[1177]: info: Output device has changed, restarting Shairport Sync Feb 08 15:22:54 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:54 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:54 volumio qobuz-connect[1976]: 20260208 15:22:54.085 [1976.1976] INFO SampleApp: shat down connection on UNIX socket Feb 08 15:22:54 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 08 15:22:54 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 08 15:22:54 volumio sudo[2476]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 15:22:54 volumio sudo[2476]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:54 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 08 15:22:54 volumio sudo[2474]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 15:22:54 volumio sudo[2474]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:54 volumio sudo[2433]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:54 volumio volumio[1177]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 15:22:54 volumio volumio[1177]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 08 15:22:54 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:54 volumio sudo[2474]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:54 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 08 15:22:54 volumio volumio[1177]: info: QobuzConnect: setDeactiveState invoked Feb 08 15:22:54 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:54 volumio upmpdcli[1638]: :2:../src/mpdcli.cxx:243::MPDCli::eventloop: mpd_run_idle_mask returned 0 Feb 08 15:22:54 volumio volumio[1177]: info: Output device has changed, restarting MPD Feb 08 15:22:54 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 15:22:54 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 15:22:54 volumio systemd[1]: mpd.service: Consumed 1.415s CPU time. Feb 08 15:22:54 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 15:22:54 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 15:22:54 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 15:22:54 volumio sudo[2487]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 08 15:22:54 volumio sudo[2487]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:54 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 15:22:54 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 15:22:54 volumio sudo[2490]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 15:22:54 volumio volumio[1177]: info: Output device has changed, restarting Shairport Sync Feb 08 15:22:54 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:54 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:54 volumio sudo[2490]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:54 volumio sudo[2494]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 15:22:54 volumio sudo[2494]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 15:22:54 volumio sudo[2487]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:54 volumio sudo[2494]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:54 volumio sudo[2490]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:54 volumio sudo[2493]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 15:22:54 volumio volumio[1177]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 15:22:54 volumio volumio[1177]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 08 15:22:54 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:54 volumio sudo[2493]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:54 volumio volumio[1177]: info: QobuzConnect: setDeactiveState invoked Feb 08 15:22:54 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:54 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 15:22:54 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 15:22:54 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 15:22:54 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 15:22:54 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 15:22:54 volumio sudo[2507]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 08 15:22:54 volumio sudo[2507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:54 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 15:22:54 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 15:22:54 volumio sudo[2512]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 08 15:22:54 volumio sudo[2513]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 08 15:22:54 volumio sudo[2507]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:54 volumio sudo[2512]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:54 volumio sudo[2513]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:54 volumio sudo[2516]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 15:22:54 volumio sudo[2516]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 15:22:54 volumio sudo[2516]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:55 volumio sudo[2521]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 08 15:22:55 volumio sudo[2521]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:55 volumio sudo[2512]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:55 volumio sudo[2513]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:55 volumio sudo[2521]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:55 volumio volumio[1177]: info: Retrieving Cloud Streaming UI Feb 08 15:22:55 volumio volumio[1177]: info: MPD Permissions set Feb 08 15:22:55 volumio volumio[1177]: info: MPD Permissions set Feb 08 15:22:55 volumio volumio[1177]: info: TidalConnect service stoped! Feb 08 15:22:55 volumio volumio[1177]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 08 15:22:55 volumio volumio[1177]: info: QobuzConnect: setDeactiveState invoked Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:55 volumio sudo[2532]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 08 15:22:55 volumio volumio[1177]: info: Executing endpoint qc_getconfig Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 08 15:22:55 volumio sudo[2532]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:55 volumio qobuz-connect[2479]: 20260208 15:22:55.317 [2479.2479] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 08 15:22:55 volumio qobuz-connect[2479]: 20260208 15:22:55.322 [2479.2479] INFO VolumeManager: [0x917368]: Setting new playback volume: 75 Feb 08 15:22:55 volumio qobuz-connect[2479]: 20260208 15:22:55.322 [2479.2479] INFO VolumeManager: [0x917368]: Setting new mute state: 0 Feb 08 15:22:55 volumio qobuz-connect[2479]: 20260208 15:22:55.322 [2479.2479] INFO QobuzConnect: [0x917d38]: Client initialized! Feb 08 15:22:55 volumio qobuz-connect[2479]: 20260208 15:22:55.322 [2479.2479] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Feb 08 15:22:55 volumio volumio[1177]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 08 15:22:55 volumio qobuz-connect[2479]: 20260208 15:22:55.349 [2479.2479] INFO LocalConfigManager: [0x916c48]: Starting Local Configuration server Feb 08 15:22:55 volumio qobuz-connect[2479]: 20260208 15:22:55.350 [2479.2479] INFO SampleApp: Starting Local configuration server Feb 08 15:22:55 volumio qobuz-connect[2479]: 20260208 15:22:55.350 [2479.2479] INFO SampleApp: Connected to UNIX socket client 0x901818 Feb 08 15:22:55 volumio volumio[1177]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 08 15:22:55 volumio sudo[2535]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 08 15:22:55 volumio sudo[2535]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:55 volumio sudo[2532]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio qobuz-connect[2479]: 20260208 15:22:55.467 [2479.2479] INFO SampleApp: Playback volume changed: 75 Feb 08 15:22:55 volumio qobuz-connect[2479]: 20260208 15:22:55.480 [2479.2479] INFO SampleApp: Stopping Local configuration server Feb 08 15:22:55 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 08 15:22:55 volumio sudo[2543]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio sudo[2543]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::Reload Ui Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Feb 08 15:22:55 volumio volumio[1177]: info: Wizard terminated Successfully Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::volumiosetStartupVolume Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:55 volumio volumio[1177]: info: Player Reboot required after I2S DAC has been enabled in wizard Feb 08 15:22:55 volumio volumio[1177]: info: TidalConnect service stoped! Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Feb 08 15:22:55 volumio volumio[1177]: info: CoreStateMachine::getcurrentVolume Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 15:22:55 volumio volumio[1177]: info: CoreStateMachine::pushState Feb 08 15:22:55 volumio volumio[1177]: info: CoreCommandRouter::volumioPushState Feb 08 15:22:56 volumio volumio[1177]: info: MRS: Pushing multiroomSync output update for this device Feb 08 15:22:56 volumio volumio[1177]: info: MRS: Pushing multiroomSync output Feb 08 15:22:56 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:56 volumio volumio[1177]: info: Getting Tidal Cloud Configuration Feb 08 15:22:56 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:56 volumio volumio[1177]: info: Getting Qobuz Cloud Configuration Feb 08 15:22:56 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:56 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:56 volumio volumio[1177]: info: Getting Spotify Cloud Configuration Feb 08 15:22:56 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:56 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:56 volumio volumio[1177]: info: Saving Spotify Acccount Feb 08 15:22:56 volumio volumio[1177]: info: Got it Feb 08 15:22:56 volumio volumio[1177]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 08 15:22:56 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:56 volumio volumio[1177]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.WoZlDdqcs5QM7f1YZAwnuNdsOiD3.62196d96712bc70858b24389cc387675.state.status' Feb 08 15:22:56 volumio mpd[2529]: 2026-02-08T15:22:56 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 08 15:22:56 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 08 15:22:56 volumio upmpdcli[1638]: :3:../src/mpdcli.cxx:148::MPDCli::startEventLoop: already started Feb 08 15:22:56 volumio sudo[2493]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:56 volumio sudo[2476]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:56 volumio volumio[1177]: info: Starting Shairport Sync Feb 08 15:22:56 volumio volumio[1177]: info: Starting Shairport Sync Feb 08 15:22:56 volumio sudo[2566]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 08 15:22:56 volumio sudo[2566]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:56 volumio sudo[2568]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 08 15:22:56 volumio sudo[2568]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:56 volumio volumio[1177]: info: Preparing to generate the ALSA configuration file Feb 08 15:22:56 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 08 15:22:56 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 08 15:22:56 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 08 15:22:56 volumio systemd[1]: shairport-sync.service: Consumed 1.947s CPU time. Feb 08 15:22:56 volumio volumio[1177]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 08 15:22:56 volumio volumio[1177]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 08 15:22:56 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 08 15:22:56 volumio sudo[2566]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:56 volumio sudo[2568]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:56 volumio volumio[1177]: info: Got Tidal Cloud Configuration Feb 08 15:22:56 volumio volumio[1177]: error: MPD error: The expression evaluated to a falsy value: Feb 08 15:22:56 volumio volumio[1177]: assert.ok(self.idling) Feb 08 15:22:56 volumio volumio[1177]: error: The expression evaluated to a falsy value: Feb 08 15:22:56 volumio volumio[1177]: assert.ok(self.idling) Feb 08 15:22:56 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:56 volumio volumio[1177]: info: Retrieving Cloud Streaming UI Feb 08 15:22:56 volumio volumio[1177]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 08 15:22:56 volumio volumio[1177]: info: Reading ALSA contributions from plugins. Feb 08 15:22:56 volumio volumio[1177]: info: Got it Feb 08 15:22:56 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:56 volumio volumio[1177]: error: updateQueue error: null Feb 08 15:22:56 volumio volumio[1177]: info: Shairport-Sync Started Feb 08 15:22:56 volumio volumio[1177]: info: Shairport-Sync Started Feb 08 15:22:56 volumio sudo[2590]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 08 15:22:56 volumio sudo[2590]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:56 volumio volumio[1177]: info: Getting Tidal Cloud Configuration Feb 08 15:22:56 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:56 volumio volumio[1177]: info: Getting Qobuz Cloud Configuration Feb 08 15:22:56 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:56 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:56 volumio volumio[1177]: info: Getting Spotify Cloud Configuration Feb 08 15:22:56 volumio volumio[1177]: info: Asking plugin for UI Config Feb 08 15:22:56 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:56 volumio volumio[1177]: info: Saving Spotify Acccount Feb 08 15:22:56 volumio volumio[1177]: info: Got it Feb 08 15:22:56 volumio volumio[1177]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 08 15:22:56 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Feb 08 15:22:57 volumio sudo[2590]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:57 volumio qobuz-connect[2479]: 20260208 15:22:57.364 [2479.2479] INFO SampleApp: shat down connection on UNIX socket Feb 08 15:22:57 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 08 15:22:57 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 08 15:22:57 volumio volumio[1177]: info: Asound.conf file unchanged, so no further update is needed Feb 08 15:22:57 volumio volumio[1177]: info: Output device has changed, restarting MPD Feb 08 15:22:57 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 08 15:22:57 volumio sudo[2543]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:57 volumio sudo[2535]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:57 volumio volumio[1177]: info: Output device has changed, restarting Shairport Sync Feb 08 15:22:57 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:57 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:57 volumio sudo[2600]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 15:22:57 volumio sudo[2600]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:57 volumio sudo[2600]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:57 volumio volumio[1177]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 15:22:57 volumio volumio[1177]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 08 15:22:57 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:57 volumio sudo[2602]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 15:22:57 volumio sudo[2602]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:57 volumio volumio[1177]: info: QobuzConnect: setDeactiveState invoked Feb 08 15:22:57 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:57 volumio volumio[1177]: info: Preparing to generate the ALSA configuration file Feb 08 15:22:57 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 08 15:22:57 volumio upmpdcli[1638]: :2:../src/mpdcli.cxx:243::MPDCli::eventloop: mpd_run_idle_mask returned 0 Feb 08 15:22:57 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 15:22:57 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 15:22:57 volumio systemd[1]: mpd.service: Consumed 1.503s CPU time. Feb 08 15:22:57 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 15:22:57 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 15:22:57 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 15:22:57 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 15:22:57 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 15:22:57 volumio volumio[1177]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 08 15:22:57 volumio volumio[1177]: info: Reading ALSA contributions from plugins. Feb 08 15:22:57 volumio sudo[2615]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 08 15:22:57 volumio sudo[2615]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:57 volumio sudo[2612]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 08 15:22:57 volumio sudo[2612]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:58 volumio sudo[2620]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 15:22:58 volumio sudo[2620]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 15:22:58 volumio sudo[2620]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:58 volumio volumio[1177]: info: Executing endpoint tc_getconfig Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 08 15:22:58 volumio volumio[1177]: info: Got Tidal Cloud Configuration Feb 08 15:22:58 volumio volumio[1177]: info: Got it Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 15:22:58 volumio vtcs[2595]: STARTING TidalConnect services, version: 1.5.2.56 Feb 08 15:22:58 volumio vtcs[2595]: STARTED TidalConnect services. Feb 08 15:22:58 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Feb 08 15:22:58 volumio systemd[1]: vtcs.service: Killing process 2632 (vtcs) with signal SIGKILL. Feb 08 15:22:58 volumio systemd[1]: vtcs.service: Deactivated successfully. Feb 08 15:22:58 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Feb 08 15:22:58 volumio sudo[2623]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 08 15:22:58 volumio sudo[2623]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:58 volumio sudo[2615]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:58 volumio sudo[2623]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:58 volumio volumio[1177]: info: MPD Permissions set Feb 08 15:22:58 volumio sudo[2612]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:58 volumio sudo[2635]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 08 15:22:58 volumio sudo[2635]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:58 volumio volumio[1177]: info: TidalConnect service stoped! Feb 08 15:22:58 volumio volumio[1177]: info: TidalConnect service stoped! Feb 08 15:22:58 volumio volumio[1177]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 08 15:22:58 volumio volumio[1177]: info: QobuzConnect: setDeactiveState invoked Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:58 volumio sudo[2640]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 15:22:58 volumio sudo[2640]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:58 volumio volumio[1177]: info: Executing endpoint qc_getconfig Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 08 15:22:58 volumio sudo[2640]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:58 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 08 15:22:58 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 08 15:22:58 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 08 15:22:58 volumio sudo[2642]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 15:22:58 volumio volumio[1177]: info: TidalConnect service stoped! Feb 08 15:22:58 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 08 15:22:58 volumio sudo[2635]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:58 volumio sudo[2642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:58 volumio volumio[1177]: info: TidalConnect service stoped! Feb 08 15:22:58 volumio sudo[2642]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:58 volumio volumio[1177]: info: Executing endpoint tc_connect Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 08 15:22:58 volumio volumio[1177]: info: Connecting to TidalConnect Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:58 volumio volumio[1177]: info: Executing endpoint qc_getconfig Feb 08 15:22:58 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 08 15:22:58 volumio qobuz-connect[2647]: 20260208 15:22:58.892 [2647.2647] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 08 15:22:58 volumio qobuz-connect[2647]: 20260208 15:22:58.896 [2647.2647] INFO VolumeManager: [0x168b368]: Setting new playback volume: 75 Feb 08 15:22:58 volumio qobuz-connect[2647]: 20260208 15:22:58.897 [2647.2647] INFO VolumeManager: [0x168b368]: Setting new mute state: 0 Feb 08 15:22:58 volumio qobuz-connect[2647]: 20260208 15:22:58.897 [2647.2647] INFO QobuzConnect: [0x168bd38]: Client initialized! Feb 08 15:22:58 volumio qobuz-connect[2647]: 20260208 15:22:58.897 [2647.2647] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Feb 08 15:22:58 volumio qobuz-connect[2647]: 20260208 15:22:58.912 [2647.2647] INFO LocalConfigManager: [0x168ac48]: Starting Local Configuration server Feb 08 15:22:58 volumio qobuz-connect[2647]: 20260208 15:22:58.912 [2647.2647] INFO SampleApp: Starting Local configuration server Feb 08 15:22:58 volumio qobuz-connect[2647]: 20260208 15:22:58.912 [2647.2647] INFO SampleApp: Connected to UNIX socket client 0x1675818 Feb 08 15:22:58 volumio volumio[1177]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 08 15:22:58 volumio volumio[1177]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 08 15:22:58 volumio volumio[1177]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 08 15:22:58 volumio volumio[1177]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 08 15:22:59 volumio volumio[1177]: verbose: New Socket.io Connection to 192.168.0.194 from 192.168.0.126 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 08 15:22:59 volumio qobuz-connect[2647]: 20260208 15:22:59.043 [2647.2647] INFO SampleApp: Playback volume changed: 75 Feb 08 15:22:59 volumio volumio[1177]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 08 15:22:59 volumio volumio[1177]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 08 15:22:59 volumio volumio[1177]: info: Starting Shairport Sync Feb 08 15:22:59 volumio volumio[1177]: info: Asound.conf file unchanged, so no further update is needed Feb 08 15:22:59 volumio volumio[1177]: info: Output device has changed, restarting MPD Feb 08 15:22:59 volumio sudo[2676]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 08 15:22:59 volumio sudo[2676]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:59 volumio volumio[1177]: info: Output device has changed, restarting Shairport Sync Feb 08 15:22:59 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:59 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:22:59 volumio sudo[2678]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 15:22:59 volumio sudo[2678]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:59 volumio sudo[2678]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:59 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 08 15:22:59 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 08 15:22:59 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 08 15:22:59 volumio systemd[1]: shairport-sync.service: Consumed 1.132s CPU time. Feb 08 15:22:59 volumio volumio[1177]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 15:22:59 volumio volumio[1177]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 08 15:22:59 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:22:59 volumio sudo[2682]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 15:22:59 volumio sudo[2682]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:59 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 08 15:22:59 volumio volumio[1177]: info: QobuzConnect: setDeactiveState invoked Feb 08 15:22:59 volumio sudo[2676]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:59 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:22:59 volumio sudo[2692]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 08 15:22:59 volumio sudo[2692]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:59 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 15:22:59 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 15:22:59 volumio systemd[1]: mpd.service: Consumed 1.483s CPU time. Feb 08 15:22:59 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 15:22:59 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 15:22:59 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 15:22:59 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 15:22:59 volumio sudo[2710]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 08 15:22:59 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 15:22:59 volumio sudo[2710]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:22:59 volumio sudo[2692]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:59 volumio sudo[2711]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 15:22:59 volumio sudo[2711]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 15:22:59 volumio sudo[2711]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:59 volumio sudo[2710]: pam_unix(sudo:session): session closed for user root Feb 08 15:22:59 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 08 15:23:00 volumio sudo[2722]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 08 15:23:00 volumio sudo[2722]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:00 volumio sudo[2722]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:00 volumio sudo[2725]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::volumioGetVisibleSources Feb 08 15:23:00 volumio sudo[2725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::volumioGetQueue Feb 08 15:23:00 volumio volumio[1177]: info: CoreStateMachine::getQueue Feb 08 15:23:00 volumio volumio[1177]: info: CorePlayQueue::getQueue Feb 08 15:23:00 volumio volumio[1177]: info: Listing playlists Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 08 15:23:00 volumio volumio[1177]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 08 15:23:00 volumio sudo[2727]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 08 15:23:00 volumio sudo[2727]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:23:00 volumio volumio[1177]: info: Received Get System Info Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:23:00 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 15:23:00 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 08 15:23:00 volumio qobuz-connect[2647]: 20260208 15:23:00.612 [2647.2647] INFO SampleApp: Stopping Local configuration server Feb 08 15:23:00 volumio volumio[1177]: info: Received Get System Info Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:23:00 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:00 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:23:00 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Feb 08 15:23:00 volumio sudo[2727]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:00 volumio qobuz-connect[2647]: 20260208 15:23:00.927 [2647.2647] INFO SampleApp: shat down connection on UNIX socket Feb 08 15:23:00 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 08 15:23:00 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 08 15:23:00 volumio volumio[1177]: info: MPD Permissions set Feb 08 15:23:00 volumio volumio[1177]: info: Shairport-Sync Started Feb 08 15:23:00 volumio volumio[1177]: info: TidalConnect service started! Feb 08 15:23:01 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 08 15:23:01 volumio sudo[2725]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:01 volumio volumio[1177]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 08 15:23:01 volumio volumio[1177]: info: QobuzConnect: setDeactiveState invoked Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:01 volumio volumio[1177]: info: Received Get System Info Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:23:01 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:23:01 volumio sudo[2735]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 08 15:23:01 volumio sudo[2735]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 15:23:01 volumio mpd[2719]: decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 08 15:23:01 volumio mpd[2719]: output: No 'audio_output' defined in config file Feb 08 15:23:01 volumio volumio[1177]: info: Executing endpoint tc_getconfig Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 08 15:23:01 volumio sudo[2735]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:01 volumio volumio[1177]: info: TidalConnect service stoped! Feb 08 15:23:01 volumio vtcs[2731]: STARTING TidalConnect services, version: 1.5.2.56 Feb 08 15:23:01 volumio vtcs[2731]: STARTED TidalConnect services. Feb 08 15:23:01 volumio mpd[2719]: output: Successfully detected a sndio audio device Feb 08 15:23:01 volumio mpd[2719]: zeroconf: No global port, disabling zeroconf Feb 08 15:23:01 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 08 15:23:01 volumio upmpdcli[1638]: :3:../src/mpdcli.cxx:148::MPDCli::startEventLoop: already started Feb 08 15:23:01 volumio sudo[2682]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:01 volumio sudo[2602]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:01 volumio volumio[1177]: info: Executing endpoint qc_getconfig Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 08 15:23:01 volumio qobuz-connect[2733]: 20260208 15:23:01.711 [2733.2733] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 08 15:23:01 volumio qobuz-connect[2733]: 20260208 15:23:01.714 [2733.2733] INFO VolumeManager: [0x1c00368]: Setting new playback volume: 75 Feb 08 15:23:01 volumio qobuz-connect[2733]: 20260208 15:23:01.714 [2733.2733] INFO VolumeManager: [0x1c00368]: Setting new mute state: 0 Feb 08 15:23:01 volumio qobuz-connect[2733]: 20260208 15:23:01.714 [2733.2733] INFO QobuzConnect: [0x1c00d38]: Client initialized! Feb 08 15:23:01 volumio qobuz-connect[2733]: 20260208 15:23:01.714 [2733.2733] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Feb 08 15:23:01 volumio qobuz-connect[2733]: 20260208 15:23:01.730 [2733.2733] INFO LocalConfigManager: [0x1bffc48]: Starting Local Configuration server Feb 08 15:23:01 volumio qobuz-connect[2733]: 20260208 15:23:01.730 [2733.2733] INFO SampleApp: Starting Local configuration server Feb 08 15:23:01 volumio qobuz-connect[2733]: 20260208 15:23:01.730 [2733.2733] INFO SampleApp: Connected to UNIX socket client 0x1bea818 Feb 08 15:23:01 volumio volumio[1177]: info: TidalConnect service stoped! Feb 08 15:23:01 volumio volumio[1177]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 08 15:23:01 volumio volumio[1177]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 08 15:23:01 volumio qobuz-connect[2733]: 20260208 15:23:01.861 [2733.2733] INFO SampleApp: Playback volume changed: 75 Feb 08 15:23:01 volumio volumio[1177]: info: Executing endpoint tc_connect Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 08 15:23:01 volumio volumio[1177]: info: Connecting to TidalConnect Feb 08 15:23:01 volumio volumio[1177]: info: Starting Shairport Sync Feb 08 15:23:01 volumio volumio[1177]: error: MPD error: The expression evaluated to a falsy value: Feb 08 15:23:01 volumio volumio[1177]: assert.ok(self.idling) Feb 08 15:23:01 volumio volumio[1177]: error: The expression evaluated to a falsy value: Feb 08 15:23:01 volumio volumio[1177]: assert.ok(self.idling) Feb 08 15:23:01 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:02 volumio volumio[1177]: error: updateQueue error: null Feb 08 15:23:02 volumio volumio[1177]: info: CoreCommandRouter::servicePushState Feb 08 15:23:02 volumio volumio[1177]: info: CoreStateMachine::pushState Feb 08 15:23:02 volumio volumio[1177]: info: CoreCommandRouter::volumioPushState Feb 08 15:23:02 volumio volumio[1177]: info: MRS: Pushing multiroomSync output update for this device Feb 08 15:23:02 volumio volumio[1177]: info: MRS: Pushing multiroomSync output Feb 08 15:23:02 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:02 volumio volumio[1177]: info: CorePlayQueue::getTrack 0 Feb 08 15:23:02 volumio volumio[1177]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Feb 08 15:23:02 volumio volumio[1177]: info: CoreCommandRouter::servicePushState Feb 08 15:23:02 volumio volumio[1177]: info: CoreStateMachine::pushState Feb 08 15:23:02 volumio volumio[1177]: info: CoreCommandRouter::volumioPushState Feb 08 15:23:02 volumio volumio[1177]: info: MRS: Pushing multiroomSync output update for this device Feb 08 15:23:02 volumio volumio[1177]: info: MRS: Pushing multiroomSync output Feb 08 15:23:02 volumio sudo[2765]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 08 15:23:02 volumio sudo[2765]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:23:02 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:02 volumio volumio[1177]: info: CorePlayQueue::getTrack 0 Feb 08 15:23:02 volumio volumio[1177]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Feb 08 15:23:02 volumio volumio[1177]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 08 15:23:02 volumio volumio[1177]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 08 15:23:02 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 08 15:23:02 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 08 15:23:02 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 08 15:23:02 volumio systemd[1]: shairport-sync.service: Consumed 1.250s CPU time. Feb 08 15:23:02 volumio volumio[1177]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.WoZlDdqcs5QM7f1YZAwnuNdsOiD3.62196d96712bc70858b24389cc387675.state.status' Feb 08 15:23:02 volumio volumio[1177]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.WoZlDdqcs5QM7f1YZAwnuNdsOiD3.62196d96712bc70858b24389cc387675.state.status' Feb 08 15:23:02 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 08 15:23:02 volumio sudo[2765]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:02 volumio volumio[1177]: info: Shairport-Sync Started Feb 08 15:23:02 volumio sudo[2791]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 08 15:23:02 volumio sudo[2791]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:23:02 volumio sudo[2791]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:02 volumio volumio[1177]: info: TidalConnect service stoped! Feb 08 15:23:02 volumio volumio[1177]: info: TidalConnect service stoped! Feb 08 15:23:03 volumio volumio[1177]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 08 15:23:03 volumio volumio[1177]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 08 15:23:03 volumio sudo[2803]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 08 15:23:03 volumio sudo[2803]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:23:03 volumio sudo[2803]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:03 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 08 15:23:03 volumio volumio[1177]: info: TidalConnect service started! Feb 08 15:23:04 volumio sudo[2822]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 15:23:04 volumio sudo[2822]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:23:04 volumio sudo[2824]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 15:23:04 volumio sudo[2822]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:04 volumio sudo[2824]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:23:04 volumio sudo[2824]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:04 volumio volumio[1177]: verbose: New Socket.io Connection to 192.168.0.194 from 192.168.0.30 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Feb 08 15:23:04 volumio volumio[1177]: info: TidalConnect service started! Feb 08 15:23:04 volumio sudo[2828]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 15:23:04 volumio sudo[2830]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 15:23:04 volumio sudo[2830]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:23:04 volumio sudo[2828]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 15:23:04 volumio sudo[2828]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:04 volumio sudo[2830]: pam_unix(sudo:session): session closed for user root Feb 08 15:23:04 volumio volumio[1177]: verbose: New Socket.io Connection to 192.168.0.194 from 192.168.0.30 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::volumioGetVisibleSources Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 08 15:23:05 volumio volumio[1177]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 08 15:23:05 volumio volumio[1177]: info: Received Get System Info Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:23:05 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:05 volumio volumio[1177]: info: Listing playlists Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 15:23:05 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 08 15:23:05 volumio volumio[1177]: info: TidalConnect service started! Feb 08 15:23:06 volumio volumio[1177]: info: TidalConnect service started! Feb 08 15:23:06 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 15:23:06 volumio volumio[1177]: info: Received Get System Info Feb 08 15:23:06 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:23:06 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:23:06 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:23:06 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:06 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:23:06 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 08 15:23:07 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 15:23:07 volumio volumio[1177]: info: Received Get System Info Feb 08 15:23:07 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:23:07 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:23:07 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:23:07 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:07 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:23:09 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 08 15:23:11 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Feb 08 15:23:11 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 08 15:23:11 volumio volumio-remote-updater[821]: Test mode disabled Feb 08 15:23:11 volumio volumio-remote-updater[821]: Alpha mode disabled Feb 08 15:23:11 volumio volumio-remote-updater[821]: Alpha legacy test mode disabled Feb 08 15:23:11 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 08 15:23:11 volumio volumio[1177]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 08 15:23:11 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 08 15:23:12 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Feb 08 15:23:12 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 08 15:23:12 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Feb 08 15:23:12 volumio volumio-remote-updater[821]: Test mode disabled Feb 08 15:23:12 volumio volumio-remote-updater[821]: Alpha mode disabled Feb 08 15:23:12 volumio volumio-remote-updater[821]: Alpha legacy test mode disabled Feb 08 15:23:12 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 08 15:23:12 volumio volumio[1177]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 08 15:23:12 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 08 15:23:15 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 08 15:23:16 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 15:23:16 volumio volumio[1177]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 08 15:23:16 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 08 15:23:16 volumio volumio[1177]: info: Received Get System Version Feb 08 15:23:16 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 15:23:16 volumio volumio[1177]: info: Received Get System Info Feb 08 15:23:16 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:23:16 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:23:16 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:23:16 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:16 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:23:22 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 15:23:22 volumio volumio[1177]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 08 15:23:22 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 08 15:23:22 volumio volumio[1177]: info: Received Get System Version Feb 08 15:23:22 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 15:23:22 volumio volumio[1177]: info: Received Get System Info Feb 08 15:23:22 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 15:23:22 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 15:23:22 volumio volumio[1177]: info: Discovery: Getting this device information Feb 08 15:23:22 volumio volumio[1177]: info: CoreCommandRouter::volumioGetState Feb 08 15:23:22 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 15:23:26 volumio volumio[1177]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Feb 08 15:23:29 volumio volumio[1177]: info: CoreCommandRouter::volumioGetQueue Feb 08 15:23:29 volumio volumio[1177]: info: CoreStateMachine::getQueue Feb 08 15:23:29 volumio volumio[1177]: info: CorePlayQueue::getQueue Feb 08 15:23:30 volumio volumio[1177]: info: Preload queue cleared Feb 08 15:23:30 volumio volumio[1177]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 08 15:23:30 volumio volumio[1177]: info: CoreStateMachine::ClearQueue Feb 08 15:23:30 volumio volumio[1177]: info: CoreStateMachine::stop Feb 08 15:23:30 volumio volumio[1177]: info: CoreStateMachine::serviceStop Feb 08 15:23:30 volumio volumio[1177]: info: Received STOP, but no service to execute it Feb 08 15:23:30 volumio volumio[1177]: info: CorePlayQueue::clearPlayQueue Feb 08 15:23:30 volumio volumio[1177]: info: CorePlayQueue::saveQueue Feb 08 15:23:30 volumio volumio[1177]: info: CoreCommandRouter::volumioPushQueue Feb 08 15:23:30 volumio volumio[1177]: info: CoreStateMachine::addQueueItems Feb 08 15:23:30 volumio volumio[1177]: info: CorePlayQueue::addQueueItems Feb 08 15:23:30 volumio volumio[1177]: info: Preload queue cleared Feb 08 15:23:30 volumio volumio[1177]: info: Adding Item to queue: https://stream.radioparadise.com/mellow-flacm Feb 08 15:23:30 volumio volumio[1177]: info: Exploding uri https://stream.radioparadise.com/mellow-flacm in service radio_paradise Feb 08 15:23:30 volumio volumio[1177]: error: [RadioParadise] explodeUri: No station found for uri "https://stream.radioparadise.com/mellow-flacm" Feb 08 15:23:30 volumio volumio[1177]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 15:23:30 volumio volumio[1177]: TypeError: Cannot read properties of undefined (reading 'then') Feb 08 15:23:30 volumio volumio[1177]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:31) Feb 08 15:23:30 volumio volumio[1177]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Feb 08 15:23:30 volumio volumio[1177]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Feb 08 15:23:30 volumio volumio[1177]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Feb 08 15:23:30 volumio volumio[1177]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:251:25) Feb 08 15:23:30 volumio volumio[1177]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:519:25) Feb 08 15:23:30 volumio volumio[1177]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Feb 08 15:23:30 volumio volumio[1177]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Feb 08 15:23:30 volumio volumio[1177]: at Socket.emit (node:events:514:28) Feb 08 15:23:30 volumio volumio[1177]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 08 15:23:30 volumio volumio[1177]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Feb 08 15:23:30 volumio volumio[1177]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 15:23:33 volumio sudo[2887]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-08 15:22' Feb 08 15:23:33 volumio sudo[2887]: 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"