Oct 17 11:15:00 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:00 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:00 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 17 11:15:00 rivo volumio[3578]: info: CoreCommandRouter::volumioPlay Oct 17 11:15:00 rivo volumio[3578]: info: CoreStateMachine::play index undefined Oct 17 11:15:00 rivo volumio[3578]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 11:15:00 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:05 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 17 11:15:05 rivo volumio[3578]: info: CURURI: music-library Oct 17 11:15:05 rivo volumio[3578]: error: Failed LSINFO: null Oct 17 11:15:05 rivo volumio[3578]: info: Preload queue cleared Oct 17 11:15:17 rivo sudo[11407]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 11:15:17 rivo sudo[11407]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:15:17 rivo sudo[11408]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 11:15:17 rivo sudo[11408]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:15:17 rivo sudo[11407]: pam_unix(sudo:session): session closed for user root Oct 17 11:15:17 rivo sudo[11408]: pam_unix(sudo:session): session closed for user root Oct 17 11:15:17 rivo volumio[3578]: verbose: New Socket.io Connection to 192.168.1.36 from 192.168.1.8 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.261014.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 17 11:15:17 rivo volumio[3578]: info: Received Get System Info Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:15:17 rivo volumio[3578]: info: Discovery: Getting this device information Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:17 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:17 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:17 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 11:15:17 rivo volumio[3578]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 17 11:15:17 rivo volumio[3578]: info: Received Get System Info Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:15:17 rivo volumio[3578]: info: Discovery: Getting this device information Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:17 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:17 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:17 rivo volumio[3578]: info: Listing playlists Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::volumioGetQueue Oct 17 11:15:17 rivo volumio[3578]: info: CoreStateMachine::getQueue Oct 17 11:15:17 rivo volumio[3578]: info: CorePlayQueue::getQueue Oct 17 11:15:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 17 11:15:19 rivo sudo[11416]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 11:15:19 rivo sudo[11415]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 11:15:19 rivo sudo[11415]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:15:19 rivo sudo[11416]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:15:19 rivo sudo[11416]: pam_unix(sudo:session): session closed for user root Oct 17 11:15:19 rivo sudo[11415]: pam_unix(sudo:session): session closed for user root Oct 17 11:15:19 rivo volumio[3578]: verbose: New Socket.io Connection to 192.168.1.36 from 192.168.1.8 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.261014.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 17 11:15:19 rivo volumio[3578]: info: Received Get System Info Oct 17 11:15:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:15:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:15:19 rivo volumio[3578]: info: Discovery: Getting this device information Oct 17 11:15:19 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:19 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:15:19 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:19 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 11:15:19 rivo volumio[3578]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 11:15:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 11:15:19 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:19 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 11:15:20 rivo volumio[3578]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 17 11:15:20 rivo volumio[3578]: info: Received Get System Info Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:15:20 rivo volumio[3578]: info: Discovery: Getting this device information Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:20 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:20 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:20 rivo volumio[3578]: info: Listing playlists Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::volumioGetQueue Oct 17 11:15:20 rivo volumio[3578]: info: CoreStateMachine::getQueue Oct 17 11:15:20 rivo volumio[3578]: info: CorePlayQueue::getQueue Oct 17 11:15:20 rivo volumio[3578]: info: Received Get System Info Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:15:20 rivo volumio[3578]: info: Discovery: Getting this device information Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:20 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:20 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.110Z level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.915056ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.127Z level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.145Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=18.276781ms Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.163Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=http://pushupdates.volumio.org duration=35.071262ms Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.173Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=44.319778ms Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.173Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=44.187902ms Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.187Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=https://google.com duration=59.176413ms Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.223Z level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=http://cddb.volumio.org duration=95.49235ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.249Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=https://www.googleapis.com duration=120.872551ms Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.250Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=121.728348ms Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.264Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=https://database.volumio.cloud duration=135.916645ms Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.269Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=https://functions.volumio.cloud duration=140.232381ms Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.273Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=https://functions.volumio.cloud duration=145.293037ms Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.277Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=https://securetoken.googleapis.com duration=148.668933ms Oct 17 11:15:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:15:22.314Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=4.033967ms timeout=10s endpoint=http://plugins.volumio.org duration=185.779749ms Oct 17 11:15:22 rivo sudo[11422]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 11:15:22 rivo sudo[11422]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:15:22 rivo sudo[11424]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 11:15:22 rivo sudo[11424]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:15:22 rivo sudo[11422]: pam_unix(sudo:session): session closed for user root Oct 17 11:15:22 rivo sudo[11424]: pam_unix(sudo:session): session closed for user root Oct 17 11:15:22 rivo volumio[3578]: verbose: New Socket.io Connection to 192.168.1.36 from 192.168.1.8 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.261014.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 17 11:15:22 rivo sudo[11430]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 11:15:22 rivo sudo[11430]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:15:22 rivo sudo[11432]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 11:15:22 rivo sudo[11432]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:15:22 rivo sudo[11430]: pam_unix(sudo:session): session closed for user root Oct 17 11:15:22 rivo sudo[11432]: pam_unix(sudo:session): session closed for user root Oct 17 11:15:22 rivo volumio[3578]: verbose: New Socket.io Connection to 192.168.1.36 from 192.168.1.8 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.261014.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 11:15:22 rivo volumio[3578]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 17 11:15:22 rivo volumio[3578]: info: Received Get System Info Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:15:22 rivo volumio[3578]: info: Discovery: Getting this device information Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:22 rivo volumio[3578]: info: Listing playlists Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 11:15:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 17 11:15:24 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 17 11:15:24 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 11:15:24 rivo volumio[3578]: info: Received Get System Info Oct 17 11:15:24 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:15:24 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:15:24 rivo volumio[3578]: info: Discovery: Getting this device information Oct 17 11:15:24 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:24 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:24 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:15:32 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 17 11:15:42 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 11:15:42 rivo volumio[3578]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 17 11:15:42 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 17 11:15:42 rivo volumio[3578]: info: Received Get System Version Oct 17 11:15:42 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 11:15:42 rivo volumio[3578]: info: Received Get System Info Oct 17 11:15:42 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:15:42 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:15:42 rivo volumio[3578]: info: Discovery: Getting this device information Oct 17 11:15:42 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:15:42 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:15:42 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:16:10 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:10.889Z level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s Oct 17 11:16:10 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:10.949Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=60.271587ms Oct 17 11:16:10 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:10.950Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=http://pushupdates.volumio.org duration=56.481688ms Oct 17 11:16:10 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:10.951Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=58.05549ms Oct 17 11:16:10 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:10.951Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=58.389366ms Oct 17 11:16:10 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:10.979Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=https://google.com duration=86.978755ms Oct 17 11:16:11 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:11.030Z level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=http://cddb.volumio.org duration=136.649733ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 17 11:16:11 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:11.030Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=https://www.googleapis.com duration=138.432244ms Oct 17 11:16:11 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:11.030Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=137.930366ms Oct 17 11:16:11 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:11.035Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=https://database.volumio.cloud duration=140.404507ms Oct 17 11:16:11 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:11.037Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=https://securetoken.googleapis.com duration=145.118244ms Oct 17 11:16:11 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:11.049Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=https://functions.volumio.cloud duration=156.507774ms Oct 17 11:16:11 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:11.062Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=https://functions.volumio.cloud duration=167.877054ms Oct 17 11:16:11 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:11.106Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" latency=5.127184ms timeout=10s endpoint=http://plugins.volumio.org duration=212.052374ms Oct 17 11:16:12 rivo volumio[3578]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 11:16:12 rivo volumio[3578]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 11:16:12 rivo volumio[3578]: info: Retrieving Cloud Streaming UI Oct 17 11:16:12 rivo volumio[3578]: info: Getting Tidal Cloud Configuration Oct 17 11:16:12 rivo volumio[3578]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 11:16:12 rivo volumio[3578]: info: Getting Qobuz Cloud Configuration Oct 17 11:16:12 rivo volumio[3578]: info: Asking plugin for UI Config Oct 17 11:16:12 rivo volumio[3578]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 11:16:12 rivo volumio[3578]: info: Getting Spotify Cloud Configuration Oct 17 11:16:12 rivo volumio[3578]: info: Asking plugin for UI Config Oct 17 11:16:12 rivo volumio[3578]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 11:16:12 rivo volumio[3578]: info: Saving Spotify Acccount Oct 17 11:16:12 rivo volumio[3578]: info: Got it Oct 17 11:16:12 rivo volumio[3578]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 17 11:16:13 rivo volumio[3578]: info: Got Tidal Cloud Configuration Oct 17 11:16:13 rivo volumio[3578]: info: Got it Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::volumioGetBrowseSources Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::volumioGetBrowseSources Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::volumioGetBrowseSources Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 11:16:13 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 17 11:16:17 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 11:16:18 rivo volumio[3578]: info: Disabling MyMusic plugin multiroom Oct 17 11:16:18 rivo volumio[3578]: info: Disabling plugin multiroom Oct 17 11:16:18 rivo volumio[3578]: info: Preparing to generate the ALSA configuration file Oct 17 11:16:18 rivo volumio[3578]: info: Asound.conf file written Oct 17 11:16:18 rivo sudo[11544]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 11:16:18 rivo sudo[11544]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:18 rivo sudo[11544]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:18 rivo volumio[3578]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 17 11:16:18 rivo volumio[3578]: No state is present for card AMLAUGESOUNDMP1 Oct 17 11:16:18 rivo volumio[3578]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 17 11:16:18 rivo volumio[3578]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Oct 17 11:16:18 rivo volumio[3578]: Hardware is initialized using a generic method Oct 17 11:16:18 rivo volumio[3578]: No state is present for card AMLAUGESOUNDMP1 Oct 17 11:16:18 rivo volumio[3578]: info: Output device has changed, restarting MPD Oct 17 11:16:18 rivo volumio[3578]: info: Output device has changed, restarting Shairport Sync Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:16:18 rivo sudo[11550]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 11:16:18 rivo sudo[11550]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:18 rivo sudo[11550]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:18 rivo sudo[11552]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 11:16:18 rivo sudo[11552]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:18 rivo volumio[3578]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 11:16:18 rivo volumio[3578]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo volumio[3578]: info: QobuzConnect: setDeactiveState invoked Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:18 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:18 rivo volumio[3578]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo vtcs[10995]: [2026-10-17 11:16:18.655] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Oct 17 11:16:18 rivo vtcs[10995]: [2026-10-17 11:16:18.663] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Oct 17 11:16:18 rivo volumio[3578]: info: Done. Oct 17 11:16:18 rivo kernel: aml_spdif_open Oct 17 11:16:18 rivo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Oct 17 11:16:18 rivo kernel: spdif_a keep clk continuous Oct 17 11:16:18 rivo kernel: aml_spdif_close Oct 17 11:16:18 rivo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Oct 17 11:16:18 rivo systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 17 11:16:18 rivo sudo[11560]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 17 11:16:18 rivo sudo[11560]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:18 rivo sudo[11563]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 17 11:16:18 rivo sudo[11563]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:18 rivo systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Oct 17 11:16:18 rivo systemd[1]: vtcs.service: Deactivated successfully. Oct 17 11:16:18 rivo systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Oct 17 11:16:18 rivo volumio[3578]: info: MPD Permissions set Oct 17 11:16:18 rivo volumio[3578]: info: CoreStateMachine::pushState Oct 17 11:16:18 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::volumioPushState Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:18 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:18 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:18 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:18 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:18.806Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" state=STATUS_STOPPED positionMs=0 volume=100 Oct 17 11:16:18 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:18.807Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" id= title= Oct 17 11:16:18 rivo sudo[11570]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo sudo[11570]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:18 rivo systemd[1]: mpd.service: Deactivated successfully. Oct 17 11:16:18 rivo systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 11:16:18 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:18 rivo sudo[11560]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:18 rivo volumio[3578]: info: Starting Shairport Sync Oct 17 11:16:18 rivo systemd[1]: mpd.socket: Deactivated successfully. Oct 17 11:16:18 rivo systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 17 11:16:18 rivo systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 17 11:16:18 rivo sudo[11585]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 11:16:18 rivo sudo[11585]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:18 rivo systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 17 11:16:18 rivo systemd[1]: Starting mpd.service - Music Player Daemon... Oct 17 11:16:19 rivo sudo[11570]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:19 rivo sudo[11563]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:19 rivo sudo[11589]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 17 11:16:19 rivo sudo[11589]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:19 rivo systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 17 11:16:19 rivo systemd[1]: shairport-sync.service: Deactivated successfully. Oct 17 11:16:19 rivo systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 17 11:16:19 rivo systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 17 11:16:19 rivo sudo[11585]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:19 rivo volumio[3578]: info: Shairport-Sync Started Oct 17 11:16:19 rivo systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Oct 17 11:16:19 rivo qobuz-connect[10999]: 20261017 11:16:19.208 [10999.10999] INFO SampleApp: Stopping Local configuration server Oct 17 11:16:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 11:16:19 rivo volumio[3578]: info: Not Reporting Auto name since its the default one Oct 17 11:16:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 17 11:16:19 rivo sudo[11615]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 17 11:16:19 rivo sudo[11615]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:19 rivo sudo[11615]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:19 rivo sudo[11617]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 17 11:16:19 rivo sudo[11617]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:19 rivo systemd[1]: Stopping raat-daemon.service - RAAT DAEMON... Oct 17 11:16:19 rivo systemd[1]: raat-daemon.service: Deactivated successfully. Oct 17 11:16:19 rivo systemd[1]: Stopped raat-daemon.service - RAAT DAEMON. Oct 17 11:16:19 rivo sudo[11588]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 11:16:19 rivo sudo[11588]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 17 11:16:19 rivo systemd[1]: Started raat-daemon.service - RAAT DAEMON. Oct 17 11:16:19 rivo sudo[11617]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:19 rivo kernel: aml_spdif_open Oct 17 11:16:19 rivo volumio[3578]: info: Raat Daemon started successfully Oct 17 11:16:19 rivo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Oct 17 11:16:19 rivo kernel: spdif_a keep clk continuous Oct 17 11:16:19 rivo kernel: aml_spdif_close Oct 17 11:16:19 rivo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Oct 17 11:16:19 rivo kernel: aml_spdif_open Oct 17 11:16:19 rivo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Oct 17 11:16:19 rivo kernel: spdif_a keep clk continuous Oct 17 11:16:19 rivo kernel: aml_spdif_close Oct 17 11:16:19 rivo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Oct 17 11:16:19 rivo sudo[11588]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:19 rivo volumio[3578]: info: Executing endpoint restartRAATSocket Oct 17 11:16:19 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 17 11:16:19 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:19 rivo volumio[3578]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Oct 17 11:16:20 rivo volumio[3578]: info: Enabling MyMusic plugin multiroom Oct 17 11:16:20 rivo volumio[3578]: info: Enabling plugin multiroom Oct 17 11:16:20 rivo volumio[3578]: info: Loading plugin "multiroom"... Oct 17 11:16:20 rivo volumio[3578]: info: Applying required configuration parameters for plugin multiroom Oct 17 11:16:20 rivo sudo[11638]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Oct 17 11:16:20 rivo sudo[11638]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:20 rivo sudo[11638]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:20 rivo volumio[3578]: /usr/bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Oct 17 11:16:20 rivo volumio[3578]: info: MRS: MultiRoom plugin initialized Oct 17 11:16:20 rivo volumio[3578]: info: MRS: STOPPING SNAPCLIENT Oct 17 11:16:20 rivo volumio[3578]: info: MRS: Snap server stop Oct 17 11:16:20 rivo volumio[3578]: info: MRS: STOPPING volumioStreaming Oct 17 11:16:20 rivo sudo[11654]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Oct 17 11:16:20 rivo sudo[11654]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:20 rivo sudo[11657]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Oct 17 11:16:20 rivo sudo[11657]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:20 rivo volumio[3578]: info: Preparing to generate the ALSA configuration file Oct 17 11:16:20 rivo sudo[11659]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Oct 17 11:16:20 rivo sudo[11659]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:20 rivo sudo[11662]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Oct 17 11:16:20 rivo sudo[11662]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:20 rivo volumio[3578]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 17 11:16:20 rivo volumio[3578]: info: Reading ALSA contributions from plugins. Oct 17 11:16:20 rivo volumio[3578]: info: Asound.conf file written Oct 17 11:16:20 rivo sudo[11662]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:20 rivo sudo[11666]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 11:16:20 rivo sudo[11666]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:20 rivo qobuz-connect[10999]: 20261017 11:16:20.394 [10999.10999] INFO SampleApp: shat down connection on UNIX socket Oct 17 11:16:20 rivo sudo[11666]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:20 rivo sudo[11654]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:20 rivo sudo[11657]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:20 rivo volumio[3578]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 17 11:16:20 rivo volumio[3578]: No state is present for card AMLAUGESOUNDMP1 Oct 17 11:16:20 rivo volumio[3578]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 17 11:16:20 rivo volumio[3578]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Oct 17 11:16:20 rivo volumio[3578]: Hardware is initialized using a generic method Oct 17 11:16:20 rivo volumio[3578]: No state is present for card AMLAUGESOUNDMP1 Oct 17 11:16:20 rivo volumio[3578]: info: Output device has changed, restarting MPD Oct 17 11:16:20 rivo systemd[1]: qobuz-connect.service: Deactivated successfully. Oct 17 11:16:20 rivo systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 17 11:16:20 rivo volumio[3578]: info: Output device has changed, restarting Shairport Sync Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:16:20 rivo sudo[11659]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:20 rivo sudo[11671]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 11:16:20 rivo sudo[11671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:20 rivo sudo[11673]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 11:16:20 rivo sudo[11673]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:20 rivo systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 17 11:16:20 rivo sudo[11589]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:20 rivo sudo[11671]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:20 rivo volumio[3578]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 11:16:20 rivo volumio[3578]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo volumio[3578]: info: QobuzConnect: setDeactiveState invoked Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:20 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:20 rivo volumio[3578]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo kernel: aml_spdif_open Oct 17 11:16:20 rivo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Oct 17 11:16:20 rivo kernel: spdif_a keep clk continuous Oct 17 11:16:20 rivo kernel: aml_spdif_close Oct 17 11:16:20 rivo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Oct 17 11:16:20 rivo volumio[3578]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo volumio[3578]: info: PLUGIN START: multiroom Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Oct 17 11:16:20 rivo volumio[3578]: info: MRS: Pushing multiroomSync output for this device Oct 17 11:16:20 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:20 rivo systemd[1]: mpd.service: Deactivated successfully. Oct 17 11:16:20 rivo systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 17 11:16:20 rivo systemd[1]: mpd.socket: Deactivated successfully. Oct 17 11:16:20 rivo systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 17 11:16:20 rivo systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 17 11:16:20 rivo volumio[3578]: info: Adding audio output: Oct 17 11:16:20 rivo volumio[3578]: error: Can't add: Oct 17 11:16:20 rivo volumio[3578]: info: Adding audio output: Oct 17 11:16:20 rivo volumio[3578]: error: Can't add: Oct 17 11:16:20 rivo sudo[11684]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 17 11:16:20 rivo sudo[11684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:20 rivo kernel: aml_spdif_open Oct 17 11:16:20 rivo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Oct 17 11:16:20 rivo kernel: spdif_a keep clk continuous Oct 17 11:16:20 rivo kernel: aml_spdif_close Oct 17 11:16:20 rivo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Oct 17 11:16:20 rivo volumio[3578]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 17 11:16:20 rivo kernel: aml_spdif_open Oct 17 11:16:20 rivo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Oct 17 11:16:20 rivo systemd[1]: Starting mpd.service - Music Player Daemon... Oct 17 11:16:20 rivo kernel: spdif_a keep clk continuous Oct 17 11:16:20 rivo kernel: aml_spdif_close Oct 17 11:16:20 rivo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Oct 17 11:16:20 rivo sudo[11696]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 17 11:16:20 rivo sudo[11696]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:20 rivo volumio[3578]: info: MPD Permissions set Oct 17 11:16:20 rivo volumio[3578]: info: MRS: volumioStreaming STOPPED Oct 17 11:16:20 rivo volumio[3578]: info: MRS: SNAPSERVER STOPPED Oct 17 11:16:20 rivo volumio[3578]: info: MRS: SNAPCLIENT STOPPED Oct 17 11:16:20 rivo volumio[3578]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Oct 17 11:16:20 rivo sudo[11684]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:20 rivo volumio[3578]: info: QobuzConnect: setDeactiveState invoked Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:20 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:20 rivo volumio[3578]: info: MRS: Removed streaming files Oct 17 11:16:20 rivo volumio[3578]: info: CoreStateMachine::pushState Oct 17 11:16:20 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::volumioPushState Oct 17 11:16:20 rivo sudo[11701]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 17 11:16:20 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:20.887Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" state=STATUS_STOPPED positionMs=0 volume=100 Oct 17 11:16:20 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:20.888Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" id= title= Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:20 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:20 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:20 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:20 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:20 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:20 rivo sudo[11701]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:20 rivo volumio[3578]: info: Executing endpoint qc_getconfig Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 17 11:16:20 rivo qobuz-connect[11679]: 20261017 11:16:20.930 [11679.11679] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:20 rivo sudo[11701]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:20 rivo qobuz-connect[11679]: 20261017 11:16:20.953 [11679.11679] INFO VolumeManager: [0xab4b8238]: Setting new playback volume: 75 Oct 17 11:16:20 rivo qobuz-connect[11679]: 20261017 11:16:20.953 [11679.11679] INFO VolumeManager: [0xab4b8238]: Setting new mute state: 0 Oct 17 11:16:20 rivo qobuz-connect[11679]: 20261017 11:16:20.953 [11679.11679] INFO AudioStreamManager: [0xab4b7f90]: Setting new audio download buffer size: 1048576 Oct 17 11:16:20 rivo qobuz-connect[11679]: 20261017 11:16:20.953 [11679.11679] INFO QobuzConnect: [0xab4b8b00]: Client initialized! Oct 17 11:16:20 rivo qobuz-connect[11679]: 20261017 11:16:20.953 [11679.11679] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Oct 17 11:16:20 rivo qobuz-connect[11679]: 20261017 11:16:20.971 [11679.11679] INFO LocalConfigManager: [0xab4b7cb8]: Starting Local Configuration server Oct 17 11:16:20 rivo qobuz-connect[11679]: 20261017 11:16:20.971 [11679.11679] INFO SampleApp: Starting Local configuration server Oct 17 11:16:20 rivo qobuz-connect[11679]: 20261017 11:16:20.971 [11679.11679] INFO SampleApp: Connected to UNIX socket client 0xab4a2908 Oct 17 11:16:20 rivo sudo[11696]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:16:20 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 11:16:20 rivo sudo[11708]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 17 11:16:20 rivo sudo[11708]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:21 rivo volumio[3578]: info: Done. Oct 17 11:16:21 rivo volumio[3578]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Oct 17 11:16:21 rivo volumio[3578]: info: QobuzConnect: QOBUZ Connect daemon connected Oct 17 11:16:21 rivo volumio[3578]: info: Starting Shairport Sync Oct 17 11:16:21 rivo systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Oct 17 11:16:21 rivo qobuz-connect[11679]: 20261017 11:16:21.041 [11679.11679] INFO SampleApp: Stopping Local configuration server Oct 17 11:16:21 rivo sudo[11719]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 11:16:21 rivo sudo[11719]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:21 rivo systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 17 11:16:21 rivo systemd[1]: shairport-sync.service: Deactivated successfully. Oct 17 11:16:21 rivo systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 11:16:21 rivo systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 17 11:16:21 rivo sudo[11719]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:21 rivo volumio[3578]: info: Shairport-Sync Started Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 11:16:21 rivo volumio[3578]: info: Not Reporting Auto name since its the default one Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 17 11:16:21 rivo volumio[3578]: info: Disabling MyMusic plugin upnp Oct 17 11:16:21 rivo sudo[11695]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 11:16:21 rivo sudo[11695]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 17 11:16:21 rivo sudo[11743]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 17 11:16:21 rivo sudo[11743]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:21 rivo sudo[11695]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:21 rivo sudo[11746]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Oct 17 11:16:21 rivo sudo[11746]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:21 rivo sudo[11743]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:21 rivo sudo[11749]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 17 11:16:21 rivo sudo[11749]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:21 rivo systemd[1]: Stopping upmpdcli.service - UPnP Renderer front-end to MPD... Oct 17 11:16:21 rivo systemd[1]: Stopping raat-daemon.service - RAAT DAEMON... Oct 17 11:16:21 rivo systemd[1]: raat-daemon.service: Deactivated successfully. Oct 17 11:16:21 rivo systemd[1]: Stopped raat-daemon.service - RAAT DAEMON. Oct 17 11:16:21 rivo systemd[1]: Started raat-daemon.service - RAAT DAEMON. Oct 17 11:16:21 rivo sudo[11749]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:21 rivo volumio[3578]: info: Raat Daemon started successfully Oct 17 11:16:21 rivo kernel: aml_spdif_open Oct 17 11:16:21 rivo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Oct 17 11:16:21 rivo kernel: spdif_a keep clk continuous Oct 17 11:16:21 rivo kernel: aml_spdif_close Oct 17 11:16:21 rivo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Oct 17 11:16:21 rivo kernel: aml_spdif_open Oct 17 11:16:21 rivo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Oct 17 11:16:21 rivo kernel: spdif_a keep clk continuous Oct 17 11:16:21 rivo kernel: aml_spdif_close Oct 17 11:16:21 rivo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Oct 17 11:16:21 rivo volumio[3578]: info: Executing endpoint restartRAATSocket Oct 17 11:16:21 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 17 11:16:21 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:21 rivo volumio[3578]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Oct 17 11:16:21 rivo volumio[3578]: info: TidalConnect service stoped! Oct 17 11:16:22 rivo volumio[3578]: info: TidalConnect service stoped! Oct 17 11:16:22 rivo volumio[3578]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 17 11:16:22 rivo volumio[3578]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 17 11:16:22 rivo sudo[11773]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 17 11:16:22 rivo sudo[11773]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:22 rivo systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Oct 17 11:16:22 rivo sudo[11773]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:22 rivo volumio[3578]: info: RAAT: Requesting Headphone Status Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Oct 17 11:16:22 rivo volumio[3578]: info: MCU Signalled Headphone Mode Disabled Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 17 11:16:22 rivo volumio[3578]: info: Reporting Headphone State: false Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:22 rivo volumio[3578]: info: Updating RAAT Signal Path Oct 17 11:16:22 rivo volumio[3578]: info: Executing endpoint tc_getconfig Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 17 11:16:22 rivo vtcs[11777]: STARTING TidalConnect services, version: 1.6.1 Oct 17 11:16:22 rivo vtcs[11777]: STARTED TidalConnect services. Oct 17 11:16:22 rivo volumio[3578]: info: Executing endpoint tc_connect Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Oct 17 11:16:22 rivo volumio[3578]: info: Connecting to TidalConnect Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::servicePushState Oct 17 11:16:22 rivo volumio[3578]: info: CoreStateMachine::pushState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioPushState Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Oct 17 11:16:22 rivo volumio[3578]: verbose: CURRENT POSITION 0 Oct 17 11:16:22 rivo volumio[3578]: info: CoreStateMachine::syncState stateService stop Oct 17 11:16:22 rivo volumio[3578]: info: CoreStateMachine::syncState currentStatus stop Oct 17 11:16:22 rivo volumio[3578]: info: CoreStateMachine::pushState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioPushState Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio[3578]: info: No code Oct 17 11:16:22 rivo volumio[3578]: info: CoreStateMachine::pushState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioPushState Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::servicePushState Oct 17 11:16:22 rivo volumio[3578]: info: CoreStateMachine::pushState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioPushState Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Oct 17 11:16:22 rivo volumio[3578]: verbose: CURRENT POSITION 0 Oct 17 11:16:22 rivo volumio[3578]: info: CoreStateMachine::syncState stateService stop Oct 17 11:16:22 rivo volumio[3578]: info: CoreStateMachine::syncState currentStatus stop Oct 17 11:16:22 rivo volumio[3578]: info: CoreStateMachine::pushState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioPushState Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio[3578]: info: No code Oct 17 11:16:22 rivo volumio[3578]: info: CoreStateMachine::pushState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioPushState Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output update for this device Oct 17 11:16:22 rivo volumio[3578]: info: MRS: Pushing multiroomSync output Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.777Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" state=STATUS_STOPPED positionMs=0 volume=100 Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.778Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" id= title= Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.780Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" state=STATUS_STOPPED positionMs=0 volume=100 Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.781Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" id= title= Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.782Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" state=STATUS_STOPPED positionMs=0 volume=100 Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.783Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" state=STATUS_STOPPED positionMs=0 volume=100 Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.784Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" state=STATUS_STOPPED positionMs=0 volume=100 Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.784Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" id= title= Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.784Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" id= title= Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.785Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" id= title= Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.788Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" state=STATUS_STOPPED positionMs=0 volume=100 Oct 17 11:16:22 rivo volumio5-onboarding[3881]: time=2026-10-17T09:16:22.789Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.8:62178,00:00:00:00:00:00%05 @ 0x3200480" id= title= Oct 17 11:16:22 rivo qobuz-connect[11679]: 20261017 11:16:22.989 [11679.11679] INFO SampleApp: shat down connection on UNIX socket Oct 17 11:16:22 rivo volumio[3578]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Oct 17 11:16:22 rivo volumio[3578]: info: QobuzConnect: setDeactiveState invoked Oct 17 11:16:22 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:22 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:22 rivo systemd[1]: qobuz-connect.service: Deactivated successfully. Oct 17 11:16:22 rivo systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 17 11:16:23 rivo systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 17 11:16:23 rivo sudo[11708]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:23 rivo volumio[3578]: info: Executing endpoint qc_getconfig Oct 17 11:16:23 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 17 11:16:23 rivo qobuz-connect[11792]: 20261017 11:16:23.127 [11792.11792] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Oct 17 11:16:23 rivo volumio[3578]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Oct 17 11:16:23 rivo volumio[3578]: info: QobuzConnect: QOBUZ Connect daemon connected Oct 17 11:16:23 rivo qobuz-connect[11792]: 20261017 11:16:23.135 [11792.11792] INFO VolumeManager: [0xab911238]: Setting new playback volume: 75 Oct 17 11:16:23 rivo qobuz-connect[11792]: 20261017 11:16:23.135 [11792.11792] INFO VolumeManager: [0xab911238]: Setting new mute state: 0 Oct 17 11:16:23 rivo qobuz-connect[11792]: 20261017 11:16:23.135 [11792.11792] INFO AudioStreamManager: [0xab910f90]: Setting new audio download buffer size: 1048576 Oct 17 11:16:23 rivo qobuz-connect[11792]: 20261017 11:16:23.135 [11792.11792] INFO QobuzConnect: [0xab911b00]: Client initialized! Oct 17 11:16:23 rivo qobuz-connect[11792]: 20261017 11:16:23.135 [11792.11792] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Oct 17 11:16:23 rivo qobuz-connect[11792]: 20261017 11:16:23.158 [11792.11792] INFO LocalConfigManager: [0xab910cb8]: Starting Local Configuration server Oct 17 11:16:23 rivo qobuz-connect[11792]: 20261017 11:16:23.158 [11792.11792] INFO SampleApp: Starting Local configuration server Oct 17 11:16:23 rivo qobuz-connect[11792]: 20261017 11:16:23.158 [11792.11792] INFO SampleApp: Connected to UNIX socket client 0xab8fb908 Oct 17 11:16:23 rivo qobuz-connect[11792]: 20261017 11:16:23.277 [11792.11792] INFO SampleApp: Playback volume changed: 75 Oct 17 11:16:23 rivo volumio[3578]: info: CoreCommandRouter::volumioGetState Oct 17 11:16:23 rivo volumio[3578]: info: CorePlayQueue::getTrack 0 Oct 17 11:16:23 rivo volumio[3578]: info: TidalConnect service stoped! Oct 17 11:16:23 rivo volumio[3578]: info: TidalConnect service stoped! Oct 17 11:16:24 rivo volumio[3578]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 17 11:16:24 rivo volumio[3578]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 17 11:16:24 rivo sudo[11806]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 17 11:16:24 rivo sudo[11806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 11:16:24 rivo sudo[11806]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:24 rivo volumio[3578]: info: RAAT: Requesting Headphone Status Oct 17 11:16:24 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Oct 17 11:16:24 rivo volumio[3578]: info: MCU Signalled Headphone Mode Disabled Oct 17 11:16:24 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 17 11:16:24 rivo volumio[3578]: info: Reporting Headphone State: false Oct 17 11:16:24 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:24 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:16:24 rivo volumio[3578]: info: Updating RAAT Signal Path Oct 17 11:16:24 rivo mpd[11750]: 2026-10-17T11:16:24 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 11:16:24 rivo systemd[1]: Started mpd.service - Music Player Daemon. Oct 17 11:16:24 rivo sudo[11552]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:24 rivo sudo[11673]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:24 rivo volumio[3578]: error: MPD error: The expression evaluated to a falsy value: Oct 17 11:16:24 rivo volumio[3578]: assert.ok(self.idling) Oct 17 11:16:24 rivo volumio[3578]: error: The expression evaluated to a falsy value: Oct 17 11:16:24 rivo volumio[3578]: assert.ok(self.idling) Oct 17 11:16:24 rivo volumio[3578]: error: updateQueue error: null Oct 17 11:16:25 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 11:16:25 rivo volumio[3578]: info: TidalConnect service started! Oct 17 11:16:25 rivo volumio[3578]: info: MRS: Getting audio outputs on start Oct 17 11:16:25 rivo volumio[3578]: info: MRS: Requesting all other devices output Oct 17 11:16:27 rivo volumio[3578]: info: TidalConnect service started! Oct 17 11:16:29 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 17 11:16:31 rivo volumio[3578]: info: Enabling MyMusic plugin upnp Oct 17 11:16:31 rivo volumio[3578]: info: Enabling plugin upnp Oct 17 11:16:31 rivo volumio[3578]: info: Loading plugin "upnp"... Oct 17 11:16:31 rivo volumio[3578]: info: [1792228591501] Starting Upmpd Daemon Oct 17 11:16:31 rivo volumio[3578]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 11:16:31 rivo volumio[3578]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 11:16:31 rivo volumio[3578]: Error: listen EADDRINUSE: address already in use :::6599 Oct 17 11:16:31 rivo volumio[3578]: at Server.setupListenHandle [as _listen2] (node:net:1872:16) Oct 17 11:16:31 rivo volumio[3578]: at listenInCluster (node:net:1920:12) Oct 17 11:16:31 rivo volumio[3578]: at Server.listen (node:net:2008:7) Oct 17 11:16:31 rivo volumio[3578]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Oct 17 11:16:31 rivo volumio[3578]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Oct 17 11:16:31 rivo volumio[3578]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 17 11:16:31 rivo volumio[3578]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 17 11:16:31 rivo volumio[3578]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Oct 17 11:16:31 rivo volumio[3578]: code: 'EADDRINUSE', Oct 17 11:16:31 rivo volumio[3578]: errno: -98, Oct 17 11:16:31 rivo volumio[3578]: syscall: 'listen', Oct 17 11:16:31 rivo volumio[3578]: address: '::', Oct 17 11:16:31 rivo volumio[3578]: port: 6599 Oct 17 11:16:31 rivo volumio[3578]: } Oct 17 11:16:31 rivo volumio[3578]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 11:16:31 rivo systemd[1]: upmpdcli.service: State 'stop-sigterm' timed out. Killing. Oct 17 11:16:31 rivo systemd[1]: upmpdcli.service: Killing process 10135 (upmpdcli) with signal SIGKILL. Oct 17 11:16:31 rivo systemd[1]: upmpdcli.service: Main process exited, code=killed, status=9/KILL Oct 17 11:16:31 rivo systemd[1]: upmpdcli.service: Failed with result 'timeout'. Oct 17 11:16:31 rivo systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 17 11:16:31 rivo sudo[11746]: pam_unix(sudo:session): session closed for user root Oct 17 11:16:32 rivo sudo[11843]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-17 11:15' Oct 17 11:16:32 rivo sudo[11843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="8ed05bf20f96eb8557ed5652c420f84f39d66325" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0a52c1fb90959ba1872a2fb0225e56fe615b19ac" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 16 16:27:36 UTC 2026" VOLUMIO_VERSION="4.208" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="be0c94671215c2b1bf2440825a1e4211"