-- Logs begin at Sat 2026-02-07 20:16:04 WET, end at Sat 2026-02-07 22:56:51 WET. -- Feb 07 22:55:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 07 22:55:00 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:55:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:55:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:55:00 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:55:00 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:55:00 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:55:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:55:00 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:55:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:55:00 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:55:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:55:04 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 07 22:55:04 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 07 22:55:07 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 07 22:55:13 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:13 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetQueue Feb 07 22:55:13 rivoplus volumio[3408]: info: CoreStateMachine::getQueue Feb 07 22:55:13 rivoplus volumio[3408]: info: CorePlayQueue::getQueue Feb 07 22:55:15 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:55:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:55:15 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:55:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:55:15 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:55:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:55:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 07 22:55:15 rivoplus volumio[3408]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 07 22:55:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 07 22:55:15 rivoplus volumio[3408]: info: Received Get System Version Feb 07 22:55:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 22:55:15 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:55:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:55:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:55:15 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:55:15 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:55:18 rivoplus volumio5-onboarding[4020]: time=2026-02-07T22:55:18.150Z level=INFO msg="continue navigation request" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.10:53390,192.168.1.10:53530 @ 0x2ffe1b0" latency=3.366875ms timeout=10s from=APP_PAGE_ROOT Feb 07 22:55:18 rivoplus sudo[6451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 22:55:18 rivoplus sudo[6451]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:55:18 rivoplus sudo[6451]: pam_unix(sudo:session): session closed for user root Feb 07 22:55:18 rivoplus sudo[6460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 22:55:18 rivoplus sudo[6460]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:55:18 rivoplus sudo[6460]: pam_unix(sudo:session): session closed for user root Feb 07 22:55:18 rivoplus volumio[3408]: verbose: New Socket.io Connection to 192.168.1.249 from 192.168.1.10 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: 12 Feb 07 22:55:18 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 07 22:55:18 rivoplus sudo[6471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 22:55:18 rivoplus sudo[6471]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:55:18 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 07 22:55:18 rivoplus sudo[6471]: pam_unix(sudo:session): session closed for user root Feb 07 22:55:18 rivoplus sudo[6475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 22:55:18 rivoplus sudo[6475]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:55:18 rivoplus sudo[6475]: pam_unix(sudo:session): session closed for user root Feb 07 22:55:19 rivoplus volumio[3408]: verbose: New Socket.io Connection to 192.168.1.249 from 192.168.1.10 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: 13 Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetVisibleSources Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 07 22:55:19 rivoplus volumio[3408]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 07 22:55:19 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:55:19 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:19 rivoplus volumio[3408]: info: Listing playlists Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 07 22:55:19 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 07 22:55:20 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:20 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 07 22:55:20 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 07 22:55:20 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:55:20 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:55:20 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:55:20 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:55:20 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:20 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:55:21 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 07 22:55:21 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:55:21 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:55:21 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:55:21 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:55:21 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:21 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:55:22 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:55:22 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:55:22 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:55:22 rivoplus sudo[6479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 22:55:22 rivoplus sudo[6479]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:55:22 rivoplus sudo[6479]: pam_unix(sudo:session): session closed for user root Feb 07 22:55:22 rivoplus sudo[6483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 22:55:22 rivoplus sudo[6483]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:55:22 rivoplus sudo[6483]: pam_unix(sudo:session): session closed for user root Feb 07 22:55:22 rivoplus volumio[3408]: verbose: New Socket.io Connection to 192.168.1.249 from 192.168.1.10 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: 13 Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetVisibleSources Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 07 22:55:22 rivoplus volumio[3408]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 07 22:55:22 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:55:22 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:22 rivoplus volumio[3408]: info: Listing playlists Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Feb 07 22:55:22 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 07 22:55:23 rivoplus volumio[3408]: info: Received Get System Version Feb 07 22:55:23 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 22:55:24 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 07 22:55:24 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 07 22:55:24 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:55:24 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:55:24 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:55:24 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:55:24 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:24 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:55:25 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 07 22:55:25 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:55:25 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:55:25 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:55:25 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:55:25 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:25 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:55:32 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 07 22:55:39 rivoplus volumio-remote-updater[2864]: No test mode Feb 07 22:55:39 rivoplus volumio-remote-updater[2864]: No alpha test mode Feb 07 22:55:39 rivoplus volumio[3408]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 07 22:55:39 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 07 22:55:40 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 07 22:55:40 rivoplus volumio[3408]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 07 22:55:40 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 07 22:55:40 rivoplus volumio[3408]: info: Received Get System Version Feb 07 22:55:40 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 22:55:40 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:55:40 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:55:40 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:55:40 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:55:40 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:40 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:55:43 rivoplus volumio[3408]: info: CoreCommandRouter::Close All Modals sent Feb 07 22:55:56 rivoplus volumio5-onboarding[4020]: time=2026-02-07T22:55:56.857Z level=INFO msg="continue navigation request" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.10:53390,192.168.1.10:53530 @ 0x2ffe1b0" latency=3.868893ms timeout=10s from=APP_PAGE_ROOT Feb 07 22:55:57 rivoplus sudo[6594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 22:55:57 rivoplus sudo[6594]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:55:57 rivoplus sudo[6594]: pam_unix(sudo:session): session closed for user root Feb 07 22:55:57 rivoplus sudo[6598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 22:55:57 rivoplus sudo[6598]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:55:57 rivoplus sudo[6598]: pam_unix(sudo:session): session closed for user root Feb 07 22:55:57 rivoplus volumio[3408]: verbose: New Socket.io Connection to 192.168.1.249 from 192.168.1.10 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: 11 Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 07 22:55:57 rivoplus sudo[6603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 22:55:57 rivoplus sudo[6603]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:55:57 rivoplus sudo[6605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 22:55:57 rivoplus sudo[6605]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:55:57 rivoplus sudo[6603]: pam_unix(sudo:session): session closed for user root Feb 07 22:55:57 rivoplus sudo[6605]: pam_unix(sudo:session): session closed for user root Feb 07 22:55:57 rivoplus volumio[3408]: verbose: New Socket.io Connection to 192.168.1.249 from 192.168.1.10 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: 12 Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetVisibleSources Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 07 22:55:57 rivoplus volumio[3408]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 07 22:55:57 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:55:57 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:57 rivoplus volumio[3408]: info: Listing playlists Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 07 22:55:57 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 07 22:55:58 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:59 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 07 22:55:59 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetQueue Feb 07 22:55:59 rivoplus volumio[3408]: info: CoreStateMachine::getQueue Feb 07 22:55:59 rivoplus volumio[3408]: info: CorePlayQueue::getQueue Feb 07 22:55:59 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 07 22:55:59 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:55:59 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:55:59 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:55:59 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:55:59 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:55:59 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 07 22:56:00 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:56:00 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:56:00 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:00 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:00 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPlay Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::play index 2 Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::stop Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::updateTrackBlock Feb 07 22:56:00 rivoplus volumio[3408]: info: CorePlayQueue::getTrackBlock Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::stPlaybackTimer Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:00 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 0 Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:00 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 0 Feb 07 22:56:00 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:00 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::serviceStop Feb 07 22:56:00 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 0 Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreCommandRouter::serviceStop Feb 07 22:56:00 rivoplus volumio[3408]: info: [1770504960927] ControllerQobuz::stop Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 07 22:56:00 rivoplus volumio[3408]: info: ControllerMpd::stop Feb 07 22:56:00 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand stop Feb 07 22:56:00 rivoplus volumio5-onboarding[4020]: time=2026-02-07T22:56:00.931Z level=ERROR msg="failed to send event" component=server dst="192.168.1.10:51417 @ 0x2ffe120" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="no WebSocket connection found for address: 192.168.1.10:51417" Feb 07 22:56:00 rivoplus volumio5-onboarding[4020]: time=2026-02-07T22:56:00.932Z level=ERROR msg="failed to send event" component=server dst="192.168.1.10:53264 @ 0x3022030" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="no WebSocket connection found for address: 192.168.1.10:53264" Feb 07 22:56:00 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:00 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:00 rivoplus volumio[3408]: info: Feb 07 22:56:00 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:00 rivoplus volumio[3408]: info: sendMpdCommand stop took 50 milliseconds Feb 07 22:56:00 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:00 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::play index undefined Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 07 22:56:00 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:00 rivoplus volumio[3408]: info: CoreStateMachine::startPlaybackTimer Feb 07 22:56:00 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:00 rivoplus volumio[3408]: info: [1770504960982] ControllerQobuz::clearAddPlayTrack Feb 07 22:56:00 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand stop Feb 07 22:56:00 rivoplus volumio[3408]: info: Feb 07 22:56:00 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:00 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:00 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:00 rivoplus volumio[3408]: info: Feb 07 22:56:00 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:00 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:00 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:00 rivoplus volumio[3408]: info: Feb 07 22:56:00 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:00 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:00 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:01 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:01 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand status took 43 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand stop took 39 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand status took 35 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand status took 30 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand status took 27 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand status took 23 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand status took 22 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand clear Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand clear took 10 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/335514628" Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:01 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:01 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:01 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:01 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:01 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 22:56:01 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:01 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:01 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:01 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:01 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:01 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:01 rivoplus volumio[3408]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Feb 07 22:56:01 rivoplus volumio[3408]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 07 22:56:01 rivoplus volumio[3408]: STREAMING PROXY: Handling url /?data=qobuz://song/335514628 Feb 07 22:56:01 rivoplus volumio[3408]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 111ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 104ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 100ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 94ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 90ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 86ms Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: error: updateQueue error: null Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 66ms Feb 07 22:56:01 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:01 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:01 rivoplus volumio[3408]: info: Executing endpoint getStreamUrlqobuz Feb 07 22:56:01 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Feb 07 22:56:01 rivoplus volumio[3408]: info: getStreamUrl took 346 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=10040877&eid=335514628&fmt=7&profile=raw&app_id=539451548&cid=3797663&etsp=1770508561&hmac=1VuDV49Uz55AFfQW6rHkdcJJFx8 Feb 07 22:56:01 rivoplus volumio[3408]: STREAMING PROXY: Response: 200, length: 30818734 Feb 07 22:56:01 rivoplus volumio[3408]: STREAMING PROXY: Client dropped request, destroying Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/335514628" Feb 07 22:56:01 rivoplus volumio[3408]: error: updateQueue error: null Feb 07 22:56:01 rivoplus volumio[3408]: error: updateQueue error: null Feb 07 22:56:01 rivoplus volumio[3408]: error: updateQueue error: null Feb 07 22:56:01 rivoplus volumio[3408]: error: updateQueue error: null Feb 07 22:56:01 rivoplus volumio[3408]: error: updateQueue error: null Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 553ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 552ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 550ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 547ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 546ms Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/335514628" took 6 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 07 22:56:01 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand play Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 5ms Feb 07 22:56:01 rivoplus volumio[3408]: info: sendMpdCommand play took 2 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: STREAMING PROXY: Handling url /?data=qobuz://song/335514628 Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: info: Feb 07 22:56:01 rivoplus volumio[3408]: ---------------------------- MPD announces system playlist update Feb 07 22:56:01 rivoplus volumio[3408]: info: Ignoring MPD Status Update Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 8ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 8ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 6ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 5ms Feb 07 22:56:01 rivoplus volumio[3408]: info: ------------------------------ 3ms Feb 07 22:56:01 rivoplus volumio[3408]: info: Executing endpoint getStreamUrlqobuz Feb 07 22:56:01 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Feb 07 22:56:01 rivoplus volumio[3408]: info: getStreamUrl took 319 milliseconds Feb 07 22:56:01 rivoplus volumio[3408]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=10040877&eid=335514628&fmt=7&profile=raw&app_id=539451548&cid=3797663&etsp=1770508561&hmac=1VuDV49Uz55AFfQW6rHkdcJJFx8 Feb 07 22:56:02 rivoplus volumio[3408]: STREAMING PROXY: Response: 200, length: 30818734 Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 101 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 109 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 107 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 106 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 104 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 115 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 24 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 25 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:02 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:02 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus stop Feb 07 22:56:02 rivoplus volumio[3408]: info: ------------------------------ 172ms Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: info: Feb 07 22:56:02 rivoplus volumio[3408]: ---------------------------- MPD announces state update: player Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::getState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand status Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 62 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 60 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 60 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 43 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 41 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 41 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 29 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 27 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 25 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 19 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand status took 13 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseState Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:02 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1596 Kbps","isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:02 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus play Feb 07 22:56:02 rivoplus volumio[3408]: info: Received an update from plugin. extracting info from payload Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:02 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1112,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1602 Kbps","isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:02 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus play Feb 07 22:56:02 rivoplus volumio[3408]: info: Received an update from plugin. extracting info from payload Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:02 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1175,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1744 Kbps","isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:02 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus play Feb 07 22:56:02 rivoplus volumio[3408]: info: Received an update from plugin. extracting info from payload Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:02 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1238,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1812 Kbps","isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:02 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus play Feb 07 22:56:02 rivoplus volumio[3408]: info: Received an update from plugin. extracting info from payload Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:02 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1238,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1645 Kbps","isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:02 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus play Feb 07 22:56:02 rivoplus volumio[3408]: info: Received an update from plugin. extracting info from payload Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:02 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1238,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1645 Kbps","isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:02 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus play Feb 07 22:56:02 rivoplus volumio[3408]: info: Received an update from plugin. extracting info from payload Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: ------------------------------ 543ms Feb 07 22:56:02 rivoplus volumio[3408]: info: ------------------------------ 544ms Feb 07 22:56:02 rivoplus volumio[3408]: info: ------------------------------ 555ms Feb 07 22:56:02 rivoplus volumio[3408]: info: ------------------------------ 555ms Feb 07 22:56:02 rivoplus volumio[3408]: info: ------------------------------ 553ms Feb 07 22:56:02 rivoplus volumio[3408]: info: ------------------------------ 466ms Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 425 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 425 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 442 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: info: sendMpdCommand playlistinfo took 441 milliseconds Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: verbose: ControllerMpd::parseTrackInfo Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:02 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1615 Kbps","isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:02 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus play Feb 07 22:56:02 rivoplus volumio[3408]: info: Received an update from plugin. extracting info from payload Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:02 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1645 Kbps","isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:02 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus play Feb 07 22:56:02 rivoplus volumio[3408]: info: Received an update from plugin. extracting info from payload Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:02 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:02 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:02 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:02 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1645 Kbps","isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:02 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:02 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus play Feb 07 22:56:03 rivoplus volumio[3408]: info: Received an update from plugin. extracting info from payload Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:03 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:03 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1645 Kbps","isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:03 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus play Feb 07 22:56:03 rivoplus volumio[3408]: info: Received an update from plugin. extracting info from payload Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:03 rivoplus volumio[3408]: info: ControllerMpd::pushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::servicePushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CorePlayQueue::getTrack 2 Feb 07 22:56:03 rivoplus volumio[3408]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":144,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1645 Kbps","isStreaming":false,"title":"335514628","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/335514628","trackType":"qobuz"} Feb 07 22:56:03 rivoplus volumio[3408]: verbose: CURRENT POSITION 2 Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreStateMachine::syncState stateService play Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreStateMachine::syncState currentStatus play Feb 07 22:56:03 rivoplus volumio[3408]: info: Received an update from plugin. extracting info from payload Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreStateMachine::pushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioPushState Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output update for this device Feb 07 22:56:03 rivoplus volumio[3408]: info: MRS: Pushing multiroomSync output Feb 07 22:56:03 rivoplus volumio[3408]: info: ------------------------------ 1130ms Feb 07 22:56:03 rivoplus volumio[3408]: info: ------------------------------ 1129ms Feb 07 22:56:03 rivoplus volumio[3408]: info: ------------------------------ 1128ms Feb 07 22:56:03 rivoplus volumio[3408]: info: ------------------------------ 1122ms Feb 07 22:56:03 rivoplus volumio[3408]: info: ------------------------------ 1119ms Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: info: Signalling Playback active due to playback status change Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: Updating RAAT Signal Path Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:03 rivoplus volumio[3408]: info: MCU Signalled Playback Active Feb 07 22:56:03 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:03 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:03 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:03 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:03 rivoplus volumio[3408]: STREAMING PROXY: Client dropped request, destroying Feb 07 22:56:05 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:05 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:05 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:05 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:05 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:05 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:07 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 07 22:56:08 rivoplus ntpd[5538]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 07 22:56:09 rivoplus volumio[3408]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 07 22:56:09 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 07 22:56:09 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 07 22:56:09 rivoplus sudo[6651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 07 22:56:09 rivoplus sudo[6651]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:56:09 rivoplus sudo[6651]: pam_unix(sudo:session): session closed for user root Feb 07 22:56:09 rivoplus sudo[6657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 07 22:56:09 rivoplus sudo[6657]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:56:09 rivoplus sudo[6657]: pam_unix(sudo:session): session closed for user root Feb 07 22:56:09 rivoplus sudo[6667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 07 22:56:09 rivoplus sudo[6667]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:56:09 rivoplus sudo[6667]: pam_unix(sudo:session): session closed for user root Feb 07 22:56:09 rivoplus sudo[6672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 07 22:56:09 rivoplus sudo[6672]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:56:09 rivoplus sudo[6672]: pam_unix(sudo:session): session closed for user root Feb 07 22:56:09 rivoplus sudo[6678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 22:56:09 rivoplus sudo[6678]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:56:09 rivoplus sudo[6678]: pam_unix(sudo:session): session closed for user root Feb 07 22:56:09 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Feb 07 22:56:09 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Feb 07 22:56:09 rivoplus sudo[6683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 22:56:09 rivoplus sudo[6683]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:56:10 rivoplus sudo[6683]: pam_unix(sudo:session): session closed for user root Feb 07 22:56:10 rivoplus sudo[6687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 22:56:10 rivoplus sudo[6687]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 22:56:10 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:10 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:10 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:10 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:10 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:10 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:10 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:10 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:10 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:11 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:11 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:11 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:11 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:11 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:11 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:11 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:12 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:12 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:12 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:13 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:13 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 8 Feb 07 22:56:14 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c00000 drv_status 0x0 e_type 69 e_states 0 Feb 07 22:56:14 rivoplus sudo[6687]: pam_unix(sudo:session): session closed for user root Feb 07 22:56:14 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:56:14 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:56:14 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:56:14 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:56:14 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:14 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:56:14 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 07 22:56:14 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 07 22:56:14 rivoplus volumio5-onboarding[4020]: time=2026-02-07T22:56:14.959Z level=INFO msg="BLE descriptor updated" deviceId=d91110e55b5b605b297430bc7c7ad922 deviceName=Rivoplus deviceModel=0x2fac208 Feb 07 22:56:14 rivoplus volumio5-onboarding[4020]: time=2026-02-07T22:56:14.964Z level=INFO msg="mDNS descriptor updated" deviceId=d91110e55b5b605b297430bc7c7ad922 deviceName=Rivoplus deviceModel=0x2fac208 Feb 07 22:56:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 07 22:56:15 rivoplus volumio[3408]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 07 22:56:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 07 22:56:15 rivoplus volumio[3408]: info: Received Get System Version Feb 07 22:56:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 22:56:15 rivoplus volumio[3408]: info: Received Get System Info Feb 07 22:56:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 22:56:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 22:56:15 rivoplus volumio[3408]: info: Discovery: Getting this device information Feb 07 22:56:15 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:15 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 22:56:27 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:29 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:29 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:29 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:29 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:29 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:29 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:32 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetState Feb 07 22:56:34 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:34 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:34 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:34 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:34 rivoplus volumio[3408]: info: Executing endpoint metavolumio Feb 07 22:56:34 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 07 22:56:42 rivoplus volumio[3408]: info: Retrieving Cloud Streaming UI Feb 07 22:56:42 rivoplus volumio[3408]: info: Getting Tidal Cloud Configuration Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 07 22:56:42 rivoplus volumio[3408]: info: Getting Qobuz Cloud Configuration Feb 07 22:56:42 rivoplus volumio[3408]: info: Asking plugin for UI Config Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 07 22:56:42 rivoplus volumio[3408]: info: Getting Spotify Cloud Configuration Feb 07 22:56:42 rivoplus volumio[3408]: info: Asking plugin for UI Config Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 07 22:56:42 rivoplus volumio[3408]: info: Saving Spotify Acccount Feb 07 22:56:42 rivoplus volumio[3408]: info: Got it Feb 07 22:56:42 rivoplus volumio[3408]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 07 22:56:42 rivoplus volumio[3408]: info: Got Tidal Cloud Configuration Feb 07 22:56:42 rivoplus volumio[3408]: info: Got it Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetBrowseSources Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetBrowseSources Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::volumioGetBrowseSources Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 07 22:56:42 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 07 22:56:46 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Feb 07 22:56:46 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Feb 07 22:56:46 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 07 22:56:47 rivoplus volumio[3408]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L AirPort-Time-Capsule-de-Joao.local. -m SMB3_11 Feb 07 22:56:50 rivoplus volumio[3408]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 07 22:56:51 rivoplus volumio[3408]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 22:56:51 rivoplus volumio[3408]: Error: dns service error: unknown Feb 07 22:56:51 rivoplus volumio[3408]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Feb 07 22:56:51 rivoplus volumio[3408]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Feb 07 22:56:51 rivoplus volumio[3408]: errorCode: -65537 Feb 07 22:56:51 rivoplus volumio[3408]: } Feb 07 22:56:51 rivoplus volumio[3408]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 22:56:51 rivoplus sudo[6830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 22:55 Feb 07 22:56:51 rivoplus sudo[6830]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:47:33 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="9e8aa5d6afb5e5d87a87bafae7aa5647"