-- Logs begin at Wed 2026-01-28 19:53:01 NZDT, end at Wed 2026-01-28 20:34:58 NZDT. -- Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 20:33:03 rivoplus volumio[11326]: info: Retrieving Cloud Streaming UI Jan 28 20:33:03 rivoplus volumio[11326]: info: Getting Tidal Cloud Configuration Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 20:33:03 rivoplus volumio[11326]: info: Getting Qobuz Cloud Configuration Jan 28 20:33:03 rivoplus volumio[11326]: info: Asking plugin for UI Config Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 20:33:03 rivoplus volumio[11326]: info: Getting Spotify Cloud Configuration Jan 28 20:33:03 rivoplus volumio[11326]: info: Asking plugin for UI Config Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 20:33:03 rivoplus volumio[11326]: info: Saving Spotify Acccount Jan 28 20:33:03 rivoplus volumio[11326]: info: Got it Jan 28 20:33:03 rivoplus volumio[11326]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 28 20:33:03 rivoplus volumio[11326]: info: Got Tidal Cloud Configuration Jan 28 20:33:03 rivoplus volumio[11326]: info: Got it Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::volumioGetBrowseSources Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::volumioGetBrowseSources Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::volumioGetBrowseSources Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 20:33:03 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 28 20:33:07 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 20:33:11 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 20:33:15 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 20:33:19 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 20:33:23 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 20:33:27 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 20:33:31 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 20:33:35 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 20:33:39 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 20:33:41 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Jan 28 20:33:41 rivoplus sudo[13408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/The_Vault Jan 28 20:33:41 rivoplus sudo[13408]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:33:41 rivoplus systemd[1]: mnt-NAS-The_Vault.mount: Succeeded. Jan 28 20:33:41 rivoplus sudo[13408]: pam_unix(sudo:session): session closed for user root Jan 28 20:33:41 rivoplus volumio[11326]: info: Share The Vault successfully unmounted Jan 28 20:33:41 rivoplus sudo[13412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Donaldo,password=L3tM31n!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.1.250/Music /mnt/NAS/The_Vault Jan 28 20:33:41 rivoplus sudo[13412]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:33:41 rivoplus sudo[13412]: pam_unix(sudo:session): session closed for user root Jan 28 20:33:41 rivoplus volumio[11326]: verbose: ControllerMpd::sendMpdCommand status Jan 28 20:33:41 rivoplus volumio[11326]: info: Jan 28 20:33:41 rivoplus volumio[11326]: ---------------------------- MPD announces state update: update Jan 28 20:33:41 rivoplus volumio[11326]: info: ControllerMpd::getState Jan 28 20:33:41 rivoplus volumio[11326]: verbose: ControllerMpd::sendMpdCommand status Jan 28 20:33:41 rivoplus volumio[11326]: verbose: ControllerMpd::sendMpdCommand status Jan 28 20:33:41 rivoplus volumio[11326]: info: Jan 28 20:33:41 rivoplus volumio[11326]: ---------------------------- MPD announces state update: update Jan 28 20:33:41 rivoplus volumio[11326]: info: ControllerMpd::getState Jan 28 20:33:41 rivoplus volumio[11326]: verbose: ControllerMpd::sendMpdCommand status Jan 28 20:33:41 rivoplus volumio[11326]: verbose: ControllerMpd::sendMpdCommand status Jan 28 20:33:41 rivoplus volumio[11326]: info: Jan 28 20:33:41 rivoplus volumio[11326]: ---------------------------- MPD announces state update: update Jan 28 20:33:41 rivoplus volumio[11326]: info: ControllerMpd::getState Jan 28 20:33:41 rivoplus volumio[11326]: verbose: ControllerMpd::sendMpdCommand status Jan 28 20:33:41 rivoplus volumio[11326]: info: sendMpdCommand status took 17 milliseconds Jan 28 20:33:41 rivoplus volumio[11326]: info: sendMpdCommand status took 12 milliseconds Jan 28 20:33:41 rivoplus volumio[11326]: info: sendMpdCommand status took 11 milliseconds Jan 28 20:33:41 rivoplus volumio[11326]: info: sendMpdCommand status took 9 milliseconds Jan 28 20:33:41 rivoplus volumio[11326]: info: sendMpdCommand status took 9 milliseconds Jan 28 20:33:41 rivoplus volumio[11326]: info: sendMpdCommand status took 7 milliseconds Jan 28 20:33:41 rivoplus volumio[11326]: verbose: ControllerMpd::parseState Jan 28 20:33:41 rivoplus volumio[11326]: info: Command Router : Notfying DB Updatetrue Jan 28 20:33:41 rivoplus volumio[11326]: verbose: ControllerMpd::parseState Jan 28 20:33:41 rivoplus volumio[11326]: verbose: ControllerMpd::parseState Jan 28 20:33:42 rivoplus volumio[11326]: info: Command Router : Notfying DB Updatetrue Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::Close All Modals sent Jan 28 20:33:42 rivoplus volumio[11326]: verbose: ControllerMpd::parseState Jan 28 20:33:42 rivoplus volumio[11326]: verbose: ControllerMpd::parseState Jan 28 20:33:42 rivoplus volumio[11326]: info: Command Router : Notfying DB Updatetrue Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::Close All Modals sent Jan 28 20:33:42 rivoplus volumio[11326]: verbose: ControllerMpd::parseState Jan 28 20:33:42 rivoplus volumio[11326]: info: ControllerMpd::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::servicePushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::volumioPushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 28 20:33:42 rivoplus volumio[11326]: verbose: CURRENT POSITION 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::syncState stateService stop Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::syncState currentStatus stop Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::volumioPushState Jan 28 20:33:42 rivoplus volumio[11326]: info: No code Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::volumioPushState Jan 28 20:33:42 rivoplus volumio[11326]: info: ControllerMpd::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::servicePushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::volumioPushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 28 20:33:42 rivoplus volumio[11326]: verbose: CURRENT POSITION 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::syncState stateService stop Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::syncState currentStatus stop Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::volumioPushState Jan 28 20:33:42 rivoplus volumio[11326]: info: No code Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::volumioPushState Jan 28 20:33:42 rivoplus volumio[11326]: info: ControllerMpd::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::servicePushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::volumioPushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 28 20:33:42 rivoplus volumio[11326]: verbose: CURRENT POSITION 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::syncState stateService stop Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::syncState currentStatus stop Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::volumioPushState Jan 28 20:33:42 rivoplus volumio[11326]: info: No code Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreStateMachine::pushState Jan 28 20:33:42 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::volumioPushState Jan 28 20:33:42 rivoplus volumio[11326]: info: ------------------------------ 377ms Jan 28 20:33:42 rivoplus volumio[11326]: info: ------------------------------ 372ms Jan 28 20:33:42 rivoplus volumio[11326]: info: ------------------------------ 369ms Jan 28 20:33:42 rivoplus volumio[11326]: info: [1769585622281] Database update started Jan 28 20:33:42 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 28 20:33:43 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 20:33:48 rivoplus volumio[11326]: info: CoreCommandRouter::volumioGetState Jan 28 20:33:48 rivoplus volumio[11326]: info: CorePlayQueue::getTrack 0 Jan 28 20:33:53 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 28 20:33:53 rivoplus volumio[11326]: info: CURURI: albums:// Jan 28 20:33:53 rivoplus volumio[11326]: info: listAlbums - loading Albums from cache Jan 28 20:33:54 rivoplus volumio[11326]: info: Preload queue cleared Jan 28 20:33:55 rivoplus nmbd[3050]: [2026/01/28 20:33:55.443792, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jan 28 20:33:55 rivoplus nmbd[3050]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.251 for name WORKGROUP<1d>. Jan 28 20:33:55 rivoplus nmbd[3050]: This response was from IP 192.168.1.252, reporting an IP address of 192.168.1.252. Jan 28 20:34:07 rivoplus volumio[11326]: Searching plugin music_service/mpd Jan 28 20:34:07 rivoplus volumio[11326]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jan 28 20:34:11 rivoplus volumio[11326]: info: All search sources collected, pushing search results Jan 28 20:34:12 rivoplus volumio[11326]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Byron%20Stingily/3ec79220-35a7-4d43-b700-5ba5356a9a2a.jpg' Jan 28 20:34:12 rivoplus volumio[11326]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Byron%20Stingly/32574399-9472-4913-9bd2-a70ca41cd2a5.jpg' Jan 28 20:34:13 rivoplus volumio[11326]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 20:34:13 rivoplus volumio[11326]: Error: connect ECONNREFUSED 158.69.210.98:443 Jan 28 20:34:13 rivoplus volumio[11326]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jan 28 20:34:13 rivoplus volumio[11326]: errno: -111, Jan 28 20:34:13 rivoplus volumio[11326]: code: 'ECONNREFUSED', Jan 28 20:34:13 rivoplus volumio[11326]: syscall: 'connect', Jan 28 20:34:13 rivoplus volumio[11326]: address: '158.69.210.98', Jan 28 20:34:13 rivoplus volumio[11326]: port: 443 Jan 28 20:34:13 rivoplus volumio[11326]: } Jan 28 20:34:13 rivoplus volumio[11326]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 20:34:14 rivoplus sudo[13536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-28 20:33 Jan 28 20:34:14 rivoplus sudo[13536]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:14 rivoplus sudo[13536]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:15 rivoplus volumio-remote-updater[2851]: [2026-01-28 20:34:15] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jan 28 20:34:15 rivoplus volumio-remote-updater[2851]: [2026-01-28 20:34:15] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jan 28 20:34:15 rivoplus systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 28 20:34:15 rivoplus volumio5-onboarding[3470]: time=2026-01-28T20:34:15.922+13:00 level=ERROR msg="failed reading message" component=volumio/socket error="websocket: close 1006 (abnormal closure): unexpected EOF" Jan 28 20:34:15 rivoplus volumio5-onboarding[3470]: time=2026-01-28T20:34:15.924+13:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="dial tcp 127.0.0.1:3000: connect: connection refused" Jan 28 20:34:15 rivoplus systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 28 20:34:15 rivoplus systemd[1]: Started dynamicswap service. Jan 28 20:34:16 rivoplus systemd[1]: dynamicswap.service: Succeeded. Jan 28 20:34:16 rivoplus systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 28 20:34:16 rivoplus systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Jan 28 20:34:16 rivoplus systemd[1]: Started dynamicswap service. Jan 28 20:34:16 rivoplus systemd[1]: Stopped Volumio Backend Module. Jan 28 20:34:16 rivoplus systemd[1]: Started Volumio Backend Module. Jan 28 20:34:16 rivoplus systemd[1]: dynamicswap.service: Succeeded. Jan 28 20:34:16 rivoplus volumio5-onboarding[3470]: time=2026-01-28T20:34:16.927+13:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="dial tcp 127.0.0.1:3000: connect: connection refused" Jan 28 20:34:18 rivoplus volumio[13559]: info: ------------------------------------------- Jan 28 20:34:18 rivoplus volumio[13559]: info: ----- Volumio3 ---- Jan 28 20:34:18 rivoplus volumio[13559]: info: ------------------------------------------- Jan 28 20:34:18 rivoplus volumio[13559]: info: ----- System startup ---- Jan 28 20:34:18 rivoplus volumio[13559]: info: ------------------------------------------- Jan 28 20:34:19 rivoplus volumio[13559]: info: MYVOLUMIO Environment detected Jan 28 20:34:19 rivoplus volumio[13559]: info: Plugin folders cleanup Jan 28 20:34:19 rivoplus volumio[13559]: info: Scanning into folder /volumio/app/plugins/ Jan 28 20:34:19 rivoplus volumio[13559]: info: Scanning category audio_interface Jan 28 20:34:19 rivoplus volumio[13559]: info: Scanning category miscellanea Jan 28 20:34:19 rivoplus volumio[13559]: info: Scanning category music_service Jan 28 20:34:19 rivoplus volumio[13559]: info: Scanning category plugins.json Jan 28 20:34:19 rivoplus volumio[13559]: info: Scanning category system_controller Jan 28 20:34:19 rivoplus volumio[13559]: info: Scanning category user_interface Jan 28 20:34:19 rivoplus volumio[13559]: info: Scanning into folder /data/plugins/ Jan 28 20:34:19 rivoplus volumio[13559]: info: Plugin folders cleanup completed Jan 28 20:34:19 rivoplus volumio[13559]: info: ------------------------------------------- Jan 28 20:34:19 rivoplus volumio[13559]: info: ----- Core plugins startup ---- Jan 28 20:34:19 rivoplus volumio[13559]: info: ------------------------------------------- Jan 28 20:34:19 rivoplus volumio[13559]: info: Loading plugins from folder /volumio/app/plugins/ Jan 28 20:34:19 rivoplus volumio[13559]: info: Adding plugin bluetooth to MyMusic Plugins Jan 28 20:34:19 rivoplus volumio[13559]: info: Adding plugin multiroom to MyMusic Plugins Jan 28 20:34:19 rivoplus volumio[13559]: info: Adding plugin upnp to MyMusic Plugins Jan 28 20:34:19 rivoplus volumio[13559]: info: Adding plugin metavolumio to MyMusic Plugins Jan 28 20:34:19 rivoplus volumio[13559]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 28 20:34:19 rivoplus volumio[13559]: info: Adding plugin cd_controller to MyMusic Plugins Jan 28 20:34:19 rivoplus volumio[13559]: info: Adding plugin qobuzconnect to MyMusic Plugins Jan 28 20:34:19 rivoplus volumio[13559]: info: Adding plugin raat to MyMusic Plugins Jan 28 20:34:19 rivoplus volumio[13559]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 28 20:34:19 rivoplus volumio[13559]: info: Adding plugin tidalconnect to MyMusic Plugins Jan 28 20:34:19 rivoplus volumio[13559]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 28 20:34:19 rivoplus volumio[13559]: info: Loading plugins from folder /data/plugins/ Jan 28 20:34:19 rivoplus volumio[13559]: info: Loading plugin "system"... Jan 28 20:34:19 rivoplus volumio[13559]: info: Loading plugin "appearance"... Jan 28 20:34:20 rivoplus volumio-remote-updater[2851]: [2026-01-28 20:34:20] [connect] Successful connection Jan 28 20:34:20 rivoplus volumio[13559]: info: Loading plugin "network"... Jan 28 20:34:20 rivoplus volumio[13559]: info: Refreshing Cached IP Addresses Jan 28 20:34:20 rivoplus sudo[13589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 20:34:20 rivoplus sudo[13589]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:21 rivoplus volumio[13559]: info: Loading plugin "services"... Jan 28 20:34:21 rivoplus sudo[13591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 20:34:21 rivoplus sudo[13591]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:21 rivoplus volumio[13559]: info: Loading plugin "volumio5onboarding"... Jan 28 20:34:21 rivoplus sudo[13589]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:21 rivoplus volumio[13559]: info: Loading plugin "alsa_controller"... Jan 28 20:34:21 rivoplus sudo[13591]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:21 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 20:34:21 rivoplus volumio[13559]: info: Loading plugin "wizard"... Jan 28 20:34:21 rivoplus volumio[13559]: info: Loading plugin "networkfs"... Jan 28 20:34:21 rivoplus volumio[13559]: info: Cannot mount NAS The_Vault at system boot, trial number 1 ,retrying in 5 seconds Jan 28 20:34:21 rivoplus volumio[13559]: info: Starting Udev Watcher for removable devices Jan 28 20:34:21 rivoplus volumio[13559]: info: Ignoring mount for partition: BOOT Jan 28 20:34:21 rivoplus volumio[13559]: info: Ignoring mount for partition: volumio Jan 28 20:34:21 rivoplus volumio[13559]: info: Ignoring mount for partition: volumio_data Jan 28 20:34:21 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 20:34:21 rivoplus volumio[13559]: info: Loading plugin "volumio_command_line_client"... Jan 28 20:34:21 rivoplus volumio[13559]: info: Loading plugin "upnp"... Jan 28 20:34:21 rivoplus volumio[13559]: info: [1769585661315] Starting Upmpd Daemon Jan 28 20:34:21 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 20:34:21 rivoplus volumio[13559]: info: Loading plugin "my_music"... Jan 28 20:34:21 rivoplus volumio[13559]: info: Loading plugin "mpd"... Jan 28 20:34:21 rivoplus volumio[13559]: info: Loading plugin "upnp_browser"... Jan 28 20:34:22 rivoplus volumio[13559]: info: Starting UPNP Browser Jan 28 20:34:22 rivoplus volumio[13559]: info: Plugin bluetooth is not enabled Jan 28 20:34:22 rivoplus volumio[13559]: info: Loading plugin "alarm-clock"... Jan 28 20:34:22 rivoplus volumio[13559]: info: Loading plugin "manifestui"... Jan 28 20:34:22 rivoplus volumio[13559]: info: Loading plugin "metavolumio"... Jan 28 20:34:24 rivoplus volumio[13559]: info: Plugin airplay_emulation is not enabled Jan 28 20:34:24 rivoplus volumio[13559]: info: Plugin cd_controller is not enabled Jan 28 20:34:24 rivoplus volumio[13559]: info: Loading plugin "last_100"... Jan 28 20:34:24 rivoplus volumio[13559]: info: Plugin qobuzconnect is not enabled Jan 28 20:34:24 rivoplus volumio[13559]: info: Plugin raat is not enabled Jan 28 20:34:24 rivoplus volumio[13559]: info: Loading plugin "streaming_services"... Jan 28 20:34:25 rivoplus volumio[13559]: info: Starting Streaming Service Transparent Proxy Jan 28 20:34:25 rivoplus volumio[13559]: info: Plugin tidalconnect is not enabled Jan 28 20:34:25 rivoplus volumio[13559]: info: Loading plugin "webradio"... Jan 28 20:34:25 rivoplus volumio[13559]: info: Loading plugin "i2s_dacs"... Jan 28 20:34:25 rivoplus volumio[13559]: info: I2S DAC not set, start Auto-detection Jan 28 20:34:25 rivoplus volumio[13559]: info: Loading plugin "volumiodiscovery"... Jan 28 20:34:25 rivoplus volumio[13559]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 28 20:34:25 rivoplus volumio[13559]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 20:34:25 rivoplus node[13559]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 28 20:34:25 rivoplus volumio[13559]: *** WARNING *** For more information see Jan 28 20:34:25 rivoplus volumio[13559]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 28 20:34:25 rivoplus volumio[13559]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 20:34:25 rivoplus volumio[13559]: *** WARNING *** For more information see Jan 28 20:34:25 rivoplus node[13559]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 20:34:25 rivoplus node[13559]: *** WARNING *** For more information see Jan 28 20:34:25 rivoplus node[13559]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 28 20:34:25 rivoplus node[13559]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 20:34:25 rivoplus node[13559]: *** WARNING *** For more information see Jan 28 20:34:25 rivoplus volumio[13559]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 28 20:34:25 rivoplus volumio[13559]: info: Discovery: Started advertising with name: Rivoplus Jan 28 20:34:25 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 20:34:25 rivoplus volumio[13559]: info: Plugin multiroom is not enabled Jan 28 20:34:25 rivoplus volumio[13559]: info: Loading plugin "outputs"... Jan 28 20:34:25 rivoplus volumio[13559]: info: Loading plugin "albumart"... Jan 28 20:34:25 rivoplus volumio[13559]: info: Plugin example_plugin is not enabled Jan 28 20:34:25 rivoplus volumio[13559]: info: Loading plugin "hi_res_audio"... Jan 28 20:34:25 rivoplus volumio[13559]: Forking 3 albumart workers Jan 28 20:34:27 rivoplus volumio[13559]: STREAMING PROXY: Starting server on port 3245 Jan 28 20:34:27 rivoplus volumio[13559]: Node JS runtime: 14 Jan 28 20:34:27 rivoplus volumio[13559]: Starting albumart workers Jan 28 20:34:27 rivoplus volumio[13559]: Starting albumart workers Jan 28 20:34:27 rivoplus volumio[13559]: Starting albumart workers Jan 28 20:34:27 rivoplus volumio[13559]: info: Applying required configuration parameters for plugin hi_res_audio Jan 28 20:34:27 rivoplus volumio[13559]: info: Loading plugin "inputs"... Jan 28 20:34:27 rivoplus volumio5-onboarding[3470]: time=2026-01-28T20:34:27.930+13:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="read tcp 127.0.0.1:44366->127.0.0.1:3000: i/o timeout" Jan 28 20:34:28 rivoplus volumio[13559]: info: Loading plugin "qobuz"... Jan 28 20:34:29 rivoplus volumio[13559]: info: Plugin smart_inputs is not enabled Jan 28 20:34:29 rivoplus volumio[13559]: info: Loading plugin "tidal"... Jan 28 20:34:30 rivoplus volumio[13559]: info: Loading plugin "rivopluscontrol"... Jan 28 20:34:31 rivoplus volumio[13559]: info: Adding this device properties Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Jan 28 20:34:31 rivoplus volumio[13559]: info: Setting Additional Device Volumio Properties: [object Object] Jan 28 20:34:31 rivoplus volumio[13559]: info: Loading plugin "updater_comm"... Jan 28 20:34:31 rivoplus volumio[13559]: info: Loading plugin "cec_controller"... Jan 28 20:34:31 rivoplus volumio[13559]: info: Applying required configuration parameters for plugin cec_controller Jan 28 20:34:31 rivoplus volumio[13559]: info: Plugin mpdemulation is not enabled Jan 28 20:34:31 rivoplus volumio[13559]: info: Loading plugin "rest_api"... Jan 28 20:34:31 rivoplus volumio[13559]: info: Loading plugin "websocket"... Jan 28 20:34:31 rivoplus volumio[13559]: info: Starting Socket.io Server version 2.3.0 Jan 28 20:34:31 rivoplus volumio[13559]: info: Loading i18n strings for locale en Jan 28 20:34:31 rivoplus volumio[13559]: Updating browse sources language Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::initPlayerControls Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 20:34:31 rivoplus volumio[13559]: Express server listening on port 3000 Jan 28 20:34:31 rivoplus volumio[13559]: [Metrics] WebUI: 14s 235.29ms Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreStateMachine::resetVolumioState Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreStateMachine::getcurrentVolume Jan 28 20:34:31 rivoplus volumio[13559]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 20:34:32 rivoplus volumio[13559]: info: Cannot mount NAS The_Vault at system boot, trial number 2 ,retrying in 5 seconds Jan 28 20:34:32 rivoplus sudo[13709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 20:34:32 rivoplus sudo[13709]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:32 rivoplus sudo[13709]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:32 rivoplus volumio[13559]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 28 20:34:32 rivoplus sudo[13712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 20:34:32 rivoplus volumio[13559]: info: Completed loading Core Plugins Jan 28 20:34:32 rivoplus sudo[13712]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:32 rivoplus volumio[13559]: info: Preparing to generate the ALSA configuration file Jan 28 20:34:32 rivoplus sudo[13712]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:32 rivoplus volumio[13559]: info: Volumio Network Manager: Network status updated: 1 Jan 28 20:34:32 rivoplus volumio[13559]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 28 20:34:32 rivoplus volumio[13559]: verbose: New Socket.io Connection to 192.168.1.251 from 192.168.1.123 UA: Mozilla/5.0 (Linux; Android 16; SM-X620 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.192 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jan 28 20:34:32 rivoplus volumio[13559]: verbose: New Socket.io Connection to 192.168.1.251 from 192.168.1.123 UA: Mozilla/5.0 (Linux; Android 16; SM-X620 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.192 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jan 28 20:34:32 rivoplus volumio[13559]: 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: 3 Jan 28 20:34:32 rivoplus volumio[13559]: verbose: New Socket.io Connection to 192.168.1.251 from 192.168.1.123 UA: Mozilla/5.0 (Linux; Android 16; SM-X620 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.192 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 20:34:32 rivoplus volumio[13559]: info: Discovery: Getting this device information Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:32 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 20:34:32 rivoplus volumio[13559]: info: VolumeController:: Volume=100 Mute =false Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreStateMachine::pushState Jan 28 20:34:32 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreStateMachine::updateTrackBlock Jan 28 20:34:32 rivoplus volumio[13559]: info: CorePlayQueue::getTrackBlock Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 20:34:32 rivoplus volumio[13559]: info: Reloading queue from file Jan 28 20:34:32 rivoplus volumio[13559]: 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: 4 Jan 28 20:34:32 rivoplus volumio[13559]: info: Asound.conf file unchanged, so no further update is needed Jan 28 20:34:32 rivoplus volumio[13559]: info: Output device has changed, restarting MPD Jan 28 20:34:32 rivoplus volumio[13559]: info: ___________ START PLUGINS ___________ Jan 28 20:34:32 rivoplus sudo[13724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 28 20:34:32 rivoplus sudo[13724]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:32 rivoplus sudo[13724]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:32 rivoplus sudo[13726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 28 20:34:32 rivoplus sudo[13726]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:32 rivoplus systemd[1]: Stopping Music Player Daemon... Jan 28 20:34:32 rivoplus volumio[13559]: info: ControllerMpd::onStart: Initializing MPD Jan 28 20:34:32 rivoplus volumio[13559]: info: Creating MPD Configuration file Jan 28 20:34:32 rivoplus sudo[13731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Jan 28 20:34:32 rivoplus sudo[13731]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:32 rivoplus sudo[13731]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 20:34:32 rivoplus volumio[13559]: info: [1769585672856] CoreMusicLibrary::Adding element Media Servers Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:32 rivoplus sudo[13734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 28 20:34:32 rivoplus sudo[13734]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:32 rivoplus volumio[13559]: info: UPNP Browser: Client initialized successfully Jan 28 20:34:32 rivoplus sudo[13734]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:32 rivoplus sudo[13736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 28 20:34:32 rivoplus sudo[13736]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:32 rivoplus volumio[13559]: info: Adding METAVOLUMIO REST API Endpoints Jan 28 20:34:32 rivoplus volumio[13559]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jan 28 20:34:32 rivoplus volumio[13559]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jan 28 20:34:32 rivoplus volumio[13559]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jan 28 20:34:32 rivoplus volumio[13559]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 20:34:32 rivoplus volumio[13559]: info: [1769585672895] CoreMusicLibrary::Adding element Last_100 Jan 28 20:34:32 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:32 rivoplus volumio[13559]: info: Streaming services startup Jan 28 20:34:32 rivoplus volumio[13559]: info: Starting Streaming Daemon Jan 28 20:34:32 rivoplus sudo[13740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 28 20:34:32 rivoplus sudo[13740]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:32 rivoplus sudo[13740]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 20:34:33 rivoplus volumio[13559]: info: [1769585673013] CoreMusicLibrary::Adding element Webradio Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 20:34:33 rivoplus volumio[13559]: info: Initializing BBC Radios Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 20:34:33 rivoplus volumio[13559]: error: Hi Res Audio Failed Login: Missing Login Data Jan 28 20:34:33 rivoplus volumio[13559]: info: Adding HIGHRESAUDIO REST API Endpoints Jan 28 20:34:33 rivoplus volumio[13559]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 28 20:34:33 rivoplus volumio[13559]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 28 20:34:33 rivoplus volumio[13559]: info: Initializing Serial Communication on port /dev/ttyS3 Jan 28 20:34:33 rivoplus volumio[13559]: info: Touch Event Listener Process Starting Jan 28 20:34:33 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Jan 28 20:34:33 rivoplus systemd[1]: mpd.service: Succeeded. Jan 28 20:34:33 rivoplus systemd[1]: Stopped Music Player Daemon. Jan 28 20:34:33 rivoplus sudo[13759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Jan 28 20:34:33 rivoplus sudo[13759]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:33 rivoplus systemd[1]: Starting Music Player Daemon... Jan 28 20:34:33 rivoplus sudo[13759]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:33 rivoplus sudo[13772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Jan 28 20:34:33 rivoplus sudo[13772]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:33 rivoplus sudo[13772]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:33 rivoplus sudo[13775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Jan 28 20:34:33 rivoplus sudo[13775]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:33 rivoplus sudo[13775]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:33 rivoplus sudo[13762]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 28 20:34:33 rivoplus sudo[13762]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:33 rivoplus sudo[13778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Jan 28 20:34:33 rivoplus sudo[13762]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:33 rivoplus sudo[13778]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:33 rivoplus sudo[13778]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:33 rivoplus sudo[13783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Jan 28 20:34:33 rivoplus sudo[13783]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:33 rivoplus sudo[13783]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:33 rivoplus volumio[13559]: info: Apply VIM3L Onboard LEDs Settings Jan 28 20:34:33 rivoplus volumio[13559]: info: Turning On Onboard LEDs Jan 28 20:34:33 rivoplus volumio-remote-updater[2851]: [2026-01-28 20:34:33] [connect] Successful connection Jan 28 20:34:33 rivoplus sudo[13787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Jan 28 20:34:33 rivoplus sudo[13787]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:33 rivoplus volumio[13559]: info: Starting CEC Event listener Jan 28 20:34:33 rivoplus volumio[13559]: info: Volumio Calling Home Jan 28 20:34:33 rivoplus sudo[13787]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:33 rivoplus sudo[13791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Jan 28 20:34:33 rivoplus sudo[13791]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:33 rivoplus sudo[13791]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:33 rivoplus volumio[13559]: info: Stopping AccessToken refresher cron for QOBUZ Jan 28 20:34:33 rivoplus volumio[13559]: info: AccessToken refresher cron started for QOBUZ Jan 28 20:34:33 rivoplus volumio[13559]: info: Adding TIDAL REST API Endpoints Jan 28 20:34:33 rivoplus volumio[13559]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jan 28 20:34:33 rivoplus volumio[13559]: info: Adding QOBUZ REST API Endpoints Jan 28 20:34:33 rivoplus volumio[13559]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreStateMachine::setRepeat false single undefined Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreStateMachine::pushState Jan 28 20:34:33 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreStateMachine::setRandom null Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreStateMachine::pushState Jan 28 20:34:33 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 20:34:33 rivoplus volumio[13559]: info: Discovery: Getting this device information Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:33 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 20:34:33 rivoplus volumio[13559]: info: Serial port opened successfully Jan 28 20:34:33 rivoplus volumio[13559]: info: Sending serial start messages Jan 28 20:34:33 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:33 rivoplus volumio[13559]: info: Reporting MCU Network Status: 1 Jan 28 20:34:34 rivoplus volumio[13559]: 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: 4 Jan 28 20:34:34 rivoplus volumio-remote-updater[2851]: [2026-01-28 20:34:34] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1769585673 101 Jan 28 20:34:34 rivoplus volumio[13559]: 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: 4 Jan 28 20:34:34 rivoplus volumio[13559]: info: Touch Event Listener Process Closed Jan 28 20:34:34 rivoplus volumio[13559]: error: Cannot start Volumio Streaming Daemon Jan 28 20:34:34 rivoplus volumio[13559]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 28 20:34:34 rivoplus volumio[13559]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 28 20:34:34 rivoplus volumio[13559]: info: MPD Permissions set Jan 28 20:34:34 rivoplus volumio[13559]: info: MPD Permissions set Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Jan 28 20:34:34 rivoplus volumio[13559]: info: Setting Device Volume Override Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 28 20:34:34 rivoplus volumio[13559]: info: Updating Volume Controller Parameters: Device: 5 Name: S/PDIF + AES/EBU + I2S Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 28 20:34:34 rivoplus volumio[13559]: info: Disabling external Volume Control Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreStateMachine::pushState Jan 28 20:34:34 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:34 rivoplus volumio[13559]: info: VolumeController:: Volume=100 Mute =false Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreStateMachine::pushState Jan 28 20:34:34 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:34 rivoplus sudo[13806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 28 20:34:34 rivoplus sudo[13806]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Jan 28 20:34:34 rivoplus volumio[13559]: info: Setting Additional System Software info: Hardware Revision: 1.0 Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Jan 28 20:34:34 rivoplus volumio[13559]: info: Setting HW Firmware info: undefined Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Jan 28 20:34:34 rivoplus volumio[13559]: info: Setting HW Version info: 1.0 Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Jan 28 20:34:34 rivoplus volumio[13559]: info: Setting Additional System Software info: Hardware Revision: 1.0, Firmware Version: 0.3.0 Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Jan 28 20:34:34 rivoplus volumio[13559]: info: Setting HW Firmware info: 0.3.0 Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Jan 28 20:34:34 rivoplus volumio[13559]: info: Setting HW Version info: 1.0 Jan 28 20:34:34 rivoplus volumio[13559]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jan 28 20:34:34 rivoplus volumio[13559]: info: MCU Signalled Headphone Mode Disabled Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jan 28 20:34:34 rivoplus volumio[13559]: info: MCU Signalled Sleep Mode Disabled Jan 28 20:34:34 rivoplus sudo[13806]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:34 rivoplus volumio[13559]: info: Enabling Advanced system settings configuration Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Jan 28 20:34:34 rivoplus volumio[13559]: info: Additional UI Settings Added for plugin music_service/inputs Jan 28 20:34:34 rivoplus volumio[13559]: info: MCU Signalled Auto Boot Mode On Power Active Jan 28 20:34:34 rivoplus sudo[13809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Jan 28 20:34:34 rivoplus sudo[13809]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:34 rivoplus sudo[13809]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:34 rivoplus volumio[13559]: verbose: New Socket.io Connection to 192.168.1.251:3000 from 192.168.1.123 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Jan 28 20:34:34 rivoplus volumio[13559]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jan 28 20:34:34 rivoplus volumio[13559]: 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: 7 Jan 28 20:34:34 rivoplus volumio[13559]: info: Volumio called home Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:34 rivoplus volumio[13559]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Jan 28 20:34:34 rivoplus volumio[13559]: info: Discovery: adding 9610f767-4b80-410b-aa64-326adadd05b0 Jan 28 20:34:34 rivoplus volumio[13559]: info: Discovery: Found device Rivoplus Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:34 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 28 20:34:34 rivoplus volumio[13559]: 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: 7 Jan 28 20:34:34 rivoplus volumio[13559]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jan 28 20:34:34 rivoplus volumio[13559]: info: Upmpdcli Daemon Started Jan 28 20:34:34 rivoplus sudo[13825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Jan 28 20:34:34 rivoplus sudo[13825]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:34 rivoplus sudo[13825]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:34 rivoplus volumio[13559]: verbose: New Socket.io Connection to 192.168.1.251 from 192.168.1.123 UA: Mozilla/5.0 (Linux; Android 16; SM-X620 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.192 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jan 28 20:34:34 rivoplus volumio[13559]: info: VolumeController:: Volume=100 Mute =false Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreStateMachine::pushState Jan 28 20:34:34 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:34 rivoplus volumio[13559]: info: MP1 GPIO: Signalled system ready via GPIO Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 28 20:34:34 rivoplus volumio[13559]: info: Adding Inputs via Serial API Jan 28 20:34:34 rivoplus volumio[13559]: info: Adding Advanced Audio Settings via Serial API Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Jan 28 20:34:34 rivoplus volumio[13559]: info: Additional UI Settings Added for plugin music_service/inputs Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreStateMachine::pushState Jan 28 20:34:34 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:34 rivoplus volumio[13559]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:34 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::volumioGetVisibleSources Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:35 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:35 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::volumioGetQueue Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreStateMachine::getQueue Jan 28 20:34:35 rivoplus volumio[13559]: info: CorePlayQueue::getQueue Jan 28 20:34:35 rivoplus volumio[13559]: info: Listing playlists Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 28 20:34:35 rivoplus volumio[13559]: info: Received Get System Info Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 20:34:35 rivoplus volumio[13559]: info: Discovery: Getting this device information Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:35 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:35 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:35 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::servicePushState Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreStateMachine::pushState Jan 28 20:34:35 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:35 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:35 rivoplus volumio[13559]: verbose: STATE SERVICE {"status":"stop","service":"inputs","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"","seek":0,"duration":0,"samplerate":"","bitdepth":"","stream":true,"disableUiControls":false,"channels":2} Jan 28 20:34:35 rivoplus volumio[13559]: verbose: CURRENT POSITION 0 Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreStateMachine::syncState stateService stop Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreStateMachine::syncState currentStatus stop Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreStateMachine::pushState Jan 28 20:34:35 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:35 rivoplus volumio[13559]: info: No code Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreStateMachine::pushState Jan 28 20:34:35 rivoplus volumio[13559]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::volumiosetSourceActiveno-source Jan 28 20:34:35 rivoplus volumio[13559]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:35 rivoplus mpd[13782]: Jan 28 20:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 28 20:34:35 rivoplus volumio[13559]: info: MCU Signalled Playback Inactive Jan 28 20:34:35 rivoplus volumio[13559]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Rod%20Stewart/7209bea0-6bb0-4865-825b-c9df147e3cd2.jpg' Jan 28 20:34:36 rivoplus volumio[13559]: info: Turning Off Onboard LEDs Jan 28 20:34:36 rivoplus sudo[13830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Jan 28 20:34:36 rivoplus sudo[13830]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:36 rivoplus sudo[13830]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:36 rivoplus sudo[13833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Jan 28 20:34:36 rivoplus sudo[13833]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:36 rivoplus sudo[13833]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:36 rivoplus volumio[13559]: info: Onboard LEDs initialized Jan 28 20:34:36 rivoplus volumio[13559]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Jan 28 20:34:36 rivoplus volumio[13559]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 20:34:36 rivoplus volumio[13559]: Error: connect ECONNREFUSED 158.69.210.98:443 Jan 28 20:34:36 rivoplus volumio[13559]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jan 28 20:34:36 rivoplus volumio[13559]: errno: -111, Jan 28 20:34:36 rivoplus volumio[13559]: code: 'ECONNREFUSED', Jan 28 20:34:36 rivoplus volumio[13559]: syscall: 'connect', Jan 28 20:34:36 rivoplus volumio[13559]: address: '158.69.210.98', Jan 28 20:34:36 rivoplus volumio[13559]: port: 443 Jan 28 20:34:36 rivoplus volumio[13559]: } Jan 28 20:34:36 rivoplus volumio[13559]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 20:34:37 rivoplus sudo[13845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-28 20:33 Jan 28 20:34:37 rivoplus sudo[13845]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:37 rivoplus sudo[13845]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:37 rivoplus volumio5-onboarding[3470]: time=2026-01-28T20:34:37.806+13:00 level=ERROR msg="failed reading message" component=volumio/socket error="websocket: close 1006 (abnormal closure): unexpected EOF" Jan 28 20:34:37 rivoplus volumio-remote-updater[2851]: [2026-01-28 20:34:37] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jan 28 20:34:37 rivoplus volumio-remote-updater[2851]: [2026-01-28 20:34:37] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jan 28 20:34:37 rivoplus volumio5-onboarding[3470]: time=2026-01-28T20:34:37.813+13:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="read tcp 127.0.0.1:44430->127.0.0.1:3000: read: connection reset by peer" Jan 28 20:34:37 rivoplus systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 28 20:34:37 rivoplus sudo[13726]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:37 rivoplus sudo[13736]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:37 rivoplus systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 28 20:34:37 rivoplus systemd[1]: Started dynamicswap service. Jan 28 20:34:38 rivoplus systemd[1]: dynamicswap.service: Succeeded. Jan 28 20:34:38 rivoplus systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 28 20:34:38 rivoplus systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. Jan 28 20:34:38 rivoplus systemd[1]: Started dynamicswap service. Jan 28 20:34:38 rivoplus systemd[1]: Stopped Volumio Backend Module. Jan 28 20:34:38 rivoplus systemd[1]: Started Volumio Backend Module. Jan 28 20:34:38 rivoplus systemd[1]: dynamicswap.service: Succeeded. Jan 28 20:34:38 rivoplus volumio5-onboarding[3470]: time=2026-01-28T20:34:38.815+13:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="dial tcp 127.0.0.1:3000: connect: connection refused" Jan 28 20:34:39 rivoplus systemd[1]: Started Music Player Daemon. Jan 28 20:34:40 rivoplus volumio[13859]: info: ------------------------------------------- Jan 28 20:34:40 rivoplus volumio[13859]: info: ----- Volumio3 ---- Jan 28 20:34:40 rivoplus volumio[13859]: info: ------------------------------------------- Jan 28 20:34:40 rivoplus volumio[13859]: info: ----- System startup ---- Jan 28 20:34:40 rivoplus volumio[13859]: info: ------------------------------------------- Jan 28 20:34:41 rivoplus volumio[13859]: info: MYVOLUMIO Environment detected Jan 28 20:34:41 rivoplus volumio[13859]: info: Plugin folders cleanup Jan 28 20:34:41 rivoplus volumio[13859]: info: Scanning into folder /volumio/app/plugins/ Jan 28 20:34:41 rivoplus volumio[13859]: info: Scanning category audio_interface Jan 28 20:34:41 rivoplus volumio[13859]: info: Scanning category miscellanea Jan 28 20:34:41 rivoplus volumio[13859]: info: Scanning category music_service Jan 28 20:34:41 rivoplus volumio[13859]: info: Scanning category plugins.json Jan 28 20:34:41 rivoplus volumio[13859]: info: Scanning category system_controller Jan 28 20:34:41 rivoplus volumio[13859]: info: Scanning category user_interface Jan 28 20:34:41 rivoplus volumio[13859]: info: Scanning into folder /data/plugins/ Jan 28 20:34:41 rivoplus volumio[13859]: info: Plugin folders cleanup completed Jan 28 20:34:41 rivoplus volumio[13859]: info: ------------------------------------------- Jan 28 20:34:41 rivoplus volumio[13859]: info: ----- Core plugins startup ---- Jan 28 20:34:41 rivoplus volumio[13859]: info: ------------------------------------------- Jan 28 20:34:41 rivoplus volumio[13859]: info: Loading plugins from folder /volumio/app/plugins/ Jan 28 20:34:41 rivoplus volumio[13859]: info: Adding plugin bluetooth to MyMusic Plugins Jan 28 20:34:41 rivoplus volumio[13859]: info: Adding plugin multiroom to MyMusic Plugins Jan 28 20:34:41 rivoplus volumio[13859]: info: Adding plugin upnp to MyMusic Plugins Jan 28 20:34:41 rivoplus volumio[13859]: info: Adding plugin metavolumio to MyMusic Plugins Jan 28 20:34:41 rivoplus volumio[13859]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 28 20:34:41 rivoplus volumio[13859]: info: Adding plugin cd_controller to MyMusic Plugins Jan 28 20:34:41 rivoplus volumio[13859]: info: Adding plugin qobuzconnect to MyMusic Plugins Jan 28 20:34:41 rivoplus volumio[13859]: info: Adding plugin raat to MyMusic Plugins Jan 28 20:34:41 rivoplus volumio[13859]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 28 20:34:41 rivoplus volumio[13859]: info: Adding plugin tidalconnect to MyMusic Plugins Jan 28 20:34:41 rivoplus volumio[13859]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 28 20:34:41 rivoplus volumio[13859]: info: Loading plugins from folder /data/plugins/ Jan 28 20:34:41 rivoplus volumio[13859]: info: Loading plugin "system"... Jan 28 20:34:41 rivoplus volumio[13859]: info: Loading plugin "appearance"... Jan 28 20:34:42 rivoplus volumio[13859]: info: Loading plugin "network"... Jan 28 20:34:42 rivoplus volumio[13859]: info: Refreshing Cached IP Addresses Jan 28 20:34:42 rivoplus sudo[13889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 20:34:42 rivoplus sudo[13889]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:42 rivoplus sudo[13891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 20:34:42 rivoplus volumio[13859]: info: Loading plugin "services"... Jan 28 20:34:42 rivoplus sudo[13891]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:42 rivoplus volumio[13859]: info: Loading plugin "volumio5onboarding"... Jan 28 20:34:42 rivoplus sudo[13889]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:42 rivoplus sudo[13891]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:42 rivoplus volumio[13859]: info: Loading plugin "alsa_controller"... Jan 28 20:34:42 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 20:34:42 rivoplus volumio[13859]: info: Loading plugin "wizard"... Jan 28 20:34:42 rivoplus volumio[13859]: info: Loading plugin "networkfs"... Jan 28 20:34:42 rivoplus volumio[13859]: info: Cannot mount NAS The_Vault at system boot, trial number 1 ,retrying in 5 seconds Jan 28 20:34:42 rivoplus volumio[13859]: info: Starting Udev Watcher for removable devices Jan 28 20:34:42 rivoplus volumio-remote-updater[2851]: [2026-01-28 20:34:42] [connect] Successful connection Jan 28 20:34:42 rivoplus volumio[13859]: info: Ignoring mount for partition: BOOT Jan 28 20:34:42 rivoplus volumio[13859]: info: Ignoring mount for partition: volumio Jan 28 20:34:42 rivoplus volumio[13859]: info: Ignoring mount for partition: volumio_data Jan 28 20:34:42 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 20:34:42 rivoplus volumio[13859]: info: Loading plugin "volumio_command_line_client"... Jan 28 20:34:42 rivoplus volumio[13859]: info: Loading plugin "upnp"... Jan 28 20:34:42 rivoplus volumio[13859]: info: [1769585682836] Starting Upmpd Daemon Jan 28 20:34:42 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 20:34:42 rivoplus volumio[13859]: info: Loading plugin "my_music"... Jan 28 20:34:42 rivoplus volumio[13859]: info: Loading plugin "mpd"... Jan 28 20:34:43 rivoplus volumio[13859]: info: Loading plugin "upnp_browser"... Jan 28 20:34:43 rivoplus volumio[13859]: info: Starting UPNP Browser Jan 28 20:34:43 rivoplus volumio[13859]: info: Plugin bluetooth is not enabled Jan 28 20:34:43 rivoplus volumio[13859]: info: Loading plugin "alarm-clock"... Jan 28 20:34:43 rivoplus volumio[13859]: info: Loading plugin "manifestui"... Jan 28 20:34:43 rivoplus volumio[13859]: info: Loading plugin "metavolumio"... Jan 28 20:34:45 rivoplus volumio[13859]: info: Plugin airplay_emulation is not enabled Jan 28 20:34:45 rivoplus volumio[13859]: info: Plugin cd_controller is not enabled Jan 28 20:34:45 rivoplus volumio[13859]: info: Loading plugin "last_100"... Jan 28 20:34:45 rivoplus volumio[13859]: info: Plugin qobuzconnect is not enabled Jan 28 20:34:45 rivoplus volumio[13859]: info: Plugin raat is not enabled Jan 28 20:34:45 rivoplus volumio[13859]: info: Loading plugin "streaming_services"... Jan 28 20:34:46 rivoplus volumio[13859]: info: Starting Streaming Service Transparent Proxy Jan 28 20:34:46 rivoplus volumio[13859]: info: Plugin tidalconnect is not enabled Jan 28 20:34:46 rivoplus volumio[13859]: info: Loading plugin "webradio"... Jan 28 20:34:46 rivoplus volumio[13859]: info: Loading plugin "i2s_dacs"... Jan 28 20:34:46 rivoplus volumio[13859]: info: I2S DAC not set, start Auto-detection Jan 28 20:34:46 rivoplus volumio[13859]: info: Loading plugin "volumiodiscovery"... Jan 28 20:34:46 rivoplus volumio[13859]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 28 20:34:46 rivoplus volumio[13859]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 20:34:46 rivoplus node[13859]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 28 20:34:46 rivoplus volumio[13859]: *** WARNING *** For more information see Jan 28 20:34:46 rivoplus volumio[13859]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 28 20:34:46 rivoplus volumio[13859]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 20:34:46 rivoplus volumio[13859]: *** WARNING *** For more information see Jan 28 20:34:46 rivoplus node[13859]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 20:34:46 rivoplus node[13859]: *** WARNING *** For more information see Jan 28 20:34:46 rivoplus node[13859]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 28 20:34:46 rivoplus node[13859]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 28 20:34:46 rivoplus node[13859]: *** WARNING *** For more information see Jan 28 20:34:46 rivoplus volumio[13859]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 28 20:34:46 rivoplus volumio[13859]: info: Discovery: Started advertising with name: Rivoplus Jan 28 20:34:46 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 20:34:46 rivoplus volumio[13859]: info: Plugin multiroom is not enabled Jan 28 20:34:46 rivoplus volumio[13859]: info: Loading plugin "outputs"... Jan 28 20:34:46 rivoplus volumio[13859]: info: Loading plugin "albumart"... Jan 28 20:34:46 rivoplus volumio[13859]: info: Plugin example_plugin is not enabled Jan 28 20:34:46 rivoplus volumio[13859]: info: Loading plugin "hi_res_audio"... Jan 28 20:34:47 rivoplus volumio[13859]: Forking 3 albumart workers Jan 28 20:34:48 rivoplus volumio[13859]: STREAMING PROXY: Starting server on port 3245 Jan 28 20:34:48 rivoplus volumio[13859]: Node JS runtime: 14 Jan 28 20:34:48 rivoplus volumio[13859]: Starting albumart workers Jan 28 20:34:48 rivoplus volumio[13859]: info: Applying required configuration parameters for plugin hi_res_audio Jan 28 20:34:48 rivoplus volumio[13859]: info: Loading plugin "inputs"... Jan 28 20:34:48 rivoplus volumio[13859]: Starting albumart workers Jan 28 20:34:48 rivoplus volumio[13859]: Starting albumart workers Jan 28 20:34:49 rivoplus volumio[13859]: info: Loading plugin "qobuz"... Jan 28 20:34:49 rivoplus volumio5-onboarding[3470]: time=2026-01-28T20:34:49.818+13:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="read tcp 127.0.0.1:44434->127.0.0.1:3000: i/o timeout" Jan 28 20:34:50 rivoplus volumio[13859]: info: Plugin smart_inputs is not enabled Jan 28 20:34:50 rivoplus volumio[13859]: info: Loading plugin "tidal"... Jan 28 20:34:51 rivoplus volumio[13859]: info: Loading plugin "rivopluscontrol"... Jan 28 20:34:51 rivoplus volumio[13859]: info: Adding this device properties Jan 28 20:34:51 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Jan 28 20:34:51 rivoplus volumio[13859]: info: Setting Additional Device Volumio Properties: [object Object] Jan 28 20:34:51 rivoplus volumio[13859]: info: Loading plugin "updater_comm"... Jan 28 20:34:51 rivoplus volumio[13859]: info: Loading plugin "cec_controller"... Jan 28 20:34:52 rivoplus volumio[13859]: info: Applying required configuration parameters for plugin cec_controller Jan 28 20:34:52 rivoplus volumio[13859]: info: Plugin mpdemulation is not enabled Jan 28 20:34:52 rivoplus volumio[13859]: info: Loading plugin "rest_api"... Jan 28 20:34:52 rivoplus volumio[13859]: info: Loading plugin "websocket"... Jan 28 20:34:52 rivoplus volumio[13859]: info: Starting Socket.io Server version 2.3.0 Jan 28 20:34:52 rivoplus volumio[13859]: info: Loading i18n strings for locale en Jan 28 20:34:52 rivoplus volumio[13859]: Updating browse sources language Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::initPlayerControls Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: Express server listening on port 3000 Jan 28 20:34:52 rivoplus volumio[13859]: [Metrics] WebUI: 12s 537.98ms Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreStateMachine::resetVolumioState Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreStateMachine::getcurrentVolume Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: info: Cannot mount NAS The_Vault at system boot, trial number 2 ,retrying in 5 seconds Jan 28 20:34:52 rivoplus volumio[13859]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 28 20:34:52 rivoplus volumio[13859]: info: Completed loading Core Plugins Jan 28 20:34:52 rivoplus volumio[13859]: info: Preparing to generate the ALSA configuration file Jan 28 20:34:52 rivoplus volumio[13859]: info: Volumio Network Manager: Network status updated: 1 Jan 28 20:34:52 rivoplus volumio[13859]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 28 20:34:52 rivoplus volumio[13859]: verbose: New Socket.io Connection to 192.168.1.251 from 192.168.1.123 UA: Mozilla/5.0 (Linux; Android 16; SM-X620 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.192 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jan 28 20:34:52 rivoplus volumio[13859]: verbose: New Socket.io Connection to 192.168.1.251 from 192.168.1.123 UA: Mozilla/5.0 (Linux; Android 16; SM-X620 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.192 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jan 28 20:34:52 rivoplus volumio[13859]: verbose: New Socket.io Connection to 192.168.1.251 from 192.168.1.123 UA: Mozilla/5.0 (Linux; Android 16; SM-X620 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.192 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jan 28 20:34:52 rivoplus volumio[13859]: 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: 4 Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 20:34:52 rivoplus volumio[13859]: info: Discovery: Getting this device information Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:52 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 20:34:52 rivoplus volumio[13859]: info: Reloading queue from file Jan 28 20:34:52 rivoplus volumio[13859]: 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: 4 Jan 28 20:34:52 rivoplus volumio[13859]: info: VolumeController:: Volume=100 Mute =false Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreStateMachine::pushState Jan 28 20:34:52 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreStateMachine::updateTrackBlock Jan 28 20:34:52 rivoplus volumio[13859]: info: CorePlayQueue::getTrackBlock Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 20:34:52 rivoplus volumio[13859]: info: Asound.conf file unchanged, so no further update is needed Jan 28 20:34:52 rivoplus volumio[13859]: info: Output device has changed, restarting MPD Jan 28 20:34:52 rivoplus sudo[14015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 28 20:34:52 rivoplus sudo[14015]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:52 rivoplus volumio[13859]: info: ___________ START PLUGINS ___________ Jan 28 20:34:52 rivoplus sudo[14015]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:52 rivoplus sudo[14018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 28 20:34:52 rivoplus sudo[14018]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:52 rivoplus volumio[13859]: info: ControllerMpd::onStart: Initializing MPD Jan 28 20:34:52 rivoplus volumio[13859]: info: Creating MPD Configuration file Jan 28 20:34:52 rivoplus systemd[1]: Stopping Music Player Daemon... Jan 28 20:34:52 rivoplus sudo[14021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Jan 28 20:34:52 rivoplus sudo[14021]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:52 rivoplus sudo[14024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 28 20:34:52 rivoplus sudo[14024]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 20:34:52 rivoplus volumio[13859]: info: [1769585692925] CoreMusicLibrary::Adding element Media Servers Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:52 rivoplus sudo[14024]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:52 rivoplus sudo[14021]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:52 rivoplus volumio[13859]: info: UPNP Browser: Client initialized successfully Jan 28 20:34:52 rivoplus sudo[14027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 28 20:34:52 rivoplus sudo[14027]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:52 rivoplus volumio[13859]: info: Adding METAVOLUMIO REST API Endpoints Jan 28 20:34:52 rivoplus volumio[13859]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jan 28 20:34:52 rivoplus volumio[13859]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jan 28 20:34:52 rivoplus volumio[13859]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jan 28 20:34:52 rivoplus volumio[13859]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 20:34:52 rivoplus volumio[13859]: info: [1769585692973] CoreMusicLibrary::Adding element Last_100 Jan 28 20:34:52 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:52 rivoplus volumio[13859]: info: Streaming services startup Jan 28 20:34:52 rivoplus volumio[13859]: info: Starting Streaming Daemon Jan 28 20:34:53 rivoplus sudo[14030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 28 20:34:53 rivoplus sudo[14030]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:53 rivoplus sudo[14030]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 28 20:34:53 rivoplus volumio[13859]: info: [1769585693092] CoreMusicLibrary::Adding element Webradio Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 20:34:53 rivoplus volumio[13859]: info: Initializing BBC Radios Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 20:34:53 rivoplus volumio[13859]: error: Hi Res Audio Failed Login: Missing Login Data Jan 28 20:34:53 rivoplus volumio[13859]: info: Adding HIGHRESAUDIO REST API Endpoints Jan 28 20:34:53 rivoplus volumio[13859]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 28 20:34:53 rivoplus volumio[13859]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 28 20:34:53 rivoplus volumio[13859]: info: Initializing Serial Communication on port /dev/ttyS3 Jan 28 20:34:53 rivoplus systemd[1]: mpd.service: Succeeded. Jan 28 20:34:53 rivoplus systemd[1]: Stopped Music Player Daemon. Jan 28 20:34:53 rivoplus volumio[13859]: info: Touch Event Listener Process Starting Jan 28 20:34:53 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Jan 28 20:34:53 rivoplus systemd[1]: Starting Music Player Daemon... Jan 28 20:34:53 rivoplus sudo[14057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Jan 28 20:34:53 rivoplus sudo[14057]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:53 rivoplus sudo[14057]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:53 rivoplus sudo[14063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Jan 28 20:34:53 rivoplus sudo[14063]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:53 rivoplus sudo[14063]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:53 rivoplus sudo[14048]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 28 20:34:53 rivoplus sudo[14048]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:53 rivoplus sudo[14048]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:53 rivoplus sudo[14066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Jan 28 20:34:53 rivoplus sudo[14066]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:53 rivoplus sudo[14066]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:53 rivoplus sudo[14071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Jan 28 20:34:53 rivoplus sudo[14071]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:53 rivoplus sudo[14071]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:53 rivoplus sudo[14074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Jan 28 20:34:53 rivoplus sudo[14074]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:53 rivoplus sudo[14074]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:53 rivoplus volumio[13859]: info: Apply VIM3L Onboard LEDs Settings Jan 28 20:34:53 rivoplus volumio[13859]: info: Turning On Onboard LEDs Jan 28 20:34:53 rivoplus sudo[14078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Jan 28 20:34:53 rivoplus sudo[14078]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:53 rivoplus sudo[14078]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:53 rivoplus volumio[13859]: info: Starting CEC Event listener Jan 28 20:34:53 rivoplus volumio[13859]: info: Volumio Calling Home Jan 28 20:34:53 rivoplus sudo[14082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Jan 28 20:34:53 rivoplus sudo[14082]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:53 rivoplus sudo[14082]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:53 rivoplus volumio[13859]: info: Stopping AccessToken refresher cron for QOBUZ Jan 28 20:34:53 rivoplus volumio[13859]: info: AccessToken refresher cron started for QOBUZ Jan 28 20:34:53 rivoplus volumio[13859]: info: Adding TIDAL REST API Endpoints Jan 28 20:34:53 rivoplus volumio[13859]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jan 28 20:34:53 rivoplus volumio[13859]: info: Adding QOBUZ REST API Endpoints Jan 28 20:34:53 rivoplus volumio[13859]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreStateMachine::setRepeat false single undefined Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreStateMachine::pushState Jan 28 20:34:53 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreStateMachine::setRandom null Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreStateMachine::pushState Jan 28 20:34:53 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:53 rivoplus volumio[13859]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:54 rivoplus sudo[14090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 20:34:54 rivoplus sudo[14090]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:54 rivoplus volumio[13859]: info: Serial port opened successfully Jan 28 20:34:54 rivoplus volumio[13859]: info: Sending serial start messages Jan 28 20:34:54 rivoplus sudo[14090]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:54 rivoplus sudo[14093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 20:34:54 rivoplus sudo[14093]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: Reporting MCU Network Status: 1 Jan 28 20:34:54 rivoplus sudo[14093]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:54 rivoplus volumio[13859]: verbose: New Socket.io Connection to 192.168.1.251 from 192.168.1.123 UA: Mozilla/5.0 (Linux; Android 16; SM-X620 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.192 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jan 28 20:34:54 rivoplus volumio[13859]: verbose: New Socket.io Connection to 192.168.1.251:3000 from 192.168.1.123 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Jan 28 20:34:54 rivoplus volumio[13859]: 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: 6 Jan 28 20:34:54 rivoplus volumio[13859]: info: Touch Event Listener Process Closed Jan 28 20:34:54 rivoplus volumio[13859]: error: Cannot start Volumio Streaming Daemon Jan 28 20:34:54 rivoplus volumio[13859]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 28 20:34:54 rivoplus volumio[13859]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 28 20:34:54 rivoplus volumio[13859]: info: MPD Permissions set Jan 28 20:34:54 rivoplus volumio[13859]: info: MPD Permissions set Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Jan 28 20:34:54 rivoplus volumio[13859]: info: Setting Device Volume Override Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 28 20:34:54 rivoplus volumio[13859]: info: Updating Volume Controller Parameters: Device: 5 Name: S/PDIF + AES/EBU + I2S Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 28 20:34:54 rivoplus volumio[13859]: info: Disabling external Volume Control Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreStateMachine::pushState Jan 28 20:34:54 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Jan 28 20:34:54 rivoplus volumio[13859]: info: Setting Additional System Software info: Hardware Revision: 1.0 Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Jan 28 20:34:54 rivoplus volumio[13859]: info: Setting HW Firmware info: undefined Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Jan 28 20:34:54 rivoplus volumio[13859]: info: Setting HW Version info: 1.0 Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Jan 28 20:34:54 rivoplus volumio[13859]: info: Setting Additional System Software info: Hardware Revision: 1.0, Firmware Version: 0.3.0 Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Jan 28 20:34:54 rivoplus volumio[13859]: info: Setting HW Firmware info: 0.3.0 Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Jan 28 20:34:54 rivoplus volumio[13859]: info: Setting HW Version info: 1.0 Jan 28 20:34:54 rivoplus volumio[13859]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jan 28 20:34:54 rivoplus volumio[13859]: info: MCU Signalled Headphone Mode Disabled Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jan 28 20:34:54 rivoplus volumio[13859]: info: MCU Signalled Sleep Mode Disabled Jan 28 20:34:54 rivoplus volumio[13859]: info: Enabling Advanced system settings configuration Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Jan 28 20:34:54 rivoplus volumio[13859]: info: Additional UI Settings Added for plugin music_service/inputs Jan 28 20:34:54 rivoplus volumio[13859]: info: MCU Signalled Auto Boot Mode On Power Active Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::volumioGetVisibleSources Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:54 rivoplus sudo[14106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Jan 28 20:34:54 rivoplus sudo[14106]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:54 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:54 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::volumioGetQueue Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreStateMachine::getQueue Jan 28 20:34:54 rivoplus volumio[13859]: info: CorePlayQueue::getQueue Jan 28 20:34:54 rivoplus volumio[13859]: info: Listing playlists Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 28 20:34:54 rivoplus sudo[14106]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:54 rivoplus volumio[13859]: info: Received Get System Info Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 20:34:54 rivoplus volumio[13859]: info: Discovery: Getting this device information Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:54 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:54 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:54 rivoplus volumio[13859]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jan 28 20:34:54 rivoplus volumio[13859]: 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: 7 Jan 28 20:34:54 rivoplus volumio[13859]: info: VolumeController:: Volume=100 Mute =false Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreStateMachine::pushState Jan 28 20:34:54 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 20:34:54 rivoplus volumio[13859]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Jan 28 20:34:54 rivoplus volumio[13859]: info: Discovery: adding 9610f767-4b80-410b-aa64-326adadd05b0 Jan 28 20:34:54 rivoplus volumio[13859]: info: Discovery: Found device Rivoplus Jan 28 20:34:54 rivoplus volumio[13859]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:54 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:55 rivoplus volumio[13859]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jan 28 20:34:55 rivoplus volumio[13859]: info: Volumio called home Jan 28 20:34:55 rivoplus sudo[14122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Jan 28 20:34:55 rivoplus sudo[14122]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:55 rivoplus volumio[13859]: info: MP1 GPIO: Signalled system ready via GPIO Jan 28 20:34:55 rivoplus sudo[14122]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:55 rivoplus volumio[13859]: 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: 7 Jan 28 20:34:55 rivoplus volumio[13859]: info: VolumeController:: Volume=100 Mute =false Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreStateMachine::pushState Jan 28 20:34:55 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:55 rivoplus volumio[13859]: info: Adding Inputs via Serial API Jan 28 20:34:55 rivoplus volumio[13859]: info: Adding Advanced Audio Settings via Serial API Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Jan 28 20:34:55 rivoplus volumio[13859]: info: Additional UI Settings Added for plugin music_service/inputs Jan 28 20:34:55 rivoplus volumio-remote-updater[2851]: [2026-01-28 20:34:55] [connect] Successful connection Jan 28 20:34:55 rivoplus sudo[14125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 28 20:34:55 rivoplus sudo[14125]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:55 rivoplus sudo[14125]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:55 rivoplus mpd[14070]: Jan 28 20:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreStateMachine::pushState Jan 28 20:34:55 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:55 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 7 Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::servicePushState Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreStateMachine::pushState Jan 28 20:34:55 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:55 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:55 rivoplus volumio[13859]: verbose: STATE SERVICE {"status":"stop","service":"inputs","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"","seek":0,"duration":0,"samplerate":"","bitdepth":"","stream":true,"disableUiControls":false,"channels":2} Jan 28 20:34:55 rivoplus volumio[13859]: verbose: CURRENT POSITION 0 Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreStateMachine::syncState stateService stop Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreStateMachine::syncState currentStatus stop Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreStateMachine::pushState Jan 28 20:34:55 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:55 rivoplus volumio[13859]: info: No code Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreStateMachine::pushState Jan 28 20:34:55 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::volumioPushState Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::volumiosetSourceActiveno-source Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 20:34:55 rivoplus volumio[13859]: info: CoreCommandRouter::volumioGetState Jan 28 20:34:55 rivoplus volumio[13859]: info: CorePlayQueue::getTrack 0 Jan 28 20:34:55 rivoplus volumio[13859]: info: Upmpdcli Daemon Started Jan 28 20:34:55 rivoplus volumio-remote-updater[2851]: [2026-01-28 20:34:55] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1769585695 101 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 7 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:55 rivoplus volumio[13859]: info: MCU Signalled Playback Inactive Jan 28 20:34:55 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:55 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:56 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:56 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:56 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:56 rivoplus volumio[13859]: 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: 8 Jan 28 20:34:56 rivoplus volumio[13859]: info: Turning Off Onboard LEDs Jan 28 20:34:56 rivoplus sudo[14130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Jan 28 20:34:56 rivoplus sudo[14130]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:56 rivoplus sudo[14130]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:56 rivoplus sudo[14133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Jan 28 20:34:56 rivoplus sudo[14133]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 28 20:34:56 rivoplus sudo[14133]: pam_unix(sudo:session): session closed for user root Jan 28 20:34:56 rivoplus volumio[13859]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sheryl%20Crow/a497e1da-9ce0-4cdd-813e-1d17cd73e5c9.jpg' Jan 28 20:34:56 rivoplus volumio[13859]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Kate%20Bush/The%20Whole%20Story/f3b22f5b-4e45-4730-a341-3fb7368e5ee1.jpg' Jan 28 20:34:56 rivoplus volumio[13859]: info: Onboard LEDs initialized Jan 28 20:34:57 rivoplus volumio[13859]: info: Cannot mount NAS The_Vault at system boot, trial number 3 ,retrying in 5 seconds Jan 28 20:34:57 rivoplus volumio[13859]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 20:34:57 rivoplus volumio[13859]: Error: connect ECONNREFUSED 158.69.209.125:443 Jan 28 20:34:57 rivoplus volumio[13859]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jan 28 20:34:57 rivoplus volumio[13859]: errno: -111, Jan 28 20:34:57 rivoplus volumio[13859]: code: 'ECONNREFUSED', Jan 28 20:34:57 rivoplus volumio[13859]: syscall: 'connect', Jan 28 20:34:57 rivoplus volumio[13859]: address: '158.69.209.125', Jan 28 20:34:57 rivoplus volumio[13859]: port: 443 Jan 28 20:34:57 rivoplus volumio[13859]: } Jan 28 20:34:57 rivoplus volumio[13859]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 20:34:58 rivoplus sudo[14145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-28 20:33 Jan 28 20:34:58 rivoplus sudo[14145]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:47:33 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="9e8aa5d6afb5e5d87a87bafae7aa5647"