-- Logs begin at Fri 2025-05-23 08:40:40 CEST, end at Wed 2025-05-28 20:45:48 CEST. -- May 28 20:44:01 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:44:01 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:44:01 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:44:01 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:01 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:44:01 rivoplus volumio[3191]: verbose: New Socket.io Connection to 192.168.1.9:3000 from 192.168.1.47 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 May 28 20:44:01 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:01 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 28 20:44:01 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 28 20:44:03 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:04 rivoplus sudo[7070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 20:44:04 rivoplus sudo[7070]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:44:04 rivoplus sudo[7070]: pam_unix(sudo:session): session closed for user root May 28 20:44:04 rivoplus sudo[7073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 20:44:04 rivoplus sudo[7073]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:44:04 rivoplus sudo[7073]: pam_unix(sudo:session): session closed for user root May 28 20:44:04 rivoplus volumio[3191]: verbose: New Socket.io Connection to 192.168.1.9 from 192.168.1.47 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 8 May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetVisibleSources May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 28 20:44:04 rivoplus volumio[3191]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 28 20:44:04 rivoplus volumio[3191]: info: Received Get System Info May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:44:04 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:04 rivoplus volumio[3191]: info: Listing playlists May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 28 20:44:04 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 28 20:44:05 rivoplus sudo[7078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 20:44:05 rivoplus sudo[7078]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:44:05 rivoplus sudo[7078]: pam_unix(sudo:session): session closed for user root May 28 20:44:05 rivoplus sudo[7082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 20:44:05 rivoplus sudo[7082]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 28 20:44:05 rivoplus sudo[7082]: pam_unix(sudo:session): session closed for user root May 28 20:44:05 rivoplus volumio[3191]: verbose: New Socket.io Connection to 192.168.1.9 from 192.168.1.47 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 9 May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetVisibleSources May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 28 20:44:05 rivoplus volumio[3191]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 28 20:44:05 rivoplus volumio[3191]: info: Received Get System Info May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:44:05 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:05 rivoplus volumio[3191]: info: Listing playlists May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 28 20:44:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 28 20:44:06 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:06 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 28 20:44:06 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 28 20:44:06 rivoplus volumio[3191]: info: Received Get System Info May 28 20:44:06 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:44:06 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:44:06 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:44:06 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:06 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:44:06 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 28 20:44:08 rivoplus volumio[3191]: info: Executing endpoint metavolumio May 28 20:44:08 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 28 20:44:09 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 28 20:44:09 rivoplus volumio[3191]: info: Received Get System Info May 28 20:44:09 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:44:09 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:44:09 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:44:09 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:09 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:44:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 28 20:44:11 rivoplus volumio[3191]: info: Received Get System Info May 28 20:44:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:44:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:44:11 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:44:11 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:44:15 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 28 20:44:18 rivoplus volumio[3191]: info: MCU Signalled Sleep Mode Disabled May 28 20:44:18 rivoplus sudo[7107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on May 28 20:44:18 rivoplus sudo[7107]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:44:18 rivoplus kernel: fb: osd[0] enable: 1 (Xorg) May 28 20:44:18 rivoplus kernel: fb: osd[0] enable: 1 (Xorg) May 28 20:44:18 rivoplus sudo[7107]: pam_unix(sudo:session): session closed for user root May 28 20:44:18 rivoplus sudo[7110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 May 28 20:44:18 rivoplus sudo[7110]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:44:18 rivoplus sudo[7110]: pam_unix(sudo:session): session closed for user root May 28 20:44:25 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 28 20:44:25 rivoplus volumio[3191]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 28 20:44:25 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 28 20:44:25 rivoplus volumio[3191]: info: Received Get System Version May 28 20:44:25 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 28 20:44:25 rivoplus volumio[3191]: info: Received Get System Info May 28 20:44:25 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:44:25 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:44:25 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:44:25 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:25 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:44:29 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:44:29 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:44:29 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:44:29 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:29 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:44:59 rivoplus volumio[3191]: info: CoreCommandRouter::volumioPlay May 28 20:44:59 rivoplus volumio[3191]: info: CoreStateMachine::play index undefined May 28 20:44:59 rivoplus volumio[3191]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 20:44:59 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:44:59 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:44:59 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:44:59 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:44:59 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:44:59 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:44:59 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:45:03 rivoplus sudo[7231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 20:45:03 rivoplus sudo[7231]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:03 rivoplus sudo[7231]: pam_unix(sudo:session): session closed for user root May 28 20:45:03 rivoplus sudo[7233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 20:45:03 rivoplus sudo[7233]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:03 rivoplus sudo[7233]: pam_unix(sudo:session): session closed for user root May 28 20:45:03 rivoplus volumio[3191]: verbose: New Socket.io Connection to 192.168.1.9 from 192.168.1.47 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 9 May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:03 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:03 rivoplus volumio[3191]: info: Received Get System Info May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:45:03 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:03 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:03 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetVisibleSources May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:03 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:03 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 28 20:45:03 rivoplus volumio[3191]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 28 20:45:03 rivoplus volumio[3191]: info: Received Get System Info May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:45:03 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:03 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:03 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:03 rivoplus volumio[3191]: info: Listing playlists May 28 20:45:03 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 28 20:45:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 28 20:45:05 rivoplus volumio[3191]: info: Received Get System Info May 28 20:45:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:45:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:45:05 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:45:05 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:05 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:05 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:45:08 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , myVolumioLogout May 28 20:45:08 rivoplus volumio[3191]: info: [MyVolumio PluginManager] Subscribed plan changed to free May 28 20:45:08 rivoplus volumio[3191]: info: MYVOLUMIO LOGGED OUT May 28 20:45:08 rivoplus volumio[3191]: info: Removing browser output: myVolumio user plan is not superstar May 28 20:45:08 rivoplus volumio[3191]: info: Removing audio output: May 28 20:45:08 rivoplus volumio[3191]: info: Stoppping Tunnel 1 May 28 20:45:08 rivoplus sudo[7259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service May 28 20:45:08 rivoplus sudo[7259]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:08 rivoplus sudo[7259]: pam_unix(sudo:session): session closed for user root May 28 20:45:08 rivoplus volumio[3191]: info: Remote SSH Stopped May 28 20:45:10 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 28 20:45:10 rivoplus volumio[3191]: info: Received Get System Info May 28 20:45:10 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:45:10 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:45:10 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:45:10 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:10 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:10 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:45:10 rivoplus volumio[3191]: info: MyVolumio not started May 28 20:45:10 rivoplus volumio[3191]: info: Initializing device activation check May 28 20:45:10 rivoplus volumio[3191]: info: MyVolumio not started May 28 20:45:10 rivoplus volumio[3191]: info: Initializing device activation check May 28 20:45:11 rivoplus sudo[7263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 20:45:11 rivoplus sudo[7263]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:11 rivoplus sudo[7264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 20:45:11 rivoplus sudo[7264]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:11 rivoplus sudo[7263]: pam_unix(sudo:session): session closed for user root May 28 20:45:11 rivoplus sudo[7264]: pam_unix(sudo:session): session closed for user root May 28 20:45:11 rivoplus volumio[3191]: verbose: New Socket.io Connection to 192.168.1.9 from 192.168.1.47 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 9 May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:11 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:11 rivoplus volumio[3191]: info: Received Get System Info May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:45:11 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:11 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:11 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetVisibleSources May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:11 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:11 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 28 20:45:11 rivoplus volumio[3191]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 28 20:45:11 rivoplus volumio[3191]: info: Received Get System Info May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:45:11 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:11 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:11 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:11 rivoplus volumio[3191]: info: Listing playlists May 28 20:45:11 rivoplus volumio[3191]: info: Received Get System Info May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:45:11 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:11 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:11 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:11 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 28 20:45:12 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:12 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:13 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 20:45:16 rivoplus volumio[3191]: No protocol specified May 28 20:45:16 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 20:45:16 rivoplus volumio[3191]: No protocol specified May 28 20:45:16 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:16 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 28 20:45:18 rivoplus volumio[3191]: info: Preparing to save Alsa Options, stopping services first May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:18 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::volumioPause May 28 20:45:18 rivoplus volumio[3191]: info: CoreStateMachine::pause May 28 20:45:18 rivoplus volumio[3191]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Hegel USB"}} May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 20:45:18 rivoplus volumio[3191]: No protocol specified May 28 20:45:18 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:18 rivoplus volumio[3191]: No protocol specified May 28 20:45:18 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 20:45:18 rivoplus volumio[3191]: No protocol specified May 28 20:45:18 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:18 rivoplus volumio[3191]: info: Setting mixer Hegel USB for card Hegel USB May 28 20:45:18 rivoplus volumio[3191]: info: QobuzConnect: setDeactiveState invoked May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:18 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:18 rivoplus volumio[3191]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes May 28 20:45:18 rivoplus vtcs[5895]: [2025-05-28 20:45:18.340] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE May 28 20:45:18 rivoplus vtcs[5895]: [2025-05-28 20:45:18.340] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected May 28 20:45:18 rivoplus sudo[7298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 28 20:45:18 rivoplus sudo[7298]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:18 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service... May 28 20:45:18 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM May 28 20:45:18 rivoplus systemd[1]: vtcs.service: Succeeded. May 28 20:45:18 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service. May 28 20:45:18 rivoplus volumio[3191]: No protocol specified May 28 20:45:18 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 28 20:45:18 rivoplus volumio[3191]: info: Updating Volume Controller Parameters: Device: 5 Name: Hegel USB Mixer: Hegel USB Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 28 20:45:18 rivoplus volumio[3191]: info: Disabling external Volume Control May 28 20:45:18 rivoplus sudo[7298]: pam_unix(sudo:session): session closed for user root May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 20:45:18 rivoplus volumio[3191]: info: Preparing to generate the ALSA configuration file May 28 20:45:18 rivoplus sudo[7307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 28 20:45:18 rivoplus sudo[7307]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:18 rivoplus sudo[7307]: pam_unix(sudo:session): session closed for user root May 28 20:45:18 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: running May 28 20:45:18 rivoplus volumio[3191]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 28 20:45:18 rivoplus volumio[3191]: info: Reading ALSA contributions from plugins. May 28 20:45:18 rivoplus volumio[3191]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified May 28 20:45:18 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:18 rivoplus sudo[7314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 28 20:45:18 rivoplus sudo[7314]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:18 rivoplus sudo[7314]: pam_unix(sudo:session): session closed for user root May 28 20:45:18 rivoplus sudo[7317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 28 20:45:18 rivoplus sudo[7317]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:18 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... May 28 20:45:18 rivoplus qobuz-connect[5811]: 20250528 20:45:18.719 [5811.5811] INFO SampleApp: Stopping Local configuration server May 28 20:45:18 rivoplus qobuz-connect[5811]: 20250528 20:45:18.730 [5811.5811] INFO SampleApp: shat down connection on UNIX socket May 28 20:45:18 rivoplus systemd[1]: qobuz-connect.service: Succeeded. May 28 20:45:18 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. May 28 20:45:18 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. May 28 20:45:18 rivoplus sudo[7317]: pam_unix(sudo:session): session closed for user root May 28 20:45:18 rivoplus volumio[3191]: No protocol specified May 28 20:45:18 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 20:45:18 rivoplus volumio[3191]: No protocol specified May 28 20:45:18 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:18 rivoplus volumio[3191]: info: Not Reporting Auto name since its the default one May 28 20:45:18 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: running May 28 20:45:18 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 28 20:45:18 rivoplus volumio[3191]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 28 20:45:18 rivoplus volumio[3191]: info: QobuzConnect: setDeactiveState invoked May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:18 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:18 rivoplus volumio[3191]: info: VolumeController:: Volume=undefined Mute =false May 28 20:45:18 rivoplus volumio[3191]: info: CoreStateMachine::pushState May 28 20:45:18 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::volumioPushState May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:18 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:18 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output update for this device May 28 20:45:18 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output May 28 20:45:18 rivoplus volumio[3191]: info: Updating RAAT Signal Path May 28 20:45:18 rivoplus volumio[3191]: info: Executing endpoint qc_getconfig May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 28 20:45:18 rivoplus qobuz-connect[7321]: 20250528 20:45:18.976 [7321.7321] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:18 rivoplus qobuz-connect[7321]: 20250528 20:45:18.988 [7321.7321] INFO VolumeManager: [0xad0558f0]: Setting new playback volume: 75 May 28 20:45:18 rivoplus qobuz-connect[7321]: 20250528 20:45:18.988 [7321.7321] INFO VolumeManager: [0xad0558f0]: Setting new mute state: 0 May 28 20:45:18 rivoplus qobuz-connect[7321]: 20250528 20:45:18.988 [7321.7321] INFO QobuzConnect: [0xad0562c0]: Client initialized! May 28 20:45:18 rivoplus qobuz-connect[7321]: 20250528 20:45:18.988 [7321.7321] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp May 28 20:45:18 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable May 28 20:45:19 rivoplus qobuz-connect[7321]: 20250528 20:45:19.012 [7321.7321] INFO LocalConfigManager: [0xad0551d0]: Starting Local Configuration server May 28 20:45:19 rivoplus qobuz-connect[7321]: 20250528 20:45:19.012 [7321.7321] INFO SampleApp: Starting Local configuration server May 28 20:45:19 rivoplus qobuz-connect[7321]: 20250528 20:45:19.013 [7321.7321] INFO SampleApp: Connected to UNIX socket client 0xad04aed8 May 28 20:45:19 rivoplus volumio[3191]: No protocol specified May 28 20:45:19 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:19 rivoplus volumio[3191]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 28 20:45:19 rivoplus volumio[3191]: info: QobuzConnect: QOBUZ Connect daemon connected May 28 20:45:19 rivoplus volumio[3191]: info: Asound.conf file unchanged, so no further update is needed May 28 20:45:19 rivoplus volumio[3191]: info: Output device has changed, restarting MPD May 28 20:45:19 rivoplus sudo[7342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service May 28 20:45:19 rivoplus sudo[7342]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:19 rivoplus qobuz-connect[7321]: 20250528 20:45:19.125 [7321.7321] INFO SampleApp: Playback volume changed: 75 May 28 20:45:19 rivoplus sudo[7342]: pam_unix(sudo:session): session closed for user root May 28 20:45:19 rivoplus sudo[7345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 28 20:45:19 rivoplus volumio[3191]: info: Output device has changed, restarting Shairport Sync May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 20:45:19 rivoplus sudo[7345]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:19 rivoplus sudo[7346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service May 28 20:45:19 rivoplus sudo[7346]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:19 rivoplus sudo[7345]: pam_unix(sudo:session): session closed for user root May 28 20:45:19 rivoplus systemd[1]: Stopping RAAT DAEMON... May 28 20:45:19 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM May 28 20:45:19 rivoplus systemd[1]: raat-daemon.service: Succeeded. May 28 20:45:19 rivoplus systemd[1]: Stopped RAAT DAEMON. May 28 20:45:19 rivoplus sudo[7350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 28 20:45:19 rivoplus sudo[7350]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:19 rivoplus systemd[1]: Started RAAT DAEMON. May 28 20:45:19 rivoplus sudo[7346]: pam_unix(sudo:session): session closed for user root May 28 20:45:19 rivoplus systemd[1]: Stopping Music Player Daemon... May 28 20:45:19 rivoplus volumio[3191]: No protocol specified May 28 20:45:19 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:19 rivoplus volumio[3191]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 28 20:45:19 rivoplus volumio[3191]: No protocol specified May 28 20:45:19 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:19 rivoplus volumio[3191]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus volumio[3191]: info: QobuzConnect: setDeactiveState invoked May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:19 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:19 rivoplus volumio[3191]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus systemd[1]: mpd.service: Succeeded. May 28 20:45:19 rivoplus systemd[1]: Stopped Music Player Daemon. May 28 20:45:19 rivoplus systemd[1]: Starting Music Player Daemon... May 28 20:45:19 rivoplus sudo[7374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 28 20:45:19 rivoplus sudo[7374]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:19 rivoplus sudo[7376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 28 20:45:19 rivoplus sudo[7376]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:19 rivoplus sudo[7374]: pam_unix(sudo:session): session closed for user root May 28 20:45:19 rivoplus sudo[7376]: pam_unix(sudo:session): session closed for user root May 28 20:45:19 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: running May 28 20:45:19 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 28 20:45:19 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: running May 28 20:45:19 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 28 20:45:19 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: running May 28 20:45:19 rivoplus sudo[7386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 28 20:45:19 rivoplus sudo[7386]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:19 rivoplus sudo[7372]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 28 20:45:19 rivoplus sudo[7372]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:19 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:19 rivoplus sudo[7372]: pam_unix(sudo:session): session closed for user root May 28 20:45:19 rivoplus volumio[3191]: info: Executing endpoint restartRAATSocket May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection May 28 20:45:19 rivoplus sudo[7386]: pam_unix(sudo:session): session closed for user root May 28 20:45:19 rivoplus volumio[3191]: info: MPD Permissions set May 28 20:45:19 rivoplus volumio[3191]: info: Raat Daemon started successfully May 28 20:45:19 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus sudo[7389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 28 20:45:19 rivoplus sudo[7389]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:19 rivoplus qobuz-connect[7321]: 20250528 20:45:19.681 [7321.7321] INFO SampleApp: Stopping Local configuration server May 28 20:45:19 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 28 20:45:19 rivoplus qobuz-connect[7321]: 20250528 20:45:19.692 [7321.7321] INFO SampleApp: shat down connection on UNIX socket May 28 20:45:19 rivoplus systemd[1]: qobuz-connect.service: Succeeded. May 28 20:45:19 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. May 28 20:45:19 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. May 28 20:45:19 rivoplus sudo[7389]: pam_unix(sudo:session): session closed for user root May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: running May 28 20:45:19 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 28 20:45:19 rivoplus volumio[3191]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 May 28 20:45:19 rivoplus volumio[3191]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 28 20:45:19 rivoplus volumio[3191]: info: QobuzConnect: setDeactiveState invoked May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:19 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:19 rivoplus volumio[3191]: info: Starting Shairport Sync May 28 20:45:19 rivoplus sudo[7402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 28 20:45:19 rivoplus sudo[7402]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:19 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus systemd[1]: shairport-sync.service: Succeeded. May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:19 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 28 20:45:19 rivoplus volumio[3191]: info: Not Reporting Auto name since its the default one May 28 20:45:19 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 28 20:45:19 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: running May 28 20:45:19 rivoplus sudo[7402]: pam_unix(sudo:session): session closed for user root May 28 20:45:19 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 28 20:45:19 rivoplus volumio[3191]: info: Executing endpoint qc_getconfig May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 28 20:45:19 rivoplus qobuz-connect[7398]: 20250528 20:45:19.921 [7398.7398] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 28 20:45:19 rivoplus qobuz-connect[7398]: 20250528 20:45:19.928 [7398.7398] INFO VolumeManager: [0xab6948f0]: Setting new playback volume: 75 May 28 20:45:19 rivoplus qobuz-connect[7398]: 20250528 20:45:19.928 [7398.7398] INFO VolumeManager: [0xab6948f0]: Setting new mute state: 0 May 28 20:45:19 rivoplus qobuz-connect[7398]: 20250528 20:45:19.928 [7398.7398] INFO QobuzConnect: [0xab6952c0]: Client initialized! May 28 20:45:19 rivoplus qobuz-connect[7398]: 20250528 20:45:19.928 [7398.7398] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp May 28 20:45:19 rivoplus volumio[3191]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 28 20:45:19 rivoplus volumio[3191]: info: QobuzConnect: QOBUZ Connect daemon connected May 28 20:45:19 rivoplus volumio[3191]: info: Shairport-Sync Started May 28 20:45:19 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable May 28 20:45:19 rivoplus qobuz-connect[7398]: 20250528 20:45:19.963 [7398.7398] INFO LocalConfigManager: [0xab6941d0]: Starting Local Configuration server May 28 20:45:19 rivoplus qobuz-connect[7398]: 20250528 20:45:19.963 [7398.7398] INFO SampleApp: Starting Local configuration server May 28 20:45:19 rivoplus qobuz-connect[7398]: 20250528 20:45:19.964 [7398.7398] INFO SampleApp: Connected to UNIX socket client 0xab689ed8 May 28 20:45:20 rivoplus volumio[3191]: No protocol specified May 28 20:45:20 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:20 rivoplus qobuz-connect[7398]: 20250528 20:45:20.071 [7398.7398] INFO SampleApp: Playback volume changed: 75 May 28 20:45:20 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:20 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:20 rivoplus sudo[7418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service May 28 20:45:20 rivoplus sudo[7418]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:20 rivoplus sudo[7418]: pam_unix(sudo:session): session closed for user root May 28 20:45:20 rivoplus sudo[7420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service May 28 20:45:20 rivoplus sudo[7420]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:20 rivoplus systemd[1]: Stopping RAAT DAEMON... May 28 20:45:20 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM May 28 20:45:20 rivoplus systemd[1]: raat-daemon.service: Succeeded. May 28 20:45:20 rivoplus systemd[1]: Stopped RAAT DAEMON. May 28 20:45:20 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: running May 28 20:45:20 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 28 20:45:20 rivoplus systemd[1]: Started RAAT DAEMON. May 28 20:45:20 rivoplus sudo[7420]: pam_unix(sudo:session): session closed for user root May 28 20:45:20 rivoplus volumio[3191]: info: Raat Daemon started successfully May 28 20:45:20 rivoplus volumio[3191]: info: Executing endpoint restartRAATSocket May 28 20:45:20 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection May 28 20:45:20 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:20 rivoplus volumio[3191]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 May 28 20:45:21 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 28 20:45:21 rivoplus volumio[3191]: info: TidalConnect service stoped! May 28 20:45:21 rivoplus mpd[7391]: May 28 20:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 28 20:45:21 rivoplus systemd[1]: Started Music Player Daemon. May 28 20:45:21 rivoplus sudo[7350]: pam_unix(sudo:session): session closed for user root May 28 20:45:21 rivoplus volumio[3191]: error: updateQueue error: null May 28 20:45:21 rivoplus volumio[3191]: info: TidalConnect service stoped! May 28 20:45:21 rivoplus volumio[3191]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 28 20:45:21 rivoplus volumio[3191]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 28 20:45:21 rivoplus sudo[7444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 28 20:45:21 rivoplus sudo[7444]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:21 rivoplus systemd[1]: Started Volumio Tidal Connect Service. May 28 20:45:21 rivoplus sudo[7444]: pam_unix(sudo:session): session closed for user root May 28 20:45:22 rivoplus volumio[3191]: info: RAAT: Requesting Headphone Status May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus May 28 20:45:22 rivoplus volumio[3191]: info: Executing endpoint tc_getconfig May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 28 20:45:22 rivoplus vtcs[7446]: STARTING TidalConnect services, version: 1.4.0.34 May 28 20:45:22 rivoplus volumio[3191]: info: MCU Signalled Headphone Mode Disabled May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState May 28 20:45:22 rivoplus volumio[3191]: info: Reporting Headphone State: false May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:22 rivoplus volumio[3191]: info: Updating RAAT Signal Path May 28 20:45:22 rivoplus vtcs[7446]: STARTED TidalConnect services. May 28 20:45:22 rivoplus volumio[3191]: info: Executing endpoint tc_connect May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 28 20:45:22 rivoplus volumio[3191]: info: Connecting to TidalConnect May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::servicePushState May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::pushState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioPushState May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output update for this device May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} May 28 20:45:22 rivoplus volumio[3191]: verbose: CURRENT POSITION 0 May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::syncState stateService stop May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::syncState currentStatus stop May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::pushState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioPushState May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output update for this device May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output May 28 20:45:22 rivoplus volumio[3191]: info: No code May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::pushState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioPushState May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output update for this device May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::servicePushState May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::pushState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioPushState May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output update for this device May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} May 28 20:45:22 rivoplus volumio[3191]: verbose: CURRENT POSITION 0 May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::syncState stateService stop May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::syncState currentStatus stop May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::pushState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioPushState May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output update for this device May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output May 28 20:45:22 rivoplus volumio[3191]: info: No code May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::pushState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioPushState May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output update for this device May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output May 28 20:45:22 rivoplus volumio[3191]: info: Updating RAAT Signal Path May 28 20:45:22 rivoplus volumio[3191]: info: Updating RAAT Signal Path May 28 20:45:22 rivoplus volumio[3191]: info: Updating RAAT Signal Path May 28 20:45:22 rivoplus volumio[3191]: info: Updating RAAT Signal Path May 28 20:45:22 rivoplus volumio[3191]: info: Updating RAAT Signal Path May 28 20:45:22 rivoplus volumio[3191]: info: Updating RAAT Signal Path May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::getcurrentVolume May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioRetrievevolume May 28 20:45:22 rivoplus volumio[3191]: info: TidalConnect service stoped! May 28 20:45:22 rivoplus volumio[3191]: info: TidalConnect service stoped! May 28 20:45:22 rivoplus volumio[3191]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified May 28 20:45:22 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:22 rivoplus volumio[3191]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 28 20:45:22 rivoplus volumio[3191]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 28 20:45:22 rivoplus volumio[3191]: info: VolumeController:: Volume=undefined Mute =false May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::pushState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioPushState May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output update for this device May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::updateTrackBlock May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrackBlock May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioRetrievevolume May 28 20:45:22 rivoplus sudo[7478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 28 20:45:22 rivoplus sudo[7478]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:22 rivoplus sudo[7478]: pam_unix(sudo:session): session closed for user root May 28 20:45:22 rivoplus volumio[3191]: info: Updating RAAT Signal Path May 28 20:45:22 rivoplus volumio[3191]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified May 28 20:45:22 rivoplus volumio[3191]: xcb_connection_has_error() returned true May 28 20:45:22 rivoplus volumio[3191]: info: VolumeController:: Volume=undefined Mute =false May 28 20:45:22 rivoplus volumio[3191]: info: CoreStateMachine::pushState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioPushState May 28 20:45:22 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:22 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output update for this device May 28 20:45:22 rivoplus volumio[3191]: info: MRS: Pushing multiroomSync output May 28 20:45:22 rivoplus volumio[3191]: info: Updating RAAT Signal Path May 28 20:45:23 rivoplus volumio[3191]: info: RAAT: Requesting Headphone Status May 28 20:45:23 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus May 28 20:45:23 rivoplus volumio[3191]: info: MCU Signalled Headphone Mode Disabled May 28 20:45:23 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState May 28 20:45:23 rivoplus volumio[3191]: info: Reporting Headphone State: false May 28 20:45:23 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:23 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 20:45:23 rivoplus volumio[3191]: info: Updating RAAT Signal Path May 28 20:45:24 rivoplus volumio[3191]: info: TidalConnect service started! May 28 20:45:25 rivoplus volumio[3191]: info: TidalConnect service started! May 28 20:45:29 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 20:45:29 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 20:45:29 rivoplus volumio[3191]: info: Discovery: Getting this device information May 28 20:45:29 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:29 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:29 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 20:45:32 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetState May 28 20:45:32 rivoplus volumio[3191]: info: CorePlayQueue::getTrack 0 May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 20:45:34 rivoplus volumio[3191]: info: Retrieving Cloud Streaming UI May 28 20:45:34 rivoplus volumio[3191]: info: Getting Tidal Cloud Configuration May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 20:45:34 rivoplus volumio[3191]: info: Getting Qobuz Cloud Configuration May 28 20:45:34 rivoplus volumio[3191]: info: Asking plugin for UI Config May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 20:45:34 rivoplus volumio[3191]: info: Getting Spotify Cloud Configuration May 28 20:45:34 rivoplus volumio[3191]: info: Asking plugin for UI Config May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 20:45:34 rivoplus volumio[3191]: info: Saving Spotify Acccount May 28 20:45:34 rivoplus volumio[3191]: info: Got it May 28 20:45:34 rivoplus volumio[3191]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 28 20:45:34 rivoplus volumio[3191]: info: Got Tidal Cloud Configuration May 28 20:45:34 rivoplus volumio[3191]: info: Got it May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::getUIConfigOnPlugin May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetBrowseSources May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetBrowseSources May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::volumioGetBrowseSources May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 28 20:45:34 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 28 20:45:37 rivoplus volumio[3191]: info: Disabling MyMusic plugin upnp May 28 20:45:37 rivoplus sudo[7522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service May 28 20:45:37 rivoplus sudo[7522]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 20:45:37 rivoplus systemd[1]: Stopping UPnP Renderer front-end to MPD... May 28 20:45:37 rivoplus volumio[3191]: error: Upnp client error: Error: This socket has been ended by the other party May 28 20:45:37 rivoplus volumio[3191]: ------------------------------------ BT MESSAGE: BT STATUS: running May 28 20:45:38 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 28 20:45:42 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 28 20:45:46 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 28 20:45:47 rivoplus volumio[3191]: info: Enabling MyMusic plugin upnp May 28 20:45:47 rivoplus volumio[3191]: info: Enabling plugin upnp May 28 20:45:47 rivoplus volumio[3191]: info: Loading plugin "upnp"... May 28 20:45:47 rivoplus volumio[3191]: info: [1748457947579] Starting Upmpd Daemon May 28 20:45:47 rivoplus volumio[3191]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 28 20:45:47 rivoplus volumio[3191]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 20:45:47 rivoplus volumio[3191]: Error: listen EADDRINUSE: address already in use :::6599 May 28 20:45:47 rivoplus volumio[3191]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) May 28 20:45:47 rivoplus volumio[3191]: at listenInCluster (net.js:1379:12) May 28 20:45:47 rivoplus volumio[3191]: at Server.listen (net.js:1465:7) May 28 20:45:47 rivoplus volumio[3191]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) May 28 20:45:47 rivoplus volumio[3191]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) May 28 20:45:47 rivoplus volumio[3191]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 28 20:45:47 rivoplus volumio[3191]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 28 20:45:47 rivoplus volumio[3191]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { May 28 20:45:47 rivoplus volumio[3191]: code: 'EADDRINUSE', May 28 20:45:47 rivoplus volumio[3191]: errno: -98, May 28 20:45:47 rivoplus volumio[3191]: syscall: 'listen', May 28 20:45:47 rivoplus volumio[3191]: address: '::', May 28 20:45:47 rivoplus volumio[3191]: port: 6599 May 28 20:45:47 rivoplus volumio[3191]: } May 28 20:45:47 rivoplus volumio[3191]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 20:45:48 rivoplus sudo[7594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-28 20:44 May 28 20:45:48 rivoplus sudo[7594]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 06:04:38 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="0064c1a7ac4363e567dacab062cb5da8"