-- Logs begin at Wed 2026-02-11 16:13:26 +08, end at Thu 2026-02-12 13:39:39 +08. -- Feb 12 13:38:54 rivoplus systemd-timedated[3357]: Changed local time to Thu Feb 12 13:38:54 2026 Feb 12 13:38:54 rivoplus sudo[3355]: pam_unix(sudo:session): session closed for user root Feb 12 13:38:54 rivoplus volumio-time-update[2822]: volumio-time-update-util: System time updated successfully. Feb 12 13:38:54 rivoplus systemd[1]: Started Volumio Time Update Utility. Feb 12 13:38:54 rivoplus systemd[1]: Starting Daily man-db regeneration... Feb 12 13:38:54 rivoplus systemd[1]: Starting Daily apt download activities... Feb 12 13:38:54 rivoplus systemd[1]: man-db.service: Succeeded. Feb 12 13:38:54 rivoplus systemd[1]: Started Daily man-db regeneration. Feb 12 13:38:54 rivoplus kernel: fb: osd[0] enable: 1 (Xorg) Feb 12 13:38:54 rivoplus ntpd[3288]: Soliciting pool server 162.159.200.1 Feb 12 13:38:54 rivoplus ntpd[3288]: Soliciting pool server 137.184.250.82 Feb 12 13:38:55 rivoplus volumio[3301]: info: ------------------------------------------- Feb 12 13:38:55 rivoplus volumio[3301]: info: ----- Volumio3 ---- Feb 12 13:38:55 rivoplus volumio[3301]: info: ------------------------------------------- Feb 12 13:38:55 rivoplus volumio[3301]: info: ----- System startup ---- Feb 12 13:38:55 rivoplus volumio[3301]: info: ------------------------------------------- Feb 12 13:38:55 rivoplus ntpd[3288]: Soliciting pool server 167.71.195.165 Feb 12 13:38:55 rivoplus ntpd[3288]: Soliciting pool server 172.104.182.184 Feb 12 13:38:55 rivoplus ntpd[3288]: Soliciting pool server 172.237.88.124 Feb 12 13:38:56 rivoplus systemd[1]: apt-daily.service: Succeeded. Feb 12 13:38:56 rivoplus systemd[1]: Started Daily apt download activities. Feb 12 13:38:56 rivoplus systemd[1]: Starting Daily apt upgrade and clean activities... Feb 12 13:38:56 rivoplus nmbd[3051]: [2026/02/12 13:38:56.399772, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 12 13:38:56 rivoplus nmbd[3051]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Feb 12 13:38:56 rivoplus systemd[1]: Started Samba NMB Daemon. Feb 12 13:38:56 rivoplus systemd[1]: Starting Samba Winbind Daemon... Feb 12 13:38:56 rivoplus volumio[3301]: info: MYVOLUMIO Environment detected Feb 12 13:38:56 rivoplus ntpd[3288]: Soliciting pool server 23.106.249.200 Feb 12 13:38:56 rivoplus ntpd[3288]: Soliciting pool server 94.237.79.110 Feb 12 13:38:56 rivoplus winbindd[3470]: [2026/02/12 13:38:56.819598, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Feb 12 13:38:56 rivoplus winbindd[3470]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 12 13:38:56 rivoplus winbindd[3470]: [2026/02/12 13:38:56.833069, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 12 13:38:56 rivoplus systemd[1]: Started Samba Winbind Daemon. Feb 12 13:38:56 rivoplus winbindd[3470]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 12 13:38:56 rivoplus systemd[1]: Starting Samba SMB Daemon... Feb 12 13:38:56 rivoplus volumio[3301]: info: Plugin folders cleanup Feb 12 13:38:56 rivoplus volumio[3301]: info: Scanning into folder /volumio/app/plugins/ Feb 12 13:38:56 rivoplus volumio[3301]: info: Scanning category audio_interface Feb 12 13:38:56 rivoplus volumio[3301]: info: Scanning category miscellanea Feb 12 13:38:56 rivoplus volumio[3301]: info: Scanning category music_service Feb 12 13:38:56 rivoplus volumio[3301]: info: Scanning category plugins.json Feb 12 13:38:56 rivoplus volumio[3301]: info: Scanning category system_controller Feb 12 13:38:56 rivoplus volumio[3301]: info: Scanning category user_interface Feb 12 13:38:56 rivoplus volumio[3301]: info: Scanning into folder /data/plugins/ Feb 12 13:38:56 rivoplus volumio[3301]: info: Scanning category audio_interface Feb 12 13:38:56 rivoplus volumio[3301]: info: Plugin folders cleanup completed Feb 12 13:38:56 rivoplus volumio[3301]: info: ------------------------------------------- Feb 12 13:38:56 rivoplus volumio[3301]: info: ----- Core plugins startup ---- Feb 12 13:38:56 rivoplus volumio[3301]: info: ------------------------------------------- Feb 12 13:38:56 rivoplus volumio[3301]: info: Loading plugins from folder /volumio/app/plugins/ Feb 12 13:38:56 rivoplus volumio[3301]: info: Adding plugin bluetooth to MyMusic Plugins Feb 12 13:38:56 rivoplus volumio[3301]: info: Adding plugin multiroom to MyMusic Plugins Feb 12 13:38:56 rivoplus volumio[3301]: info: Adding plugin upnp to MyMusic Plugins Feb 12 13:38:56 rivoplus volumio[3301]: info: Adding plugin metavolumio to MyMusic Plugins Feb 12 13:38:56 rivoplus volumio[3301]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 12 13:38:56 rivoplus volumio[3301]: info: Adding plugin cd_controller to MyMusic Plugins Feb 12 13:38:56 rivoplus volumio[3301]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 12 13:38:56 rivoplus volumio[3301]: info: Adding plugin raat to MyMusic Plugins Feb 12 13:38:56 rivoplus volumio[3301]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 12 13:38:56 rivoplus volumio[3301]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 12 13:38:56 rivoplus volumio[3301]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 12 13:38:56 rivoplus volumio[3301]: info: Loading plugins from folder /data/plugins/ Feb 12 13:38:56 rivoplus volumio[3301]: info: Loading plugin "system"... Feb 12 13:38:57 rivoplus volumio[3301]: info: Loading plugin "appearance"... Feb 12 13:38:57 rivoplus smbd[3493]: [2026/02/12 13:38:57.430921, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 12 13:38:57 rivoplus systemd[1]: Started Samba SMB Daemon. Feb 12 13:38:57 rivoplus smbd[3493]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 12 13:38:57 rivoplus systemd[1]: Reached target Multi-User System. Feb 12 13:38:57 rivoplus systemd[1]: Reached target Graphical Interface. Feb 12 13:38:57 rivoplus systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 12 13:38:57 rivoplus systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 12 13:38:57 rivoplus systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 12 13:38:57 rivoplus volumio-remote-updater[2833]: [2026-02-12 13:38:57] [connect] Successful connection Feb 12 13:38:57 rivoplus ntpd[3288]: Soliciting pool server 64.235.61.113 Feb 12 13:38:57 rivoplus ntpd[3288]: Soliciting pool server 15.235.181.37 Feb 12 13:38:58 rivoplus systemd[1]: apt-daily-upgrade.service: Succeeded. Feb 12 13:38:58 rivoplus systemd[1]: Started Daily apt upgrade and clean activities. Feb 12 13:38:58 rivoplus systemd[1]: Startup finished in 12.963s (kernel) + 29.293s (userspace) = 42.256s. Feb 12 13:38:58 rivoplus ntpd[3288]: Soliciting pool server 84.33.16.6 Feb 12 13:38:58 rivoplus ntpd[3288]: Soliciting pool server 2406:2000:e4:a1f::1000 Feb 12 13:38:58 rivoplus volumio[3301]: info: Loading plugin "network"... Feb 12 13:38:58 rivoplus volumio[3301]: info: Refreshing Cached IP Addresses Feb 12 13:38:58 rivoplus sudo[3540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 12 13:38:58 rivoplus sudo[3540]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:38:58 rivoplus sudo[3542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 12 13:38:58 rivoplus sudo[3542]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:38:58 rivoplus sudo[3540]: pam_unix(sudo:session): session closed for user root Feb 12 13:38:58 rivoplus volumio[3301]: info: Loading plugin "services"... Feb 12 13:38:58 rivoplus volumio[3301]: info: Loading plugin "volumio5onboarding"... Feb 12 13:38:58 rivoplus sudo[3542]: pam_unix(sudo:session): session closed for user root Feb 12 13:38:58 rivoplus sudo[3552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 12 13:38:58 rivoplus volumio[3301]: info: Loading plugin "alsa_controller"... Feb 12 13:38:58 rivoplus sudo[3552]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:38:58 rivoplus kernel: wl_escan_set_scan: ioctl_ver=2 Feb 12 13:38:58 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:58 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:58 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:58 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:59 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:59 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 12 13:38:59 rivoplus volumio[3301]: info: Loading plugin "wizard"... Feb 12 13:38:59 rivoplus volumio[3301]: info: Loading plugin "networkfs"... Feb 12 13:38:59 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:59 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:59 rivoplus volumio[3301]: info: Starting Udev Watcher for removable devices Feb 12 13:38:59 rivoplus sudo[3573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=Sla8038S!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //vinshineaudio/music /mnt/NAS/NAS Feb 12 13:38:59 rivoplus sudo[3573]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:38:59 rivoplus volumio[3301]: info: Ignoring mount for partition: BOOT Feb 12 13:38:59 rivoplus volumio[3301]: info: Ignoring mount for partition: volumio Feb 12 13:38:59 rivoplus volumio[3301]: info: Ignoring mount for partition: volumio_data Feb 12 13:38:59 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 12 13:38:59 rivoplus volumio[3301]: info: Loading plugin "volumio_command_line_client"... Feb 12 13:38:59 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:59 rivoplus volumio[3301]: info: Loading plugin "upnp"... Feb 12 13:38:59 rivoplus volumio[3301]: info: [1770874739333] Starting Upmpd Daemon Feb 12 13:38:59 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 12 13:38:59 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:59 rivoplus volumio[3301]: info: Loading plugin "my_music"... Feb 12 13:38:59 rivoplus volumio[3301]: info: Loading plugin "mpd"... Feb 12 13:38:59 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:59 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:59 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:59 rivoplus sudo[3573]: pam_unix(sudo:session): session closed for user root Feb 12 13:38:59 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:59 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:38:59 rivoplus volumio[3301]: info: Loading plugin "upnp_browser"... Feb 12 13:38:59 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:00 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:00 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:00 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:00 rivoplus volumio[3301]: info: Starting UPNP Browser Feb 12 13:39:00 rivoplus volumio[3301]: info: Loading plugin "bluetooth"... Feb 12 13:39:00 rivoplus volumio[3301]: info: [1770874740693] Starting BluetoothController Feb 12 13:39:00 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:00 rivoplus volumio[3301]: info: Loading plugin "alarm-clock"... Feb 12 13:39:00 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:01 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:01 rivoplus volumio[3301]: info: Loading plugin "manifestui"... Feb 12 13:39:01 rivoplus volumio[3301]: info: Loading plugin "metavolumio"... Feb 12 13:39:02 rivoplus ntpd[3288]: receive: Unexpected origin timestamp 0xed37e5f5.b4d713a3 does not match aorg 0000000000.00000000 from server@142.91.99.46 xmt 0xed37e5f6.59e58d04 Feb 12 13:39:02 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:02 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:03 rivoplus systemd[1]: systemd-fsckd.service: Succeeded. Feb 12 13:39:03 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:03 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:03 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 8 Feb 12 13:39:03 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04cb43000 drv_status 0x0 e_type 69 e_states 0 Feb 12 13:39:04 rivoplus sudo[3552]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:04 rivoplus volumio[3301]: info: Loading plugin "airplay_emulation"... Feb 12 13:39:04 rivoplus volumio[3301]: info: Starting Shairport Sync Feb 12 13:39:04 rivoplus volumio[3301]: info: Loading plugin "cd_controller"... Feb 12 13:39:04 rivoplus volumio[3301]: info: Loading plugin "last_100"... Feb 12 13:39:04 rivoplus volumio[3301]: info: Loading plugin "qobuzconnect"... Feb 12 13:39:04 rivoplus volumio[3301]: info: Loading plugin "raat"... Feb 12 13:39:05 rivoplus sh[2755]: timed out Feb 12 13:39:05 rivoplus sh[2755]: dhcpcd exited Feb 12 13:39:05 rivoplus dhcpcd[2807]: timed out Feb 12 13:39:05 rivoplus systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Feb 12 13:39:05 rivoplus sh[2755]: ifup: failed to bring up eth0 Feb 12 13:39:05 rivoplus dhcpcd[2807]: dhcpcd exited Feb 12 13:39:05 rivoplus systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Feb 12 13:39:05 rivoplus volumio[3301]: info: RAAT Plugin loaded Feb 12 13:39:05 rivoplus volumio[3301]: info: Adding restartRAATSocket REST API Endpoint Feb 12 13:39:05 rivoplus volumio[3301]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Feb 12 13:39:05 rivoplus volumio[3301]: info: Loading plugin "streaming_services"... Feb 12 13:39:07 rivoplus volumio[3301]: info: Starting Streaming Service Transparent Proxy Feb 12 13:39:07 rivoplus volumio[3301]: info: Loading plugin "tidalconnect"... Feb 12 13:39:07 rivoplus volumio[3301]: info: Loading plugin "webradio"... Feb 12 13:39:08 rivoplus volumio[3301]: info: Loading plugin "i2s_dacs"... Feb 12 13:39:08 rivoplus volumio[3301]: info: I2S DAC not set, start Auto-detection Feb 12 13:39:08 rivoplus volumio[3301]: info: Loading plugin "volumiodiscovery"... Feb 12 13:39:08 rivoplus volumio[3301]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 12 13:39:08 rivoplus node[3301]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 12 13:39:08 rivoplus volumio[3301]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 12 13:39:08 rivoplus node[3301]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 12 13:39:08 rivoplus volumio[3301]: *** WARNING *** For more information see Feb 12 13:39:08 rivoplus node[3301]: *** WARNING *** For more information see Feb 12 13:39:08 rivoplus volumio[3301]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 12 13:39:08 rivoplus node[3301]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 12 13:39:08 rivoplus volumio[3301]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 12 13:39:08 rivoplus node[3301]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 12 13:39:08 rivoplus volumio[3301]: *** WARNING *** For more information see Feb 12 13:39:08 rivoplus node[3301]: *** WARNING *** For more information see Feb 12 13:39:08 rivoplus volumio[3301]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 12 13:39:08 rivoplus volumio[3301]: info: Discovery: Started advertising with name: Rivoplus Feb 12 13:39:08 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 12 13:39:08 rivoplus volumio[3301]: info: Loading plugin "multiroom"... Feb 12 13:39:09 rivoplus volumio[3301]: STREAMING PROXY: Starting server on port 3245 Feb 12 13:39:09 rivoplus volumio[3301]: Node JS runtime: 14 Feb 12 13:39:11 rivoplus volumio[3301]: info: Applying required configuration parameters for plugin multiroom Feb 12 13:39:11 rivoplus sudo[3766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Feb 12 13:39:11 rivoplus sudo[3766]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:11 rivoplus sudo[3766]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:11 rivoplus volumio[3301]: info: MRS: MultiRoom plugin initialized Feb 12 13:39:11 rivoplus volumio[3301]: info: MRS: STOPPING SNAPCLIENT Feb 12 13:39:11 rivoplus volumio[3301]: info: MRS: Snap server stop Feb 12 13:39:11 rivoplus sudo[3782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Feb 12 13:39:11 rivoplus sudo[3782]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:11 rivoplus volumio[3301]: info: MRS: STOPPING volumioStreaming Feb 12 13:39:11 rivoplus sudo[3784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Feb 12 13:39:11 rivoplus sudo[3784]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:11 rivoplus volumio[3301]: info: Loading plugin "outputs"... Feb 12 13:39:11 rivoplus sudo[3782]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:11 rivoplus sudo[3789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Feb 12 13:39:11 rivoplus sudo[3789]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:11 rivoplus volumio[3301]: info: Loading plugin "albumart"... Feb 12 13:39:11 rivoplus sudo[3790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Feb 12 13:39:11 rivoplus sudo[3790]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:11 rivoplus sudo[3790]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:11 rivoplus volumio[3301]: info: Plugin example_plugin is not enabled Feb 12 13:39:11 rivoplus volumio[3301]: info: Loading plugin "hi_res_audio"... Feb 12 13:39:11 rivoplus sudo[3789]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:11 rivoplus sudo[3784]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:11 rivoplus volumio[3301]: Forking 3 albumart workers Feb 12 13:39:13 rivoplus volumio[3301]: Starting albumart workers Feb 12 13:39:13 rivoplus volumio-remote-updater[2833]: [2026-02-12 13:39:13] [connect] Successful connection Feb 12 13:39:13 rivoplus volumio[3301]: Starting albumart workers Feb 12 13:39:13 rivoplus volumio[3301]: Starting albumart workers Feb 12 13:39:13 rivoplus volumio[3301]: info: Applying required configuration parameters for plugin hi_res_audio Feb 12 13:39:13 rivoplus volumio[3301]: info: Loading plugin "inputs"... Feb 12 13:39:14 rivoplus volumio[3301]: info: Loading plugin "qobuz"... Feb 12 13:39:16 rivoplus volumio[3301]: info: Loading plugin "smart_inputs"... Feb 12 13:39:16 rivoplus volumio[3301]: info: Loading plugin "tidal"... Feb 12 13:39:18 rivoplus volumio[3301]: info: Loading plugin "rivopluscontrol"... Feb 12 13:39:18 rivoplus volumio[3301]: info: Adding this device properties Feb 12 13:39:18 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Feb 12 13:39:18 rivoplus volumio[3301]: info: Setting Additional Device Volumio Properties: [object Object] Feb 12 13:39:18 rivoplus volumio[3301]: info: Loading plugin "updater_comm"... Feb 12 13:39:19 rivoplus kernel: fb: mem_free_work, free memory: addr:800000 Feb 12 13:39:19 rivoplus volumio[3301]: info: Loading plugin "cec_controller"... Feb 12 13:39:19 rivoplus volumio[3301]: info: Applying required configuration parameters for plugin cec_controller Feb 12 13:39:19 rivoplus volumio[3301]: info: Plugin mpdemulation is not enabled Feb 12 13:39:19 rivoplus volumio[3301]: info: Loading plugin "rest_api"... Feb 12 13:39:19 rivoplus volumio[3301]: info: Loading plugin "websocket"... Feb 12 13:39:19 rivoplus volumio[3301]: info: Starting Socket.io Server version 2.3.0 Feb 12 13:39:19 rivoplus volumio[3301]: info: Loading plugin "fusiondsp"... Feb 12 13:39:20 rivoplus volumio[3301]: info: Applying required configuration parameters for plugin fusiondsp Feb 12 13:39:20 rivoplus volumio[3301]: info: Loading i18n strings for locale en Feb 12 13:39:20 rivoplus volumio[3301]: Updating browse sources language Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::initPlayerControls Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 13:39:20 rivoplus volumio[3301]: Express server listening on port 3000 Feb 12 13:39:20 rivoplus volumio[3301]: [Metrics] WebUI: 25s 915.92ms Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreStateMachine::resetVolumioState Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreStateMachine::getcurrentVolume Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::volumioRetrievevolume Feb 12 13:39:20 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:20 rivoplus sudo[3868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 12 13:39:20 rivoplus sudo[3868]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:20 rivoplus sudo[3868]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:20 rivoplus volumio[3301]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 12 13:39:20 rivoplus sudo[3871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 12 13:39:20 rivoplus volumio[3301]: info: Completed loading Core Plugins Feb 12 13:39:20 rivoplus sudo[3871]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:20 rivoplus volumio[3301]: info: Preparing to generate the ALSA configuration file Feb 12 13:39:20 rivoplus sudo[3871]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:20 rivoplus volumio[3301]: info: Volumio Network Manager: Network status updated: 2 Feb 12 13:39:20 rivoplus volumio[3301]: info: MRS: Removed streaming files Feb 12 13:39:20 rivoplus volumio[3301]: info: MRS: volumioStreaming STOPPED Feb 12 13:39:20 rivoplus volumio[3301]: info: MRS: SNAPSERVER STOPPED Feb 12 13:39:20 rivoplus volumio[3301]: info: MRS: SNAPCLIENT STOPPED Feb 12 13:39:20 rivoplus volumio[3301]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Feb 12 13:39:20 rivoplus volumio[3301]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 12 13:39:20 rivoplus volumio[3301]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 12 13:39:20 rivoplus volumio[3301]: info: Reading ALSA contributions from plugins. Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Feb 12 13:39:21 rivoplus volumio[3301]: info: VolumeController:: Volume=100 Mute =false Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:21 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreStateMachine::updateTrackBlock Feb 12 13:39:21 rivoplus volumio[3301]: info: CorePlayQueue::getTrackBlock Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreCommandRouter::volumioRetrievevolume Feb 12 13:39:21 rivoplus volumio[3301]: info: Reloading queue from file Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Feb 12 13:39:21 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreStateMachine::setRepeat null single undefined Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:21 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreStateMachine::setRandom null Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:21 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:21 rivoplus volumio[3301]: info: Discovery: adding 7d40c390-fda6-4f1c-a5a3-792865b4cf51 Feb 12 13:39:21 rivoplus volumio[3301]: info: Discovery: Found device Rivoplus Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:21 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:21 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output for this device Feb 12 13:39:21 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output Feb 12 13:39:21 rivoplus volumio[3301]: info: Adding audio output: Feb 12 13:39:21 rivoplus volumio[3301]: info: Adding audio output: Feb 12 13:39:21 rivoplus sudo[3885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 12 13:39:21 rivoplus sudo[3885]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:21 rivoplus volumio[3301]: info: VolumeController:: Volume=100 Mute =false Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:21 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:21 rivoplus volumio[3301]: info: Asound.conf file unchanged, so no further update is needed Feb 12 13:39:21 rivoplus volumio[3301]: info: Output device has changed, restarting MPD Feb 12 13:39:21 rivoplus systemd[1]: Started UPnP Renderer front-end to MPD. Feb 12 13:39:21 rivoplus sudo[3885]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:21 rivoplus sudo[3889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 13:39:21 rivoplus sudo[3889]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:21 rivoplus sudo[3889]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:21 rivoplus volumio[3301]: info: Output device has changed, restarting Shairport Sync Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:21 rivoplus sudo[3898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 13:39:21 rivoplus sudo[3898]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:21 rivoplus systemd[1]: Listening on mpd.socket. Feb 12 13:39:21 rivoplus systemd[1]: Starting Music Player Daemon... Feb 12 13:39:21 rivoplus volumio[3301]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 13:39:21 rivoplus volumio[3301]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 12 13:39:21 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:21 rivoplus volumio[3301]: info: ___________ START PLUGINS ___________ Feb 12 13:39:21 rivoplus volumio[3301]: info: ControllerMpd::onStart: Initializing MPD Feb 12 13:39:21 rivoplus volumio[3301]: info: Creating MPD Configuration file Feb 12 13:39:21 rivoplus sudo[3907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Feb 12 13:39:21 rivoplus sudo[3907]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:22 rivoplus systemd[1]: Started Volumio5 Onboarding Server. Feb 12 13:39:22 rivoplus sudo[3907]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 12 13:39:22 rivoplus volumio[3301]: info: [1770874762045] CoreMusicLibrary::Adding element Media Servers Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 13:39:22 rivoplus sudo[3903]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 12 13:39:22 rivoplus sudo[3903]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:22 rivoplus sudo[3911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 13:39:22 rivoplus sudo[3911]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:22 rivoplus sudo[3903]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 12 13:39:22 rivoplus sudo[3903]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:22 rivoplus volumio[3301]: info: UPNP Browser: Client initialized successfully Feb 12 13:39:22 rivoplus sudo[3911]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 12 13:39:22 rivoplus sudo[3914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 13:39:22 rivoplus sudo[3914]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:22 rivoplus volumio[3301]: info: Adding METAVOLUMIO REST API Endpoints Feb 12 13:39:22 rivoplus volumio[3301]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Feb 12 13:39:22 rivoplus volumio[3301]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Feb 12 13:39:22 rivoplus volumio[3301]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Feb 12 13:39:22 rivoplus volumio[3301]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:22 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 12 13:39:22 rivoplus systemd[1]: mpd.service: Succeeded. Feb 12 13:39:22 rivoplus systemd[1]: Stopped Music Player Daemon. Feb 12 13:39:22 rivoplus sudo[3921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Rivoplus Feb 12 13:39:22 rivoplus sudo[3921]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:22 rivoplus systemd[1]: Starting Music Player Daemon... Feb 12 13:39:22 rivoplus sudo[3921]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:22 rivoplus volumio[3301]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:22 rivoplus volumio[3301]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 13:39:22 rivoplus sudo[3923]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 12 13:39:22 rivoplus sudo[3923]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:22 rivoplus volumio[3301]: info: Preparing CD Folders Feb 12 13:39:22 rivoplus volumio[3301]: info: Adding CD REST API Endpoints Feb 12 13:39:22 rivoplus volumio[3301]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Feb 12 13:39:22 rivoplus volumio[3301]: info: Starting UDEV Watcher for CD Feb 12 13:39:22 rivoplus volumio[3301]: info: Detecting CD presence with UDEV Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Feb 12 13:39:22 rivoplus sudo[3923]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 12 13:39:22 rivoplus sudo[3923]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 12 13:39:22 rivoplus volumio[3301]: info: [1770874762456] CoreMusicLibrary::Adding element Last_100 Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 13:39:22 rivoplus volumio[3301]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Feb 12 13:39:22 rivoplus volumio[3301]: info: QobuzConnect: Starting Qobuz Connect socket and service Feb 12 13:39:22 rivoplus volumio[3301]: info: Starting RAAT Plugin Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Feb 12 13:39:22 rivoplus volumio[3301]: info: Additional UI Settings Added for plugin music_service/raat Feb 12 13:39:22 rivoplus volumio[3301]: info: Registering DSP Elements listener and retrieving current ones Feb 12 13:39:22 rivoplus volumio[3301]: info: Additional DSP elements updated Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:22 rivoplus sudo[3942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 13:39:22 rivoplus sudo[3942]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:22 rivoplus volumio[3301]: info: Updating RAAT Signal Path Feb 12 13:39:22 rivoplus volumio5-onboarding[3913]: time=2026-02-12T13:39:22.631+08:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 12 13:39:22 rivoplus volumio[3301]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Feb 12 13:39:22 rivoplus volumio[3301]: info: Streaming services startup Feb 12 13:39:22 rivoplus volumio[3301]: info: Starting Streaming Daemon Feb 12 13:39:22 rivoplus sudo[3942]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:22 rivoplus sudo[3950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 13:39:22 rivoplus sudo[3950]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:22 rivoplus sudo[3951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 12 13:39:22 rivoplus sudo[3951]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:22 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Feb 12 13:39:22 rivoplus sudo[3950]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:22 rivoplus sudo[3951]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 12 13:39:22 rivoplus volumio[3301]: info: [1770874762851] CoreMusicLibrary::Adding element Webradio Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 13:39:22 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 12 13:39:22 rivoplus volumio[3301]: info: Initializing BBC Radios Feb 12 13:39:22 rivoplus sudo[3963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 13:39:22 rivoplus sudo[3963]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:22 rivoplus sudo[3963]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:23 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 12 13:39:23 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:23 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Feb 12 13:39:23 rivoplus volumio[3301]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 12 13:39:23 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:23 rivoplus volumio[3301]: error: Hi Res Audio Failed Login: Missing Login Data Feb 12 13:39:23 rivoplus volumio[3301]: info: Adding HIGHRESAUDIO REST API Endpoints Feb 12 13:39:23 rivoplus volumio[3301]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Feb 12 13:39:23 rivoplus volumio[3301]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Feb 12 13:39:23 rivoplus volumio[3301]: info: Initializing Serial Communication on port /dev/ttyS3 Feb 12 13:39:23 rivoplus volumio[3301]: info: Touch Event Listener Process Starting Feb 12 13:39:23 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Feb 12 13:39:23 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Feb 12 13:39:23 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Feb 12 13:39:23 rivoplus volumio[3301]: info: Adding inputs REST Endpoints Feb 12 13:39:23 rivoplus volumio[3301]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Feb 12 13:39:23 rivoplus volumio[3301]: info: Scanning Audio Inputs Feb 12 13:39:23 rivoplus sudo[3981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Feb 12 13:39:23 rivoplus sudo[3981]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:23 rivoplus volumio[3301]: info: Checking against Known Cards name Feb 12 13:39:23 rivoplus volumio[3301]: info: Checking against Known Cards name Feb 12 13:39:23 rivoplus volumio[3301]: info: Checking against Known Cards name Feb 12 13:39:23 rivoplus volumio[3301]: info: Checking against Known Cards name Feb 12 13:39:23 rivoplus volumio[3301]: info: Checking against Known Cards name Feb 12 13:39:23 rivoplus volumio[3301]: info: Adding Server instance for streaming Feb 12 13:39:23 rivoplus sudo[3991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Feb 12 13:39:23 rivoplus sudo[3991]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:23 rivoplus sudo[3991]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:23 rivoplus sudo[3994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Feb 12 13:39:23 rivoplus sudo[3994]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:23 rivoplus sudo[3994]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:23 rivoplus sudo[3997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Feb 12 13:39:23 rivoplus sudo[3997]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:23 rivoplus sudo[3997]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:23 rivoplus sudo[4000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Feb 12 13:39:23 rivoplus sudo[4000]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:23 rivoplus sudo[4000]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:23 rivoplus volumio[3301]: info: Apply VIM3L Onboard LEDs Settings Feb 12 13:39:23 rivoplus volumio[3301]: info: Turning On Onboard LEDs Feb 12 13:39:23 rivoplus sudo[4004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Feb 12 13:39:23 rivoplus sudo[4004]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:23 rivoplus volumio[3301]: info: Starting CEC Event listener Feb 12 13:39:23 rivoplus sudo[4004]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:23 rivoplus volumio[3301]: info: Loading i18n strings for locale en Feb 12 13:39:23 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 12 13:39:23 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:23 rivoplus volumio[3301]: info: FusionDsp - mixtype--------------------- Hardware Feb 12 13:39:23 rivoplus sudo[4008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Feb 12 13:39:23 rivoplus volumio[3301]: info: Volumio Calling Home Feb 12 13:39:23 rivoplus sudo[4008]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:23 rivoplus sudo[4008]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:24 rivoplus volumio[3301]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Feb 12 13:39:24 rivoplus volumio[3301]: (node:3301) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Feb 12 13:39:24 rivoplus volumio[3301]: (Use `node --trace-deprecation ...` to show where the warning was created) Feb 12 13:39:24 rivoplus volumio[3301]: info: Preparing to generate the ALSA configuration file Feb 12 13:39:24 rivoplus volumio[3301]: info: Stopping AccessToken refresher cron for QOBUZ Feb 12 13:39:24 rivoplus volumio[3301]: info: AccessToken refresher cron started for QOBUZ Feb 12 13:39:24 rivoplus volumio[3301]: info: Adding TIDAL REST API Endpoints Feb 12 13:39:24 rivoplus volumio[3301]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Feb 12 13:39:24 rivoplus volumio[3301]: info: Adding QOBUZ REST API Endpoints Feb 12 13:39:24 rivoplus volumio[3301]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Feb 12 13:39:24 rivoplus volumio[3301]: info: Serial port opened successfully Feb 12 13:39:24 rivoplus volumio[3301]: info: Sending serial start messages Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:24 rivoplus volumio[3301]: info: Reporting MCU Network Status: 2 Feb 12 13:39:24 rivoplus volumio[3301]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 12 13:39:24 rivoplus volumio[3301]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 12 13:39:24 rivoplus volumio[3301]: info: Reading ALSA contributions from plugins. Feb 12 13:39:24 rivoplus volumio[3301]: error: Cannot start Volumio Streaming Daemon Feb 12 13:39:24 rivoplus volumio[3301]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 12 13:39:24 rivoplus volumio[3301]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 12 13:39:24 rivoplus volumio[3301]: info: RAAT Albumart path created successfully Feb 12 13:39:24 rivoplus volumio[3301]: info: Bluetooth name changed to Rivoplus Feb 12 13:39:24 rivoplus volumio[3301]: info: MPD Permissions set Feb 12 13:39:24 rivoplus volumio[3301]: info: MPD Permissions set Feb 12 13:39:24 rivoplus volumio[3301]: info: Upmpdcli Daemon Started Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Feb 12 13:39:24 rivoplus volumio[3301]: info: Setting Device Volume Override Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 12 13:39:24 rivoplus volumio[3301]: info: Updating Volume Controller Parameters: Device: 5 Name: S/PDIF + AES/EBU + I2S Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 12 13:39:24 rivoplus volumio[3301]: info: Disabling external Volume Control Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:24 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:24 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:24 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output update for this device Feb 12 13:39:24 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output Feb 12 13:39:24 rivoplus volumio[3301]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 17 Feb 12 13:39:24 rivoplus systemd[1]: systemd-timedated.service: Succeeded. Feb 12 13:39:24 rivoplus volumio[3301]: info: Executing endpoint qc_getconfig Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 12 13:39:24 rivoplus qobuz-connect[3957]: 20260212 13:39:24.826 [3957.3957] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Feb 12 13:39:24 rivoplus volumio[3301]: info: Setting Additional System Software info: Hardware Revision: 1.0 Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Feb 12 13:39:24 rivoplus volumio[3301]: info: Setting HW Firmware info: undefined Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Feb 12 13:39:24 rivoplus volumio[3301]: info: Setting HW Version info: 1.0 Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Feb 12 13:39:24 rivoplus volumio[3301]: info: Setting Additional System Software info: Hardware Revision: 1.0, Firmware Version: 0.3.0 Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Feb 12 13:39:24 rivoplus volumio[3301]: info: Setting HW Firmware info: 0.3.0 Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Feb 12 13:39:24 rivoplus volumio[3301]: info: Setting HW Version info: 1.0 Feb 12 13:39:24 rivoplus volumio[3301]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 12 13:39:24 rivoplus volumio[3301]: info: MCU Signalled Headphone Mode Disabled Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 12 13:39:24 rivoplus volumio[3301]: info: Reporting Headphone State: false Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:24 rivoplus volumio[3301]: info: Updating RAAT Signal Path Feb 12 13:39:24 rivoplus volumio[3301]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Feb 12 13:39:24 rivoplus volumio[3301]: info: MCU Signalled Sleep Mode Disabled Feb 12 13:39:24 rivoplus volumio[3301]: info: Enabling Advanced system settings configuration Feb 12 13:39:24 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Feb 12 13:39:24 rivoplus volumio[3301]: info: Additional UI Settings Added for plugin music_service/inputs Feb 12 13:39:24 rivoplus volumio[3301]: info: MCU Signalled Auto Boot Mode On Power Disabled Feb 12 13:39:24 rivoplus sudo[4036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Feb 12 13:39:24 rivoplus sudo[4036]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:25 rivoplus kernel: fb: osd[0] enable: 1 (Xorg) Feb 12 13:39:25 rivoplus sudo[4036]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:25 rivoplus qobuz-connect[3957]: 20260212 13:39:25.016 [3957.3957] INFO VolumeManager: [0xabf89360]: Setting new playback volume: 75 Feb 12 13:39:25 rivoplus qobuz-connect[3957]: 20260212 13:39:25.016 [3957.3957] INFO VolumeManager: [0xabf89360]: Setting new mute state: 0 Feb 12 13:39:25 rivoplus qobuz-connect[3957]: 20260212 13:39:25.016 [3957.3957] INFO QobuzConnect: [0xabf89d30]: Client initialized! Feb 12 13:39:25 rivoplus qobuz-connect[3957]: 20260212 13:39:25.016 [3957.3957] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Feb 12 13:39:25 rivoplus volumio[3301]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 17 Feb 12 13:39:25 rivoplus volumio[3301]: info: Received Get System Info Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 12 13:39:25 rivoplus qobuz-connect[3957]: 20260212 13:39:25.075 [3957.3957] INFO LocalConfigManager: [0xabf88c40]: Starting Local Configuration server Feb 12 13:39:25 rivoplus qobuz-connect[3957]: 20260212 13:39:25.075 [3957.3957] INFO SampleApp: Starting Local configuration server Feb 12 13:39:25 rivoplus qobuz-connect[3957]: 20260212 13:39:25.075 [3957.3957] INFO SampleApp: Playback volume changed: 75 Feb 12 13:39:25 rivoplus qobuz-connect[3957]: 20260212 13:39:25.076 [3957.3957] INFO SampleApp: Connected to UNIX socket client 0xabf7eed8 Feb 12 13:39:25 rivoplus volumio[3301]: info: Discovery: Getting this device information Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:25 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 12 13:39:25 rivoplus volumio5-onboarding[3913]: time=2026-02-12T13:39:25.086+08:00 level=INFO msg="system info for 4ce7a2325c4b09568e080862cf14e9e7" deviceName=Rivoplus deviceVariant=rivoplus deviceModel="Volumio Rivo+" softwareVersion=3.908 Feb 12 13:39:25 rivoplus volumio[3301]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18 Feb 12 13:39:25 rivoplus volumio[3301]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 12 13:39:25 rivoplus volumio[3301]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 12 13:39:25 rivoplus volumio[3301]: info: Volumio called home Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus sudo[4044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Feb 12 13:39:25 rivoplus sudo[4044]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 12 13:39:25 rivoplus systemd[1]: Started Volumio Bluetooth Module. Feb 12 13:39:25 rivoplus sudo[4044]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus sudo[4052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Feb 12 13:39:25 rivoplus sudo[4052]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:25 rivoplus volumiobt[4050]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus sudo[4052]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:25 rivoplus volumio[3301]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Feb 12 13:39:25 rivoplus volumio[3301]: info: MP1 GPIO: Signalled system ready via GPIO Feb 12 13:39:25 rivoplus volumio[3301]: info: Received Get System Info Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 12 13:39:25 rivoplus volumio[3301]: info: Discovery: Getting this device information Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:25 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 12 13:39:25 rivoplus volumio[3301]: verbose: New Socket.io Connection to 192.168.118.177 from 192.168.118.49 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Feb 12 13:39:25 rivoplus volumio[3301]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 20 Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:25 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:25 rivoplus volumio[3301]: info: VolumeController:: Volume=100 Mute =false Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:25 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:25 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:25 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output update for this device Feb 12 13:39:25 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output Feb 12 13:39:25 rivoplus sudo[4063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Feb 12 13:39:25 rivoplus sudo[4063]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:25 rivoplus sudo[4063]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 12 13:39:25 rivoplus volumio5-onboarding[3913]: time=2026-02-12T13:39:25.659+08:00 level=INFO msg="enabling local network discovery" Feb 12 13:39:25 rivoplus volumio5-onboarding[3913]: time=2026-02-12T13:39:25.664+08:00 level=INFO msg="bootstrapping state" hasInternet=true Feb 12 13:39:25 rivoplus volumio[3301]: info: Volumio BT Module successfully started Feb 12 13:39:25 rivoplus volumio[3301]: info: Received Get System Info Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 12 13:39:25 rivoplus volumio[3301]: info: Discovery: Getting this device information Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:25 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:25 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:25 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetQueue Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreStateMachine::getQueue Feb 12 13:39:25 rivoplus volumio[3301]: info: CorePlayQueue::getQueue Feb 12 13:39:25 rivoplus volumio[3301]: info: Listing playlists Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 12 13:39:25 rivoplus volumio[3301]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 12 13:39:25 rivoplus volumio[3301]: info: Received Get System Info Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 12 13:39:25 rivoplus volumio[3301]: info: Discovery: Getting this device information Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:25 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 12 13:39:25 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:25 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:26 rivoplus volumio[3301]: info: camilladsp spawned new process with pid 4073, instance 1, run: true Feb 12 13:39:26 rivoplus volumio[3301]: info: camilladsp service started and running in background, instance 1 Feb 12 13:39:26 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:26 rivoplus mpd[3937]: Feb 12 13:39 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 12 13:39:26 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:26 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:26 rivoplus volumio[3301]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 384000 768000 <-AAAAAAAAAAAAA Feb 12 13:39:26 rivoplus volumio[3301]: info: FusionDsp loaded Feb 12 13:39:26 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 12 13:39:26 rivoplus sudo[4083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 12 13:39:26 rivoplus sudo[4083]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:26 rivoplus volumio[3301]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 12 13:39:26 rivoplus volumio[3301]: info: Adding Signal Path Element [object Object] Feb 12 13:39:26 rivoplus volumio[3301]: info: Adding fusiondspeq DSP Signal Path Element Feb 12 13:39:26 rivoplus volumio[3301]: info: Additional DSP elements updated Feb 12 13:39:26 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:26 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:26 rivoplus volumio[3301]: info: Updating RAAT Signal Path Feb 12 13:39:26 rivoplus volumio[3301]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Feb 12 13:39:26 rivoplus volumio[3301]: info: FusionDsp - ---- installed callbackRead Feb 12 13:39:26 rivoplus volumio[3301]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 12 13:39:26 rivoplus volumio[3301]: info: Starting Shairport Sync Feb 12 13:39:26 rivoplus systemd[1]: Started FusionDsp Daemon. Feb 12 13:39:26 rivoplus sudo[4083]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:26 rivoplus volumio[3301]: info: Starting Shairport Sync Feb 12 13:39:26 rivoplus sudo[4088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 13:39:26 rivoplus sudo[4088]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:26 rivoplus volumio[3301]: info: Starting Shairport Sync Feb 12 13:39:26 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 12 13:39:26 rivoplus systemd[1]: shairport-sync.service: Succeeded. Feb 12 13:39:26 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:26 rivoplus sudo[4089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Feb 12 13:39:26 rivoplus sudo[4089]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:26 rivoplus sudo[4092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 13:39:26 rivoplus volumio[3301]: info: Adding Inputs via Serial API Feb 12 13:39:26 rivoplus volumio[3301]: info: Adding Advanced Audio Settings via Serial API Feb 12 13:39:26 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Feb 12 13:39:26 rivoplus volumio[3301]: info: Additional UI Settings Added for plugin music_service/inputs Feb 12 13:39:26 rivoplus sudo[4092]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:26 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:26 rivoplus sudo[4088]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:26 rivoplus volumiobt[4050]: pulseaudio: no process found Feb 12 13:39:26 rivoplus sudo[4089]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:26 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:26 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:26 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 13:39:26 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 12 13:39:26 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:26 rivoplus systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 12 13:39:26 rivoplus systemd[1]: shairport-sync.service: Succeeded. Feb 12 13:39:26 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:26 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:26 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:26 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output update for this device Feb 12 13:39:26 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:26 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output Feb 12 13:39:26 rivoplus sudo[4092]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:26 rivoplus sudo[4096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 13:39:26 rivoplus sudo[4096]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:26 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 12 13:39:26 rivoplus systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 12 13:39:26 rivoplus systemd[1]: shairport-sync.service: Succeeded. Feb 12 13:39:26 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:26 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:26 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:26 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:26 rivoplus sudo[4096]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:26 rivoplus dbus-daemon[2835]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.22' (uid=1000 pid=4104 comm="/usr/bin/pulseaudio --high-priority=true " label="kernel") Feb 12 13:39:26 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:26 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:26 rivoplus systemd[1]: Starting RealtimeKit Scheduling Policy Service... Feb 12 13:39:26 rivoplus kernel: IPVS: Creating netns size=1928 id=2 Feb 12 13:39:27 rivoplus dbus-daemon[2835]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Feb 12 13:39:27 rivoplus systemd[1]: Started RealtimeKit Scheduling Policy Service. Feb 12 13:39:27 rivoplus rtkit-daemon[4105]: Successfully called chroot. Feb 12 13:39:27 rivoplus rtkit-daemon[4105]: Successfully dropped privileges. Feb 12 13:39:27 rivoplus rtkit-daemon[4105]: Successfully limited resources. Feb 12 13:39:27 rivoplus rtkit-daemon[4105]: Running. Feb 12 13:39:27 rivoplus rtkit-daemon[4105]: Watchdog thread running. Feb 12 13:39:27 rivoplus rtkit-daemon[4105]: Canary thread running. Feb 12 13:39:27 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:27 rivoplus dbus-daemon[2835]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.24' (uid=0 pid=4105 comm="/usr/lib/rtkit/rtkit-daemon " label="kernel") Feb 12 13:39:27 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:27 rivoplus volumio[3301]: info: TidalConnect service stoped! Feb 12 13:39:27 rivoplus systemd[1]: Starting Authorization Manager... Feb 12 13:39:27 rivoplus volumio[3301]: info: Turning Off Onboard LEDs Feb 12 13:39:27 rivoplus volumio[3301]: info: CoreCommandRouter::servicePushState Feb 12 13:39:27 rivoplus sudo[4121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Feb 12 13:39:27 rivoplus sudo[4121]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:27 rivoplus polkitd[4110]: started daemon version 0.105 using authority implementation `local' version `0.105' Feb 12 13:39:27 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:27 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:27 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:27 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:27 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:27 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output update for this device Feb 12 13:39:27 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output Feb 12 13:39:27 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:27 rivoplus volumio[3301]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received inputs Feb 12 13:39:27 rivoplus volumio[3301]: info: CoreCommandRouter::volumiosetSourceActiveno-source Feb 12 13:39:27 rivoplus systemd[1]: Started Authorization Manager. Feb 12 13:39:27 rivoplus dbus-daemon[2835]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Feb 12 13:39:27 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 13:39:27 rivoplus sudo[4121]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:27 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:27 rivoplus sudo[4124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Feb 12 13:39:27 rivoplus sudo[4124]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:27 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:27 rivoplus sudo[4124]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:27 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:27 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:27 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:27 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:27 rivoplus volumio[3301]: info: Shairport-Sync Started Feb 12 13:39:27 rivoplus volumio[3301]: Error adding Membership: Error: addMembership EINVAL Feb 12 13:39:27 rivoplus volumio[3301]: info: Shairport-Sync Started Feb 12 13:39:27 rivoplus volumio[3301]: info: Asound.conf file unchanged, so no further update is needed Feb 12 13:39:27 rivoplus volumio[3301]: info: Output device has changed, restarting MPD Feb 12 13:39:27 rivoplus sudo[4131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 13:39:27 rivoplus sudo[4131]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:27 rivoplus volumio[3301]: info: Output device has changed, restarting Shairport Sync Feb 12 13:39:27 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:27 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:27 rivoplus sudo[4131]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:27 rivoplus sudo[4134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 13:39:27 rivoplus sudo[4134]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:28 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 12 13:39:28 rivoplus systemd[1]: mpd.service: Succeeded. Feb 12 13:39:28 rivoplus systemd[1]: Stopped Music Player Daemon. Feb 12 13:39:28 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:28 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:28 rivoplus volumio[3301]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 13:39:28 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:28 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:28 rivoplus volumio[3301]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:28 rivoplus systemd[1]: Starting Music Player Daemon... Feb 12 13:39:28 rivoplus volumio[3301]: info: QobuzConnect: setDeactiveState invoked Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:28 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:28 rivoplus volumio[3301]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:28 rivoplus volumio[3301]: info: Preparing to generate the ALSA configuration file Feb 12 13:39:28 rivoplus pulseaudio[4104]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Feb 12 13:39:28 rivoplus pulseaudio[4104]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Feb 12 13:39:28 rivoplus volumiobt[4050]: Applying permissions Feb 12 13:39:28 rivoplus volumiobt[4050]: Setting BT discoverable and pairable Feb 12 13:39:28 rivoplus bluetoothd[3206]: Endpoint registered: sender=:1.44 path=/MediaEndpoint/A2DPSource Feb 12 13:39:28 rivoplus bluetoothd[3206]: Endpoint registered: sender=:1.44 path=/MediaEndpoint/A2DPSink Feb 12 13:39:28 rivoplus pulseaudio[4104]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Feb 12 13:39:28 rivoplus volumio-remote-updater[2833]: [2026-02-12 13:39:28] [connect] Successful connection Feb 12 13:39:28 rivoplus volumiobt[4050]: [96B blob data] Feb 12 13:39:28 rivoplus volumiobt[4050]: [77B blob data] Feb 12 13:39:28 rivoplus volumiobt[4050]: [77B blob data] Feb 12 13:39:28 rivoplus volumiobt[4050]: [33B blob data] Feb 12 13:39:28 rivoplus volumiobt[4050]: [bluetoothctl]> -e power on Feb 12 13:39:28 rivoplus volumiobt[4050]: Invalid command in menu main: -e Feb 12 13:39:28 rivoplus volumiobt[4050]: Feb 12 13:39:28 rivoplus volumiobt[4050]: Use "help" for a list of available commands in a menu. Feb 12 13:39:28 rivoplus volumiobt[4050]: Use "menu " if you want to enter any submenu. Feb 12 13:39:28 rivoplus volumiobt[4050]: Use "back" if you want to return to menu main. Feb 12 13:39:28 rivoplus volumiobt[4050]: [bluetoothctl]> agent on Feb 12 13:39:28 rivoplus volumiobt[4050]: Agent is already registered Feb 12 13:39:28 rivoplus volumiobt[4050]: [bluetoothctl]> discoverable on Feb 12 13:39:28 rivoplus volumiobt[4050]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Feb 12 13:39:28 rivoplus volumiobt[4050]: [bluetoothctl]> pairable on Feb 12 13:39:28 rivoplus volumiobt[4050]: [bluetoothctl]> agent NoInputNoOutput Feb 12 13:39:28 rivoplus volumiobt[4050]: Agent is already registered Feb 12 13:39:28 rivoplus volumiobt[4050]: [bluetoothctl]> default-agent Feb 12 13:39:28 rivoplus volumiobt[4050]: [bluetoothctl]> quit Feb 12 13:39:28 rivoplus volumiobt[4050]: [65B blob data] Feb 12 13:39:28 rivoplus sudo[4141]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 12 13:39:28 rivoplus sudo[4141]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:28 rivoplus sudo[4150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 13:39:28 rivoplus sudo[4150]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:28 rivoplus sudo[4141]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:28 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:28 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:28 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:28 rivoplus sudo[4150]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:28 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:28 rivoplus sudo[4154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 13:39:28 rivoplus sudo[4154]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:28 rivoplus volumio[3301]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 21 Feb 12 13:39:28 rivoplus qobuz-connect[3957]: 20260212 13:39:28.562 [3957.3957] INFO SampleApp: Stopping Local configuration server Feb 12 13:39:28 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 12 13:39:28 rivoplus qobuz-connect[3957]: 20260212 13:39:28.573 [3957.3957] INFO SampleApp: shat down connection on UNIX socket Feb 12 13:39:28 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Feb 12 13:39:28 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 12 13:39:28 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Feb 12 13:39:28 rivoplus sudo[4154]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:28 rivoplus volumio[3301]: info: Onboard LEDs initialized Feb 12 13:39:28 rivoplus volumio[3301]: info: MRS: Getting audio outputs on start Feb 12 13:39:28 rivoplus volumio[3301]: info: MRS: Requesting all other devices output Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:28 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 13:39:28 rivoplus volumio[3301]: info: Not Reporting Auto name since its the default one Feb 12 13:39:28 rivoplus volumio[3301]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 12 13:39:28 rivoplus volumio[3301]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 12 13:39:28 rivoplus volumio[3301]: info: Reading ALSA contributions from plugins. Feb 12 13:39:29 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:29 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:29 rivoplus volumio[3301]: info: FusionDsp - {"Reload":{"result":"Ok"}} Feb 12 13:39:29 rivoplus volumio[3301]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Feb 12 13:39:29 rivoplus volumio[3301]: info: MPD Permissions set Feb 12 13:39:29 rivoplus volumio[3301]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 12 13:39:29 rivoplus volumio[3301]: info: QobuzConnect: setDeactiveState invoked Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:29 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:29 rivoplus volumio[3301]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 12 13:39:29 rivoplus volumio[3301]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 12 13:39:29 rivoplus sudo[4167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 12 13:39:29 rivoplus sudo[4167]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:29 rivoplus volumio[3301]: info: Executing endpoint metavolumio Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 12 13:39:29 rivoplus systemd[1]: Started Volumio Tidal Connect Service. Feb 12 13:39:29 rivoplus volumio-remote-updater[2833]: [2026-02-12 13:39:29] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770874768 101 Feb 12 13:39:29 rivoplus sudo[4167]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:29 rivoplus volumio[3301]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 22 Feb 12 13:39:29 rivoplus volumio[3301]: info: Executing endpoint qc_getconfig Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 12 13:39:29 rivoplus qobuz-connect[4160]: 20260212 13:39:29.652 [4160.4160] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 12 13:39:29 rivoplus qobuz-connect[4160]: 20260212 13:39:29.667 [4160.4160] INFO VolumeManager: [0xace11360]: Setting new playback volume: 75 Feb 12 13:39:29 rivoplus qobuz-connect[4160]: 20260212 13:39:29.667 [4160.4160] INFO VolumeManager: [0xace11360]: Setting new mute state: 0 Feb 12 13:39:29 rivoplus qobuz-connect[4160]: 20260212 13:39:29.667 [4160.4160] INFO QobuzConnect: [0xace11d30]: Client initialized! Feb 12 13:39:29 rivoplus qobuz-connect[4160]: 20260212 13:39:29.667 [4160.4160] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Feb 12 13:39:29 rivoplus volumio[3301]: info: Executing endpoint metavolumio Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 13:39:29 rivoplus volumio[3301]: info: Executing endpoint metavolumio Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 13:39:29 rivoplus qobuz-connect[4160]: 20260212 13:39:29.703 [4160.4160] INFO LocalConfigManager: [0xace10c40]: Starting Local Configuration server Feb 12 13:39:29 rivoplus qobuz-connect[4160]: 20260212 13:39:29.704 [4160.4160] INFO SampleApp: Starting Local configuration server Feb 12 13:39:29 rivoplus qobuz-connect[4160]: 20260212 13:39:29.704 [4160.4160] INFO SampleApp: Connected to UNIX socket client 0xace06ed8 Feb 12 13:39:29 rivoplus volumio[3301]: info: MCU Signalled Playback Inactive Feb 12 13:39:29 rivoplus qobuz-connect[4160]: 20260212 13:39:29.802 [4160.4160] INFO SampleApp: Playback volume changed: 75 Feb 12 13:39:29 rivoplus volumio[3301]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 12 13:39:29 rivoplus volumio[3301]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:29 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 12 13:39:30 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:30 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 12 13:39:30 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:30 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:30 rivoplus sudo[4202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 12 13:39:30 rivoplus sudo[4202]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:30 rivoplus volumio[3301]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 23 Feb 12 13:39:30 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:30 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:30 rivoplus sudo[4202]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:30 rivoplus sudo[4204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 12 13:39:30 rivoplus sudo[4204]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:30 rivoplus systemd[1]: Started RAAT DAEMON. Feb 12 13:39:30 rivoplus sudo[4204]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:31 rivoplus volumio[3301]: info: Executing endpoint tc_getconfig Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 12 13:39:31 rivoplus vtcs[4169]: STARTING TidalConnect services, version: 1.6.1 Feb 12 13:39:31 rivoplus volumio[3301]: info: Starting Shairport Sync Feb 12 13:39:31 rivoplus vtcs[4169]: STARTED TidalConnect services. Feb 12 13:39:31 rivoplus sudo[4224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 13:39:31 rivoplus sudo[4224]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:31 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 12 13:39:31 rivoplus systemd[1]: shairport-sync.service: Succeeded. Feb 12 13:39:31 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:31 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:31 rivoplus sudo[4224]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:31 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:31 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 12 13:39:31 rivoplus volumio[3301]: info: Raat Daemon started successfully Feb 12 13:39:31 rivoplus volumio[3301]: info: Executing endpoint restartRAATSocket Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 12 13:39:31 rivoplus volumio[3301]: info: Executing endpoint tc_connect Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 12 13:39:31 rivoplus volumio[3301]: info: Connecting to TidalConnect Feb 12 13:39:31 rivoplus volumio[3301]: info: Shairport-Sync Started Feb 12 13:39:31 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Feb 12 13:39:31 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Feb 12 13:39:31 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreCommandRouter::servicePushState Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:31 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:31 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:31 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output update for this device Feb 12 13:39:31 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output Feb 12 13:39:31 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:31 rivoplus volumio[3301]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreCommandRouter::servicePushState Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:31 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:31 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:31 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:31 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output update for this device Feb 12 13:39:31 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output Feb 12 13:39:31 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:31 rivoplus volumio[3301]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Feb 12 13:39:31 rivoplus volumio[3301]: info: Asound.conf file written Feb 12 13:39:31 rivoplus sudo[4239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 12 13:39:31 rivoplus sudo[4239]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:31 rivoplus sudo[4239]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:32 rivoplus kernel: Fine tdm clk setting range (0~2000000), 12287994 Feb 12 13:39:32 rivoplus kernel: Err: can not set rate to 4278967296! Feb 12 13:39:32 rivoplus kernel: Range[3920000 - 500000000] Feb 12 13:39:32 rivoplus kernel: out of value, fixed it Feb 12 13:39:32 rivoplus kernel: id=0 set inskew=0 Feb 12 13:39:32 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:32 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:32 rivoplus volumio[3301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Feb 12 13:39:32 rivoplus volumio[3301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Feb 12 13:39:32 rivoplus volumio[3301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Feb 12 13:39:32 rivoplus volumio[3301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Feb 12 13:39:32 rivoplus volumio[3301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 5 Validity:0' : Operation not permitted Feb 12 13:39:32 rivoplus volumio[3301]: info: Output device has changed, restarting MPD Feb 12 13:39:32 rivoplus sudo[4244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 13:39:32 rivoplus volumio[3301]: info: Output device has changed, restarting Shairport Sync Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:32 rivoplus sudo[4244]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:32 rivoplus sudo[4244]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:32 rivoplus sudo[4247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 13:39:32 rivoplus sudo[4247]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:32 rivoplus mpd[4155]: Feb 12 13:39 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 12 13:39:32 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:32 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:32 rivoplus volumio[3301]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 13:39:32 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:32 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:32 rivoplus volumio[3301]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 12 13:39:32 rivoplus systemd[1]: mpd.service: Succeeded. Feb 12 13:39:32 rivoplus systemd[1]: Stopped Music Player Daemon. Feb 12 13:39:32 rivoplus volumio[3301]: info: QobuzConnect: setDeactiveState invoked Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:32 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:32 rivoplus volumio[3301]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus vtcs[4169]: [2026-02-12 13:39:32.253] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 12 13:39:32 rivoplus vtcs[4169]: [2026-02-12 13:39:32.255] [tisoc] [error] [SpkconServer.cpp:476] socket write error. fd=3 errorno=32 error=Broken pipe Feb 12 13:39:32 rivoplus vtcs[4169]: [2026-02-12 13:39:32.256] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Feb 12 13:39:32 rivoplus systemd[1]: Starting Music Player Daemon... Feb 12 13:39:32 rivoplus volumio[3301]: info: Preparing to generate the ALSA configuration file Feb 12 13:39:32 rivoplus sudo[4256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 13:39:32 rivoplus sudo[4256]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:32 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service... Feb 12 13:39:32 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Feb 12 13:39:32 rivoplus systemd[1]: vtcs.service: Succeeded. Feb 12 13:39:32 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service. Feb 12 13:39:32 rivoplus sudo[4259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 13:39:32 rivoplus sudo[4259]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:32 rivoplus sudo[4256]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:32 rivoplus sudo[4259]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:32 rivoplus sudo[4254]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 12 13:39:32 rivoplus sudo[4254]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:32 rivoplus sudo[4254]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:32 rivoplus sudo[4267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 13:39:32 rivoplus sudo[4267]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:32 rivoplus volumio[3301]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 24 Feb 12 13:39:32 rivoplus volumio[3301]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 12 13:39:32 rivoplus volumio[3301]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 12 13:39:32 rivoplus volumio[3301]: info: Reading ALSA contributions from plugins. Feb 12 13:39:32 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:32 rivoplus sudo[4267]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:32 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:32 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:32 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:32 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:32 rivoplus sudo[4271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 13:39:32 rivoplus sudo[4271]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:32 rivoplus volumio[3301]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Feb 12 13:39:32 rivoplus volumio[3301]: info: MPD Permissions set Feb 12 13:39:32 rivoplus volumio[3301]: info: TidalConnect service started! Feb 12 13:39:32 rivoplus qobuz-connect[4160]: 20260212 13:39:32.730 [4160.4160] INFO SampleApp: Stopping Local configuration server Feb 12 13:39:32 rivoplus qobuz-connect[4160]: 20260212 13:39:32.742 [4160.4160] INFO SampleApp: shat down connection on UNIX socket Feb 12 13:39:32 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 12 13:39:32 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Feb 12 13:39:32 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 12 13:39:32 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Feb 12 13:39:32 rivoplus sudo[4271]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: Not Reporting Auto name since its the default one Feb 12 13:39:32 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:32 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:32 rivoplus volumio[3301]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 12 13:39:32 rivoplus volumio[3301]: info: QobuzConnect: setDeactiveState invoked Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:32 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:32 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:33 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:33 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 12 13:39:33 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:33 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 12 13:39:33 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:33 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:33 rivoplus volumio[3301]: info: Executing endpoint qc_getconfig Feb 12 13:39:33 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 12 13:39:33 rivoplus sudo[4289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 12 13:39:33 rivoplus sudo[4289]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:33 rivoplus sudo[4289]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:33 rivoplus qobuz-connect[4273]: 20260212 13:39:33.284 [4273.4273] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 12 13:39:33 rivoplus qobuz-connect[4273]: 20260212 13:39:33.291 [4273.4273] INFO VolumeManager: [0xac10d360]: Setting new playback volume: 75 Feb 12 13:39:33 rivoplus qobuz-connect[4273]: 20260212 13:39:33.291 [4273.4273] INFO VolumeManager: [0xac10d360]: Setting new mute state: 0 Feb 12 13:39:33 rivoplus qobuz-connect[4273]: 20260212 13:39:33.291 [4273.4273] INFO QobuzConnect: [0xac10dd30]: Client initialized! Feb 12 13:39:33 rivoplus qobuz-connect[4273]: 20260212 13:39:33.291 [4273.4273] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Feb 12 13:39:33 rivoplus volumio[3301]: info: Starting Shairport Sync Feb 12 13:39:33 rivoplus qobuz-connect[4273]: 20260212 13:39:33.320 [4273.4273] INFO LocalConfigManager: [0xac10cc40]: Starting Local Configuration server Feb 12 13:39:33 rivoplus qobuz-connect[4273]: 20260212 13:39:33.320 [4273.4273] INFO SampleApp: Starting Local configuration server Feb 12 13:39:33 rivoplus qobuz-connect[4273]: 20260212 13:39:33.320 [4273.4273] INFO SampleApp: Connected to UNIX socket client 0xac102ed8 Feb 12 13:39:33 rivoplus sudo[4293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 12 13:39:33 rivoplus sudo[4293]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:33 rivoplus volumio[3301]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 12 13:39:33 rivoplus volumio[3301]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 12 13:39:33 rivoplus volumio[3301]: info: RAAT: Requesting Headphone Status Feb 12 13:39:33 rivoplus systemd[1]: Stopped RAAT DAEMON. Feb 12 13:39:33 rivoplus sudo[4297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 13:39:33 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 12 13:39:33 rivoplus sudo[4297]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:33 rivoplus systemd[1]: Started RAAT DAEMON. Feb 12 13:39:33 rivoplus volumio[3301]: info: Asound.conf file written Feb 12 13:39:33 rivoplus qobuz-connect[4273]: 20260212 13:39:33.434 [4273.4273] INFO SampleApp: Playback volume changed: 75 Feb 12 13:39:33 rivoplus sudo[4293]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:33 rivoplus sudo[4307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 12 13:39:33 rivoplus sudo[4307]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:33 rivoplus sudo[4307]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:33 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 12 13:39:33 rivoplus systemd[1]: shairport-sync.service: Succeeded. Feb 12 13:39:33 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:33 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:33 rivoplus sudo[4297]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:33 rivoplus kernel: Fine tdm clk setting range (0~2000000), 12287994 Feb 12 13:39:33 rivoplus kernel: Err: can not set rate to 4274967296! Feb 12 13:39:33 rivoplus kernel: Range[3920000 - 500000000] Feb 12 13:39:33 rivoplus kernel: out of value, fixed it Feb 12 13:39:33 rivoplus kernel: id=0 set inskew=0 Feb 12 13:39:33 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:33 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:33 rivoplus volumio[3301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Feb 12 13:39:33 rivoplus volumio[3301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Feb 12 13:39:33 rivoplus volumio[3301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Feb 12 13:39:33 rivoplus volumio[3301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Feb 12 13:39:33 rivoplus volumio[3301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 5 Validity:0' : Operation not permitted Feb 12 13:39:33 rivoplus volumio[3301]: info: Output device has changed, restarting MPD Feb 12 13:39:33 rivoplus volumio[3301]: info: Output device has changed, restarting Shairport Sync Feb 12 13:39:33 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:33 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:33 rivoplus sudo[4318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 13:39:33 rivoplus sudo[4318]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:33 rivoplus sudo[4318]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:33 rivoplus sudo[4321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 13:39:33 rivoplus sudo[4321]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:33 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:33 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:33 rivoplus volumio[3301]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 13:39:33 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:33 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:33 rivoplus volumio[3301]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 12 13:39:33 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:33 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 12 13:39:33 rivoplus systemd[1]: mpd.service: Succeeded. Feb 12 13:39:33 rivoplus systemd[1]: Stopped Music Player Daemon. Feb 12 13:39:33 rivoplus systemd[1]: Starting Music Player Daemon... Feb 12 13:39:33 rivoplus volumio[3301]: info: QobuzConnect: setDeactiveState invoked Feb 12 13:39:33 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:33 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:33 rivoplus volumio[3301]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 12 13:39:33 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:33 rivoplus volumio[3301]: info: Preparing to generate the ALSA configuration file Feb 12 13:39:34 rivoplus sudo[4344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 13:39:34 rivoplus sudo[4344]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:34 rivoplus sudo[4344]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:34 rivoplus sudo[4360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 13:39:34 rivoplus sudo[4360]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:34 rivoplus sudo[4338]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 12 13:39:34 rivoplus sudo[4338]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:34 rivoplus sudo[4338]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:34 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:34 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:34 rivoplus sudo[4360]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:34 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:34 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:34 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:34 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:34 rivoplus volumio[3301]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 12 13:39:34 rivoplus volumio[3301]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 12 13:39:34 rivoplus volumio[3301]: info: Reading ALSA contributions from plugins. Feb 12 13:39:34 rivoplus volumio[3301]: info: Checking for updated MCU Firmware Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 12 13:39:34 rivoplus volumio[3301]: info: Firware on device is on latest version, no need to update Feb 12 13:39:34 rivoplus sudo[4374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 13:39:34 rivoplus sudo[4374]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:34 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:34 rivoplus volumio[3301]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Feb 12 13:39:34 rivoplus volumio[3301]: info: MPD Permissions set Feb 12 13:39:34 rivoplus volumio[3301]: info: Shairport-Sync Started Feb 12 13:39:34 rivoplus volumio[3301]: info: Raat Daemon started successfully Feb 12 13:39:34 rivoplus volumio[3301]: info: MCU Signalled Headphone Mode Disabled Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 12 13:39:34 rivoplus volumio[3301]: info: Reporting Headphone State: false Feb 12 13:39:34 rivoplus sudo[4374]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: Updating RAAT Signal Path Feb 12 13:39:34 rivoplus volumio[3301]: info: Executing endpoint restartRAATSocket Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 12 13:39:34 rivoplus sudo[4387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 13:39:34 rivoplus sudo[4387]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:34 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: Not Reporting Auto name since its the default one Feb 12 13:39:34 rivoplus qobuz-connect[4273]: 20260212 13:39:34.545 [4273.4273] INFO SampleApp: Stopping Local configuration server Feb 12 13:39:34 rivoplus qobuz-connect[4273]: 20260212 13:39:34.555 [4273.4273] INFO SampleApp: shat down connection on UNIX socket Feb 12 13:39:34 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Feb 12 13:39:34 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 12 13:39:34 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 12 13:39:34 rivoplus sudo[4387]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:34 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:34 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:34 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:34 rivoplus volumio[3301]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 12 13:39:34 rivoplus volumio[3301]: info: QobuzConnect: setDeactiveState invoked Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:34 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 12 13:39:34 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:34 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:34 rivoplus volumio[3301]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 25 Feb 12 13:39:34 rivoplus volumio[3301]: info: Executing endpoint qc_getconfig Feb 12 13:39:34 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 12 13:39:34 rivoplus sudo[4405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 12 13:39:34 rivoplus sudo[4405]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:34 rivoplus sudo[4405]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:34 rivoplus qobuz-connect[4395]: 20260212 13:39:34.995 [4395.4395] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 12 13:39:35 rivoplus qobuz-connect[4395]: 20260212 13:39:35.006 [4395.4395] INFO VolumeManager: [0xabf04360]: Setting new playback volume: 75 Feb 12 13:39:35 rivoplus qobuz-connect[4395]: 20260212 13:39:35.007 [4395.4395] INFO VolumeManager: [0xabf04360]: Setting new mute state: 0 Feb 12 13:39:35 rivoplus qobuz-connect[4395]: 20260212 13:39:35.008 [4395.4395] INFO QobuzConnect: [0xabf04d30]: Client initialized! Feb 12 13:39:35 rivoplus qobuz-connect[4395]: 20260212 13:39:35.008 [4395.4395] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Feb 12 13:39:35 rivoplus volumio[3301]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 26 Feb 12 13:39:35 rivoplus volumio[3301]: info: Starting Shairport Sync Feb 12 13:39:35 rivoplus sudo[4409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 12 13:39:35 rivoplus sudo[4409]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:35 rivoplus qobuz-connect[4395]: 20260212 13:39:35.039 [4395.4395] INFO LocalConfigManager: [0xabf03c40]: Starting Local Configuration server Feb 12 13:39:35 rivoplus qobuz-connect[4395]: 20260212 13:39:35.040 [4395.4395] INFO SampleApp: Starting Local configuration server Feb 12 13:39:35 rivoplus qobuz-connect[4395]: 20260212 13:39:35.041 [4395.4395] INFO SampleApp: Connected to UNIX socket client 0xabef9ed8 Feb 12 13:39:35 rivoplus volumio[3301]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 12 13:39:35 rivoplus volumio[3301]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 12 13:39:35 rivoplus systemd[1]: Stopped RAAT DAEMON. Feb 12 13:39:35 rivoplus sudo[4413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 13:39:35 rivoplus systemd[1]: Started RAAT DAEMON. Feb 12 13:39:35 rivoplus sudo[4413]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:35 rivoplus qobuz-connect[4395]: 20260212 13:39:35.145 [4395.4395] INFO SampleApp: Playback volume changed: 75 Feb 12 13:39:35 rivoplus sudo[4409]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:35 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:35 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:35 rivoplus volumio[3301]: info: Asound.conf file unchanged, so no further update is needed Feb 12 13:39:35 rivoplus volumio[3301]: info: Output device has changed, restarting MPD Feb 12 13:39:35 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 12 13:39:35 rivoplus systemd[1]: shairport-sync.service: Succeeded. Feb 12 13:39:35 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:35 rivoplus systemd[1]: shairport-sync.service: Start request repeated too quickly. Feb 12 13:39:35 rivoplus systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Feb 12 13:39:35 rivoplus systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:35 rivoplus sudo[4413]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:35 rivoplus volumio[3301]: info: Output device has changed, restarting Shairport Sync Feb 12 13:39:35 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:35 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:35 rivoplus sudo[4426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 13:39:35 rivoplus sudo[4426]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:35 rivoplus sudo[4426]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:35 rivoplus sudo[4428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 13:39:35 rivoplus sudo[4428]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:35 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:35 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:35 rivoplus volumio[3301]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 13:39:35 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:35 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:35 rivoplus volumio[3301]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 12 13:39:35 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:35 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 12 13:39:35 rivoplus systemd[1]: mpd.service: Succeeded. Feb 12 13:39:35 rivoplus systemd[1]: Stopped Music Player Daemon. Feb 12 13:39:35 rivoplus volumio[3301]: info: QobuzConnect: setDeactiveState invoked Feb 12 13:39:35 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:35 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:35 rivoplus volumio[3301]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Feb 12 13:39:35 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:35 rivoplus systemd[1]: Starting Music Player Daemon... Feb 12 13:39:35 rivoplus sudo[4440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 13:39:35 rivoplus sudo[4440]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:35 rivoplus sudo[4440]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:35 rivoplus sudo[4445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 13:39:35 rivoplus sudo[4445]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:35 rivoplus sudo[4445]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:35 rivoplus sudo[4437]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 12 13:39:35 rivoplus sudo[4437]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:35 rivoplus sudo[4437]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:35 rivoplus volumio[3301]: info: Raat Daemon started successfully Feb 12 13:39:35 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:35 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:35 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:35 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:35 rivoplus sudo[4453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 13:39:35 rivoplus sudo[4453]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:35 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:35 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:35 rivoplus volumio[3301]: info: Executing endpoint restartRAATSocket Feb 12 13:39:35 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 12 13:39:35 rivoplus volumio[3301]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Feb 12 13:39:35 rivoplus volumio[3301]: info: MPD Permissions set Feb 12 13:39:35 rivoplus volumio[3301]: info: TidalConnect service stoped! Feb 12 13:39:35 rivoplus sudo[4453]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:35 rivoplus volumio[3301]: info: TidalConnect service stoped! Feb 12 13:39:35 rivoplus volumio[3301]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Feb 12 13:39:35 rivoplus volumio[3301]: Job for shairport-sync.service failed. Feb 12 13:39:35 rivoplus volumio[3301]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Feb 12 13:39:35 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Feb 12 13:39:35 rivoplus sudo[4457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 13:39:35 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Feb 12 13:39:35 rivoplus sudo[4457]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:36 rivoplus qobuz-connect[4395]: 20260212 13:39:36.021 [4395.4395] INFO SampleApp: Stopping Local configuration server Feb 12 13:39:36 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 12 13:39:36 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:36 rivoplus qobuz-connect[4395]: 20260212 13:39:36.032 [4395.4395] INFO SampleApp: shat down connection on UNIX socket Feb 12 13:39:36 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Feb 12 13:39:36 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 12 13:39:36 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Feb 12 13:39:36 rivoplus sudo[4457]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: Not Reporting Auto name since its the default one Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 12 13:39:36 rivoplus volumio[3301]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 12 13:39:36 rivoplus volumio[3301]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 12 13:39:36 rivoplus volumio[3301]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 12 13:39:36 rivoplus volumio[3301]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 12 13:39:36 rivoplus volumio[3301]: info: QobuzConnect: setDeactiveState invoked Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:36 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:36 rivoplus volumio[3301]: info: RAAT: Requesting Headphone Status Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 12 13:39:36 rivoplus sudo[4480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 12 13:39:36 rivoplus sudo[4480]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:36 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 12 13:39:36 rivoplus volumio[3301]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 12 13:39:36 rivoplus volumio[3301]: info: Received Get System Info Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 12 13:39:36 rivoplus volumio[3301]: info: Discovery: Getting this device information Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:36 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:36 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:36 rivoplus volumio[3301]: info: Listing playlists Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:36 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 12 13:39:36 rivoplus systemd[1]: Started Volumio Tidal Connect Service. Feb 12 13:39:36 rivoplus volumio[3301]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 26 Feb 12 13:39:36 rivoplus sudo[4480]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:36 rivoplus volumio[3301]: info: Executing endpoint qc_getconfig Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 12 13:39:36 rivoplus qobuz-connect[4464]: 20260212 13:39:36.664 [4464.4464] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 12 13:39:36 rivoplus volumio[3301]: info: Starting Shairport Sync Feb 12 13:39:36 rivoplus qobuz-connect[4464]: 20260212 13:39:36.680 [4464.4464] INFO VolumeManager: [0xabf62360]: Setting new playback volume: 75 Feb 12 13:39:36 rivoplus qobuz-connect[4464]: 20260212 13:39:36.680 [4464.4464] INFO VolumeManager: [0xabf62360]: Setting new mute state: 0 Feb 12 13:39:36 rivoplus qobuz-connect[4464]: 20260212 13:39:36.680 [4464.4464] INFO QobuzConnect: [0xabf62d30]: Client initialized! Feb 12 13:39:36 rivoplus qobuz-connect[4464]: 20260212 13:39:36.680 [4464.4464] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Feb 12 13:39:36 rivoplus qobuz-connect[4464]: 20260212 13:39:36.699 [4464.4464] INFO LocalConfigManager: [0xabf61c40]: Starting Local Configuration server Feb 12 13:39:36 rivoplus qobuz-connect[4464]: 20260212 13:39:36.699 [4464.4464] INFO SampleApp: Starting Local configuration server Feb 12 13:39:36 rivoplus qobuz-connect[4464]: 20260212 13:39:36.700 [4464.4464] INFO SampleApp: Connected to UNIX socket client 0xabf57ed8 Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 12 13:39:36 rivoplus sudo[4489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 13:39:36 rivoplus sudo[4489]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:36 rivoplus qobuz-connect[4464]: 20260212 13:39:36.814 [4464.4464] INFO SampleApp: Playback volume changed: 75 Feb 12 13:39:36 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 12 13:39:36 rivoplus sudo[4489]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:36 rivoplus volumio[3301]: No protocol specified Feb 12 13:39:36 rivoplus volumio[3301]: xcb_connection_has_error() returned true Feb 12 13:39:36 rivoplus volumio[3301]: info: MCU Signalled Headphone Mode Disabled Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 12 13:39:36 rivoplus volumio[3301]: info: Reporting Headphone State: false Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:36 rivoplus volumio[3301]: info: Updating RAAT Signal Path Feb 12 13:39:37 rivoplus sudo[4495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 12 13:39:37 rivoplus sudo[4495]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:37 rivoplus volumio[3301]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 12 13:39:37 rivoplus volumio[3301]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 12 13:39:37 rivoplus sudo[4495]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:37 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:37 rivoplus volumio[3301]: info: Shairport-Sync Started Feb 12 13:39:37 rivoplus sudo[4499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 12 13:39:37 rivoplus sudo[4499]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:37 rivoplus volumio[3301]: info: TidalConnect service stoped! Feb 12 13:39:37 rivoplus systemd[1]: Stopped RAAT DAEMON. Feb 12 13:39:37 rivoplus systemd[1]: Started RAAT DAEMON. Feb 12 13:39:37 rivoplus sudo[4499]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:37 rivoplus volumio[3301]: info: Raat Daemon started successfully Feb 12 13:39:37 rivoplus volumio[3301]: info: TidalConnect service stoped! Feb 12 13:39:37 rivoplus volumio[3301]: info: Executing endpoint tc_getconfig Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 12 13:39:37 rivoplus vtcs[4482]: STARTING TidalConnect services, version: 1.6.1 Feb 12 13:39:37 rivoplus vtcs[4482]: STARTED TidalConnect services. Feb 12 13:39:37 rivoplus volumio[3301]: info: Executing endpoint restartRAATSocket Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 12 13:39:37 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT Feb 12 13:39:37 rivoplus systemd[1]: raat-daemon.service: Failed with result 'signal'. Feb 12 13:39:37 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:37 rivoplus volumio[3301]: info: Executing endpoint tc_connect Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 12 13:39:37 rivoplus volumio[3301]: info: Connecting to TidalConnect Feb 12 13:39:37 rivoplus volumio[3301]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 12 13:39:37 rivoplus volumio[3301]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::servicePushState Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:37 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:37 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:37 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output update for this device Feb 12 13:39:37 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output Feb 12 13:39:37 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:37 rivoplus volumio[3301]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::servicePushState Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreStateMachine::pushState Feb 12 13:39:37 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushState Feb 12 13:39:37 rivoplus sudo[4536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 12 13:39:37 rivoplus sudo[4536]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:37 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:37 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output update for this device Feb 12 13:39:37 rivoplus volumio[3301]: info: MRS: Pushing multiroomSync output Feb 12 13:39:37 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:37 rivoplus volumio[3301]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Feb 12 13:39:37 rivoplus sudo[4536]: pam_unix(sudo:session): session closed for user root Feb 12 13:39:37 rivoplus volumio[3301]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 26 Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 12 13:39:37 rivoplus volumio[3301]: info: Received Get System Info Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 12 13:39:37 rivoplus volumio[3301]: info: Discovery: Getting this device information Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::volumioGetState Feb 12 13:39:37 rivoplus volumio[3301]: info: CorePlayQueue::getTrack 0 Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 12 13:39:37 rivoplus volumio[3301]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 12 13:39:38 rivoplus volumio[3301]: info: RAAT: Requesting Headphone Status Feb 12 13:39:38 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 12 13:39:38 rivoplus volumio[3301]: info: MCU Signalled Headphone Mode Disabled Feb 12 13:39:38 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Feb 12 13:39:38 rivoplus volumio[3301]: info: Reporting Headphone State: false Feb 12 13:39:38 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:38 rivoplus volumio[3301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 13:39:38 rivoplus volumio[3301]: info: Updating RAAT Signal Path Feb 12 13:39:38 rivoplus volumio[3301]: info: Preload queue cleared Feb 12 13:39:38 rivoplus volumio[3301]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 12 13:39:38 rivoplus volumio[3301]: info: CoreStateMachine::ClearQueue Feb 12 13:39:38 rivoplus volumio[3301]: info: CoreStateMachine::stop Feb 12 13:39:38 rivoplus volumio[3301]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 13:39:38 rivoplus volumio[3301]: info: CorePlayQueue::clearPlayQueue Feb 12 13:39:38 rivoplus volumio[3301]: info: CorePlayQueue::saveQueue Feb 12 13:39:38 rivoplus volumio[3301]: info: CoreCommandRouter::volumioPushQueue Feb 12 13:39:38 rivoplus volumio[3301]: info: CoreStateMachine::addQueueItems Feb 12 13:39:38 rivoplus volumio[3301]: info: CorePlayQueue::addQueueItems Feb 12 13:39:38 rivoplus volumio[3301]: info: Preload queue cleared Feb 12 13:39:38 rivoplus volumio[3301]: info: Adding Item to queue: music-library/NAS/NAS/Test Tracks/Channel Test Tone By Jeffrey Richards/01 Right Channel Identification PCM.flac Feb 12 13:39:38 rivoplus volumio[3301]: info: Exploding uri music-library/NAS/NAS/Test Tracks/Channel Test Tone By Jeffrey Richards/01 Right Channel Identification PCM.flac in service mpd Feb 12 13:39:38 rivoplus volumio[3301]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 12 13:39:38 rivoplus volumio[3301]: TypeError: Cannot read property 'then' of undefined Feb 12 13:39:38 rivoplus volumio[3301]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2541:19) Feb 12 13:39:38 rivoplus volumio[3301]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2339:21) Feb 12 13:39:38 rivoplus volumio[3301]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:16) Feb 12 13:39:38 rivoplus volumio[3301]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Feb 12 13:39:38 rivoplus volumio[3301]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Feb 12 13:39:38 rivoplus volumio[3301]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Feb 12 13:39:38 rivoplus volumio[3301]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:251:25) Feb 12 13:39:38 rivoplus volumio[3301]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:511:25) Feb 12 13:39:38 rivoplus volumio[3301]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Feb 12 13:39:38 rivoplus volumio[3301]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Feb 12 13:39:38 rivoplus volumio[3301]: at Socket.emit (events.js:400:28) Feb 12 13:39:38 rivoplus volumio[3301]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Feb 12 13:39:38 rivoplus volumio[3301]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Feb 12 13:39:38 rivoplus volumio[3301]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 12 13:39:39 rivoplus mpd[4455]: Feb 12 13:39 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 12 13:39:39 rivoplus sudo[4549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-12 13:38 Feb 12 13:39:39 rivoplus sudo[4549]: 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="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 02:06:11 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="6fcef4b36db553cbf88901935dbe83e3"