-- Logs begin at Mon 2026-04-13 03:40:21 CEST, end at Mon 2026-04-13 14:47:21 CEST. -- Apr 13 14:46:25 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:25.578+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=172.20.10.5:43396 Apr 13 14:46:25 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:25 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:25 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:25 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:25 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:25 rivoooo volumio[6965]: verbose: New Socket.io Connection to 172.20.10.2:3000 from 172.20.10.5 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Apr 13 14:46:25 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 13 14:46:25 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.268+02:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="172.20.10.5:43396 @ 0x324a0c0" latency=252.901169ms platform=PLATFORM_ANDROID version=5.260331.0 Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.269+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="172.20.10.5:43396 @ 0x324a0c0" latency=253.642173ms timeout=10s Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.269+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" Apr 13 14:46:33 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:33 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.274+02:00 level=INFO msg="emitting device name changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" name=Rivoooo Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.275+02:00 level=INFO msg="emitting device language changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" language=en Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.278+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" timezone=Europe/Copenhagen Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.280+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" available=true connected=true macAddress=02:00:00:1b:32:01 ip4Address=172.20.10.2/28 ip6Address= Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.283+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.283+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" setupComplete=true Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Apr 13 14:46:33 rivoooo volumio[6965]: xcb_connection_has_error() returned true Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.365+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" selectedOutputId=0,2 Apr 13 14:46:33 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:33 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.434+02:00 level=INFO msg="emitting software info changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" currentVersion=3.912 latestVersion=3.912 Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.435+02:00 level=INFO msg="emitting software update progress event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" status=UPDATE_STATUS_NONE progress=0 Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.435+02:00 level=INFO msg="emitting user changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" userId=M18F1iNXaCa8MLr7o8x5Dwra5uX2 Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.435+02:00 level=INFO msg="emitting music providers changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" providers=9 Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.436+02:00 level=INFO msg="emitting plugins changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" plugins=32 Apr 13 14:46:33 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.440+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" state=STATUS_PLAYING positionMs=1830627 volume=100 Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.441+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" id="https://live-bauerdk.sharp-stream.com/radiosoft_dk_mp3?direct=true&aw_0_1st.playerid=BMUK_TuneIn&aw_0_1st.skey=7374499933&stationCode=dso" title="Anti-Hero - Taylor Swift" Apr 13 14:46:33 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:46:33.495+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="172.20.10.5:43396 @ 0x324a0c0" latency=245.497794ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Apr 13 14:46:35 rivoooo sudo[23284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 14:46:35 rivoooo sudo[23284]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:46:35 rivoooo sudo[23284]: pam_unix(sudo:session): session closed for user root Apr 13 14:46:35 rivoooo sudo[23288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 14:46:35 rivoooo sudo[23288]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:46:35 rivoooo sudo[23288]: pam_unix(sudo:session): session closed for user root Apr 13 14:46:35 rivoooo volumio[6965]: verbose: New Socket.io Connection to 172.20.10.2 from 172.20.10.5 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.177 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 14:46:35 rivoooo volumio[6965]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 13 14:46:35 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:35 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:35 rivoooo volumio[6965]: info: Listing playlists Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 13 14:46:35 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 13 14:46:36 rivoooo sudo[23293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 14:46:36 rivoooo sudo[23293]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:46:36 rivoooo sudo[23293]: pam_unix(sudo:session): session closed for user root Apr 13 14:46:36 rivoooo sudo[23297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 14:46:36 rivoooo sudo[23297]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:46:36 rivoooo sudo[23297]: pam_unix(sudo:session): session closed for user root Apr 13 14:46:36 rivoooo volumio[6965]: verbose: New Socket.io Connection to 172.20.10.2 from 172.20.10.5 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.177 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 14:46:36 rivoooo volumio[6965]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 13 14:46:36 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:36 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:36 rivoooo volumio[6965]: info: Listing playlists Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 13 14:46:36 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 13 14:46:37 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 13 14:46:37 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 14:46:37 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:37 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:37 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:37 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:37 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:37 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:37 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 13 14:46:39 rivoooo sudo[23301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 14:46:39 rivoooo sudo[23301]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:46:39 rivoooo sudo[23301]: pam_unix(sudo:session): session closed for user root Apr 13 14:46:39 rivoooo sudo[23305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 14:46:39 rivoooo sudo[23305]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:46:39 rivoooo sudo[23305]: pam_unix(sudo:session): session closed for user root Apr 13 14:46:39 rivoooo volumio[6965]: verbose: New Socket.io Connection to 172.20.10.2 from 172.20.10.5 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.177 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Apr 13 14:46:39 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:39 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 14:46:39 rivoooo volumio[6965]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 13 14:46:39 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:39 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:39 rivoooo volumio[6965]: info: Listing playlists Apr 13 14:46:39 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 13 14:46:41 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 14:46:41 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:41 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:41 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:41 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:41 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:41 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:41 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 14:46:41 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:41 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:41 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:41 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:41 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:41 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:43 rivoooo sudo[23326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 14:46:43 rivoooo sudo[23326]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:46:43 rivoooo sudo[23326]: pam_unix(sudo:session): session closed for user root Apr 13 14:46:43 rivoooo sudo[23330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 14:46:43 rivoooo sudo[23330]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:46:43 rivoooo sudo[23330]: pam_unix(sudo:session): session closed for user root Apr 13 14:46:43 rivoooo volumio[6965]: verbose: New Socket.io Connection to 172.20.10.2 from 172.20.10.5 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.177 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Apr 13 14:46:43 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:43 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 14:46:43 rivoooo volumio[6965]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 13 14:46:43 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:43 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:43 rivoooo volumio[6965]: info: Listing playlists Apr 13 14:46:43 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:43 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:43 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 13 14:46:46 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 13 14:46:49 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 14:46:51 rivoooo volumio[6965]: info: Retrieving Cloud Streaming UI Apr 13 14:46:51 rivoooo volumio[6965]: info: Getting Tidal Cloud Configuration Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 14:46:51 rivoooo volumio[6965]: info: Getting Qobuz Cloud Configuration Apr 13 14:46:51 rivoooo volumio[6965]: info: Asking plugin for UI Config Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 14:46:51 rivoooo volumio[6965]: info: Getting Spotify Cloud Configuration Apr 13 14:46:51 rivoooo volumio[6965]: info: Asking plugin for UI Config Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 14:46:51 rivoooo volumio[6965]: info: Saving Spotify Acccount Apr 13 14:46:51 rivoooo volumio[6965]: info: Got it Apr 13 14:46:51 rivoooo volumio[6965]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 14:46:51 rivoooo volumio[6965]: info: Got Tidal Cloud Configuration Apr 13 14:46:51 rivoooo volumio[6965]: info: Got it Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 14:46:51 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 13 14:46:53 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 13 14:46:54 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 13 14:46:54 rivoooo volumio[6965]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 13 14:46:54 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 13 14:46:54 rivoooo volumio[6965]: info: Received Get System Version Apr 13 14:46:54 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 14:46:54 rivoooo volumio[6965]: info: Received Get System Info Apr 13 14:46:54 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:46:54 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:46:54 rivoooo volumio[6965]: info: Discovery: Getting this device information Apr 13 14:46:54 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:46:54 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:46:55 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 14:46:59 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 14:47:06 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetQueue Apr 13 14:47:06 rivoooo volumio[6965]: info: CoreStateMachine::getQueue Apr 13 14:47:06 rivoooo volumio[6965]: info: CorePlayQueue::getQueue Apr 13 14:47:08 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 13 14:47:08 rivoooo volumio[6965]: info: Preload queue cleared Apr 13 14:47:10 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 13 14:47:11 rivoooo volumio[6965]: info: Preload queue cleared Apr 13 14:47:13 rivoooo volumio[6965]: info: Preload queue cleared Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::ClearQueue Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::stop Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 14:47:13 rivoooo volumio[6965]: info: CorePlayQueue::clearPlayQueue Apr 13 14:47:13 rivoooo volumio[6965]: info: CorePlayQueue::saveQueue Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushQueue Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::addQueueItems Apr 13 14:47:13 rivoooo volumio[6965]: info: CorePlayQueue::addQueueItems Apr 13 14:47:13 rivoooo volumio[6965]: info: Preload queue cleared Apr 13 14:47:13 rivoooo volumio[6965]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushQueue Apr 13 14:47:13 rivoooo volumio[6965]: info: CorePlayQueue::saveQueue Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::updateTrackBlock Apr 13 14:47:13 rivoooo volumio[6965]: info: CorePlayQueue::getTrackBlock Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPlay Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::play index 0 Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::stop Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::play index undefined Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 14:47:13 rivoooo volumio[6965]: info: CorePlayQueue::getTrack 0 Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::startPlaybackTimer Apr 13 14:47:13 rivoooo volumio[6965]: info: CorePlayQueue::getTrack 0 Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 13 14:47:13 rivoooo volumio[6965]: info: METAVOLUMIO: Retrieving similar tracks from metavolumio Apr 13 14:47:13 rivoooo volumio[6965]: info: [1776084433114] ControllerWebradio::clearAddPlayTrack Apr 13 14:47:13 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 14:47:13 rivoooo volumio[6965]: info: sendMpdCommand stop took 13 milliseconds Apr 13 14:47:13 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand clear Apr 13 14:47:13 rivoooo volumio[6965]: info: Apr 13 14:47:13 rivoooo volumio[6965]: ---------------------------- MPD announces system playlist update Apr 13 14:47:13 rivoooo volumio[6965]: info: Ignoring MPD Status Update Apr 13 14:47:13 rivoooo volumio[6965]: info: sendMpdCommand clear took 5 milliseconds Apr 13 14:47:13 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Apr 13 14:47:13 rivoooo volumio[6965]: info: Apr 13 14:47:13 rivoooo volumio[6965]: ---------------------------- MPD announces system playlist update Apr 13 14:47:13 rivoooo volumio[6965]: info: Ignoring MPD Status Update Apr 13 14:47:13 rivoooo volumio[6965]: info: Apr 13 14:47:13 rivoooo volumio[6965]: ---------------------------- MPD announces system playlist update Apr 13 14:47:13 rivoooo volumio[6965]: info: Ignoring MPD Status Update Apr 13 14:47:13 rivoooo volumio[6965]: error: updateQueue error: null Apr 13 14:47:13 rivoooo volumio[6965]: info: ------------------------------ 9ms Apr 13 14:47:13 rivoooo volumio[6965]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 440 milliseconds Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 13 14:47:13 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand play Apr 13 14:47:13 rivoooo volumio[6965]: info: Apr 13 14:47:13 rivoooo volumio[6965]: ---------------------------- MPD announces system playlist update Apr 13 14:47:13 rivoooo volumio[6965]: info: Ignoring MPD Status Update Apr 13 14:47:13 rivoooo volumio[6965]: info: ------------------------------ 444ms Apr 13 14:47:13 rivoooo volumio[6965]: info: ------------------------------ 443ms Apr 13 14:47:13 rivoooo volumio[6965]: info: sendMpdCommand play took 4 milliseconds Apr 13 14:47:13 rivoooo volumio[6965]: info: Apr 13 14:47:13 rivoooo volumio[6965]: ---------------------------- MPD announces system playlist update Apr 13 14:47:13 rivoooo volumio[6965]: info: Ignoring MPD Status Update Apr 13 14:47:13 rivoooo volumio[6965]: info: Apr 13 14:47:13 rivoooo volumio[6965]: ---------------------------- MPD announces system playlist update Apr 13 14:47:13 rivoooo volumio[6965]: info: Ignoring MPD Status Update Apr 13 14:47:13 rivoooo volumio[6965]: info: ------------------------------ 11ms Apr 13 14:47:13 rivoooo volumio[6965]: info: ------------------------------ 7ms Apr 13 14:47:13 rivoooo volumio[6965]: info: ------------------------------ 6ms Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: my_music , getSuperSearchEnabledSourcesList Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 14:47:13 rivoooo volumio[6965]: info: All cached search sources collected Apr 13 14:47:13 rivoooo volumio[6965]: info: All cached search sources collected Apr 13 14:47:13 rivoooo volumio[6965]: info: All cached search sources collected Apr 13 14:47:13 rivoooo volumio[6965]: info: All cached search sources collected Apr 13 14:47:13 rivoooo volumio[6965]: info: All cached search sources collected Apr 13 14:47:13 rivoooo volumio[6965]: info: All cached search sources collected Apr 13 14:47:13 rivoooo volumio[6965]: info: All cached search sources collected Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:13 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:13 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Apr 13 14:47:14 rivoooo volumio[6965]: info: Getting Calm Radio categories data Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Apr 13 14:47:14 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Apr 13 14:47:15 rivoooo kernel: aml_spdif_open Apr 13 14:47:15 rivoooo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Apr 13 14:47:15 rivoooo kernel: set normal 512 fs /4 fs Apr 13 14:47:15 rivoooo kernel: set spdifout clk:5644800, mpll:22579200 Apr 13 14:47:15 rivoooo kernel: get spdifout clk:5644797, mpll:22579186 Apr 13 14:47:15 rivoooo kernel: aml_dai_set_spdif_fmt , fmt 0x4000 Apr 13 14:47:15 rivoooo kernel: set normal 512 fs /4 fs Apr 13 14:47:15 rivoooo kernel: set spdifout clk:5644800, mpll:22579200 Apr 13 14:47:15 rivoooo kernel: get spdifout clk:5644797, mpll:22579186 Apr 13 14:47:15 rivoooo kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Apr 13 14:47:15 rivoooo kernel: aml_spdif_fifo_ctrl, bit depth:24, frddr type:4, toddr:type:4 Apr 13 14:47:15 rivoooo kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Apr 13 14:47:15 rivoooo kernel: aml_spdif_fifo_ctrl, bit depth:24, frddr type:4, toddr:type:4 Apr 13 14:47:15 rivoooo kernel: asoc-aml-card auge_sound: S/PDIF Playback enable Apr 13 14:47:17 rivoooo volumio[6965]: info: Apr 13 14:47:17 rivoooo volumio[6965]: ---------------------------- MPD announces state update: player Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::getState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand status Apr 13 14:47:17 rivoooo volumio[6965]: info: Apr 13 14:47:17 rivoooo volumio[6965]: ---------------------------- MPD announces state update: player Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::getState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand status Apr 13 14:47:17 rivoooo volumio[6965]: info: Apr 13 14:47:17 rivoooo volumio[6965]: ---------------------------- MPD announces state update: player Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::getState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand status Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3015 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 2950 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: Apr 13 14:47:17 rivoooo volumio[6965]: ---------------------------- MPD announces system playlist update Apr 13 14:47:17 rivoooo volumio[6965]: info: Ignoring MPD Status Update Apr 13 14:47:17 rivoooo volumio[6965]: info: Apr 13 14:47:17 rivoooo volumio[6965]: ---------------------------- MPD announces state update: player Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::getState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand status Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand status took 272 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand status took 271 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand status took 270 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 14:47:17 rivoooo volumio[6965]: info: Apr 13 14:47:17 rivoooo volumio[6965]: ---------------------------- MPD announces system playlist update Apr 13 14:47:17 rivoooo volumio[6965]: info: Ignoring MPD Status Update Apr 13 14:47:17 rivoooo volumio[6965]: info: Apr 13 14:47:17 rivoooo volumio[6965]: ---------------------------- MPD announces state update: player Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::getState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand status Apr 13 14:47:17 rivoooo volumio[6965]: info: Apr 13 14:47:17 rivoooo volumio[6965]: ---------------------------- MPD announces system playlist update Apr 13 14:47:17 rivoooo volumio[6965]: info: Ignoring MPD Status Update Apr 13 14:47:17 rivoooo volumio[6965]: info: Apr 13 14:47:17 rivoooo volumio[6965]: ---------------------------- MPD announces state update: player Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::getState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand status Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3255 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3242 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3262 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3358 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3407 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3357 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3233 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3230 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: ------------------------------ 115ms Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand status took 113 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand playlistinfo took 110 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand playlistinfo took 109 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand playlistinfo took 109 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: ------------------------------ 109ms Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand status took 107 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: ------------------------------ 106ms Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand status took 105 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseTrackInfo Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseTrackInfo Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseTrackInfo Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseState Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::servicePushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CorePlayQueue::getTrack 0 Apr 13 14:47:17 rivoooo volumio[6965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 13 14:47:17 rivoooo volumio[6965]: verbose: CURRENT POSITION 0 Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState stateService play Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState currentStatus stop Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::servicePushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CorePlayQueue::getTrack 0 Apr 13 14:47:17 rivoooo volumio[6965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 13 14:47:17 rivoooo volumio[6965]: verbose: CURRENT POSITION 0 Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState stateService play Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState currentStatus play Apr 13 14:47:17 rivoooo volumio[6965]: info: Received an update from plugin. extracting info from payload Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output update for this device Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output update for this device Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::servicePushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CorePlayQueue::getTrack 0 Apr 13 14:47:17 rivoooo volumio[6965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 13 14:47:17 rivoooo volumio[6965]: verbose: CURRENT POSITION 0 Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState stateService play Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState currentStatus play Apr 13 14:47:17 rivoooo volumio[6965]: info: Received an update from plugin. extracting info from payload Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output update for this device Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output update for this device Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output Apr 13 14:47:17 rivoooo volumio[6965]: info: ------------------------------ 424ms Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.498+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.498+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.499+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.499+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.499+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.499+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.500+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.500+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.500+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.500+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.500+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.501+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.501+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.501+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.501+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.502+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio[6965]: info: ------------------------------ 439ms Apr 13 14:47:17 rivoooo volumio[6965]: info: ------------------------------ 439ms Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3545 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand playlistinfo took 156 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand playlistinfo took 153 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: sendMpdCommand playlistinfo took 153 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseTrackInfo Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseTrackInfo Apr 13 14:47:17 rivoooo volumio[6965]: verbose: ControllerMpd::parseTrackInfo Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::servicePushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CorePlayQueue::getTrack 0 Apr 13 14:47:17 rivoooo volumio[6965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3106,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 13 14:47:17 rivoooo volumio[6965]: verbose: CURRENT POSITION 0 Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState stateService play Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState currentStatus play Apr 13 14:47:17 rivoooo volumio[6965]: info: Received an update from plugin. extracting info from payload Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output update for this device Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output update for this device Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::servicePushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CorePlayQueue::getTrack 0 Apr 13 14:47:17 rivoooo volumio[6965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3106,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 13 14:47:17 rivoooo volumio[6965]: verbose: CURRENT POSITION 0 Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState stateService play Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState currentStatus play Apr 13 14:47:17 rivoooo volumio[6965]: info: Received an update from plugin. extracting info from payload Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output update for this device Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output update for this device Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output Apr 13 14:47:17 rivoooo volumio[6965]: info: ControllerMpd::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::servicePushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CorePlayQueue::getTrack 0 Apr 13 14:47:17 rivoooo volumio[6965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3106,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 13 14:47:17 rivoooo volumio[6965]: verbose: CURRENT POSITION 0 Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState stateService play Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::syncState currentStatus play Apr 13 14:47:17 rivoooo volumio[6965]: info: Received an update from plugin. extracting info from payload Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output update for this device Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreStateMachine::pushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioPushState Apr 13 14:47:17 rivoooo volumio[6965]: info: CoreCommandRouter::volumioGetState Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output update for this device Apr 13 14:47:17 rivoooo volumio[6965]: info: MRS: Pushing multiroomSync output Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.645+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.646+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.646+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.646+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.646+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.647+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.647+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.647+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.647+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.647+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.648+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.648+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.648+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.648+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.649+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.649+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.649+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.649+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.649+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.650+02:00 level=INFO msg="emitting player state changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" state=STATUS_PLAYING positionMs=2855 volume=100 Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.650+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.4:50614 @ 0x324a270" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio5-onboarding[3953]: time=2026-04-13T14:47:17.650+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="172.20.10.5:43396 @ 0x324a0c0" id=https://dancewave.online:443/dance.mp3 title="Tracklist: https://dancewave.online" Apr 13 14:47:17 rivoooo volumio[6965]: info: ------------------------------ 320ms Apr 13 14:47:17 rivoooo volumio[6965]: info: ------------------------------ 313ms Apr 13 14:47:17 rivoooo volumio[6965]: info: ------------------------------ 312ms Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3448 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3539 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3503 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3555 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3608 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3599 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3499 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3613 milliseconds Apr 13 14:47:17 rivoooo volumio[6965]: info: searchQOBUZUri took 3545 milliseconds Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:18 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:19 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:19 rivoooo volumio[6965]: info: Getting Calm Radio channels data Apr 13 14:47:21 rivoooo volumio[6965]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 14:47:21 rivoooo volumio[6965]: TypeError: Cannot read property 'slice' of null Apr 13 14:47:21 rivoooo volumio[6965]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Apr 13 14:47:21 rivoooo volumio[6965]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Apr 13 14:47:21 rivoooo volumio[6965]: at Object.onceWrapper (events.js:520:26) Apr 13 14:47:21 rivoooo volumio[6965]: at ClientRequest.emit (events.js:400:28) Apr 13 14:47:21 rivoooo volumio[6965]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Apr 13 14:47:21 rivoooo volumio[6965]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Apr 13 14:47:21 rivoooo volumio[6965]: at TLSSocket.socketOnData (_http_client.js:515:22) Apr 13 14:47:21 rivoooo volumio[6965]: at TLSSocket.emit (events.js:400:28) Apr 13 14:47:21 rivoooo volumio[6965]: at addChunk (internal/streams/readable.js:293:12) Apr 13 14:47:21 rivoooo volumio[6965]: at readableAddChunk (internal/streams/readable.js:267:9) Apr 13 14:47:21 rivoooo volumio[6965]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Apr 13 14:47:21 rivoooo volumio[6965]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Apr 13 14:47:21 rivoooo volumio[6965]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 14:47:21 rivoooo sudo[23456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-13 14:46 Apr 13 14:47:21 rivoooo sudo[23456]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 11:38:48 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="8e381701610c2a79deb52e712150c089"