Aug 28 12:16:00 rivo volumio[3241]: info: Loading plugin "qobuz"... Aug 28 12:16:01 rivo volumio-remote-updater[2935]: [2026-08-28 12:16:01] [connect] Successful connection Aug 28 12:16:02 rivo volumio[3241]: info: Loading plugin "smart_inputs"... Aug 28 12:16:02 rivo volumio[3241]: info: Loading plugin "tidal"... Aug 28 12:16:02 rivo systemd[1]: systemd-fsckd.service: Deactivated successfully. Aug 28 12:16:03 rivo volumio[3241]: info: Loading plugin "rivocontrol"... Aug 28 12:16:04 rivo volumio[3241]: info: Adding this device properties Aug 28 12:16:04 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Aug 28 12:16:04 rivo volumio[3241]: info: Setting Additional Device Volumio Properties: [object Object] Aug 28 12:16:04 rivo volumio[3241]: info: Loading plugin "updater_comm"... Aug 28 12:16:04 rivo volumio[3241]: info: Loading plugin "cec_controller"... Aug 28 12:16:04 rivo volumio[3241]: info: Applying required configuration parameters for plugin cec_controller Aug 28 12:16:04 rivo volumio[3241]: info: Plugin mpdemulation is not enabled Aug 28 12:16:04 rivo volumio[3241]: info: Loading plugin "rest_api"... Aug 28 12:16:04 rivo volumio[3241]: info: Loading plugin "websocket"... Aug 28 12:16:04 rivo volumio[3241]: info: Starting Socket.io Server version 1.7.4 Aug 28 12:16:04 rivo volumio[3241]: info: Loading plugin "minidlna"... Aug 28 12:16:04 rivo systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Aug 28 12:16:04 rivo systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Aug 28 12:16:04 rivo systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Aug 28 12:16:04 rivo volumio[3241]: info: Applying required configuration parameters for plugin minidlna Aug 28 12:16:04 rivo upmpdcli[3681]: Could not open config: /tmp/upmpdcli.conf Aug 28 12:16:04 rivo systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 28 12:16:04 rivo systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 28 12:16:05 rivo volumio[3241]: info: Loading i18n strings for locale en Aug 28 12:16:05 rivo volumio[3241]: Updating browse sources language Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::initPlayerControls Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:05 rivo volumio[3241]: info: VolumeController:: Starting alsactl monitor Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 12:16:05 rivo volumio[3241]: Express server listening on port 3000 Aug 28 12:16:05 rivo volumio[3241]: [Metrics] WebUI: 24s 815.74ms Aug 28 12:16:05 rivo volumio[3241]: info: CoreStateMachine::resetVolumioState Aug 28 12:16:05 rivo volumio[3241]: info: CoreStateMachine::getcurrentVolume Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::volumioRetrievevolume Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 12:16:05 rivo sudo[3714]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 28 12:16:05 rivo sudo[3714]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:05 rivo volumio[3241]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Aug 28 12:16:05 rivo volumio[3241]: info: Completed loading Core Plugins Aug 28 12:16:05 rivo sudo[3716]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 28 12:16:05 rivo sudo[3716]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:05 rivo volumio[3241]: info: Preparing to generate the ALSA configuration file Aug 28 12:16:05 rivo sudo[3714]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:05 rivo sudo[3716]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:05 rivo volumio[3241]: info: Volumio Network Manager: Network status updated: 0 Aug 28 12:16:05 rivo volumio[3241]: info: MRS: Removed streaming files Aug 28 12:16:05 rivo volumio[3241]: info: MRS: volumioStreaming STOPPED Aug 28 12:16:05 rivo volumio[3241]: info: MRS: SNAPSERVER STOPPED Aug 28 12:16:05 rivo volumio[3241]: info: MRS: SNAPCLIENT STOPPED Aug 28 12:16:05 rivo volumio[3241]: info: Cannot mount NAS MJUZA_2 at system boot, trial number 1 ,retrying in 5 seconds Aug 28 12:16:05 rivo volumio[3241]: info: Cannot mount NAS MJUZA_1 at system boot, trial number 1 ,retrying in 5 seconds Aug 28 12:16:05 rivo volumio[3241]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Aug 28 12:16:05 rivo volumio[3241]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 28 12:16:05 rivo volumio[3241]: info: Reading ALSA contributions from plugins. Aug 28 12:16:05 rivo volumio[3241]: info: VolumeController:: Volume=100 Mute =false Aug 28 12:16:05 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:05 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:05 rivo volumio[3241]: info: CoreStateMachine::updateTrackBlock Aug 28 12:16:05 rivo volumio[3241]: info: CorePlayQueue::getTrackBlock Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::volumioRetrievevolume Aug 28 12:16:05 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 1 Aug 28 12:16:05 rivo volumio[3241]: info: Reloading queue from file Aug 28 12:16:05 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 2 Aug 28 12:16:05 rivo volumio[3241]: info: CoreStateMachine::setRepeat false single undefined Aug 28 12:16:05 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:05 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:05 rivo volumio[3241]: info: CoreStateMachine::setRandom null Aug 28 12:16:05 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:05 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:05 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:06 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 3 Aug 28 12:16:06 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 4 Aug 28 12:16:06 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.16 UA: Mozilla/5.0 (iPad; CPU OS 9_3_5 like Mac OS X) AppleWebKit/601.1.46 (KHTML, like Gecko) Mobile/13G36 Engine version: 3 Transport: polling Total Clients: 5 Aug 28 12:16:06 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 6 Aug 28 12:16:06 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 7 Aug 28 12:16:06 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.16 UA: Mozilla/5.0 (iPad; CPU OS 9_3_5 like Mac OS X) AppleWebKit/601.1.46 (KHTML, like Gecko) Mobile/13G36 Engine version: 3 Transport: polling Total Clients: 8 Aug 28 12:16:06 rivo volumio[3241]: info: VolumeController:: Volume=100 Mute =false Aug 28 12:16:06 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:06 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:06 rivo sudo[3731]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 28 12:16:06 rivo sudo[3731]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:06 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.16 UA: Mozilla/5.0 (iPad; CPU OS 9_3_5 like Mac OS X) AppleWebKit/601.1.46 (KHTML, like Gecko) Mobile/13G36 Engine version: 3 Transport: polling Total Clients: 9 Aug 28 12:16:06 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.16 UA: Mozilla/5.0 (iPad; CPU OS 9_3_5 like Mac OS X) AppleWebKit/601.1.46 (KHTML, like Gecko) Mobile/13G36 Engine version: 3 Transport: polling Total Clients: 10 Aug 28 12:16:06 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 11 Aug 28 12:16:06 rivo volumio[3241]: info: Asound.conf file unchanged, so no further update is needed Aug 28 12:16:06 rivo volumio[3241]: info: Output device has changed, restarting MPD Aug 28 12:16:06 rivo volumio[3241]: info: Output device has changed, restarting Shairport Sync Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 12:16:06 rivo sudo[3734]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 12:16:06 rivo sudo[3734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:06 rivo sudo[3734]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:06 rivo sudo[3736]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 12:16:06 rivo sudo[3736]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:06 rivo volumio[3241]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 28 12:16:06 rivo volumio[3241]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:06 rivo volumio[3241]: info: ___________ START PLUGINS ___________ Aug 28 12:16:06 rivo volumio[3241]: info: ControllerMpd::onStart: Initializing MPD Aug 28 12:16:06 rivo volumio[3241]: info: Creating MPD Configuration file Aug 28 12:16:06 rivo systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 28 12:16:06 rivo volumio[3241]: info: [1787912166287] CoreMusicLibrary::Adding element Media Servers Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 12:16:06 rivo systemd[1]: Starting mpd.service - Music Player Daemon... Aug 28 12:16:06 rivo sudo[3745]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Aug 28 12:16:06 rivo sudo[3745]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:06 rivo sudo[3747]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 12:16:06 rivo sudo[3747]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:06 rivo volumio[3241]: info: UPNP Browser: Client initialized successfully Aug 28 12:16:06 rivo sudo[3747]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:06 rivo sudo[3751]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 12:16:06 rivo sudo[3751]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:06 rivo volumio[3241]: info: Adding METAVOLUMIO REST API Endpoints Aug 28 12:16:06 rivo volumio[3241]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 28 12:16:06 rivo volumio[3241]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Aug 28 12:16:06 rivo volumio[3241]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Aug 28 12:16:06 rivo volumio[3241]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 12:16:06 rivo volumio[3241]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 12:16:06 rivo systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Aug 28 12:16:06 rivo sudo[3745]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:06 rivo volumio[3241]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 28 12:16:06 rivo volumio[3241]: info: Preparing CD Folders Aug 28 12:16:06 rivo volumio[3241]: info: Adding CD REST API Endpoints Aug 28 12:16:06 rivo volumio[3241]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Aug 28 12:16:06 rivo systemd[1]: mpd.service: Deactivated successfully. Aug 28 12:16:06 rivo systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 28 12:16:06 rivo volumio[3241]: info: Starting UDEV Watcher for CD Aug 28 12:16:06 rivo volumio[3241]: info: Detecting CD presence with UDEV Aug 28 12:16:06 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Aug 28 12:16:06 rivo systemd[1]: mpd.socket: Deactivated successfully. Aug 28 12:16:06 rivo systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 28 12:16:06 rivo systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 28 12:16:06 rivo systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 28 12:16:06 rivo systemd[1]: Starting mpd.service - Music Player Daemon... Aug 28 12:16:06 rivo volumio5-onboarding[3760]: time=2026-08-28T12:16:06.865+02:00 level=INFO msg="running volumio4-device-gateway" version=2a6bbeeb+CHANGES buildDate=2026-07-03T07:51:28Z Aug 28 12:16:06 rivo sudo[3764]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 28 12:16:06 rivo sudo[3764]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 28 12:16:06 rivo sudo[3775]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 28 12:16:06 rivo sudo[3764]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:11 rivo mpd[3776]: 2026-08-28T12:16:11 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 28 12:16:11 rivo volumio[3241]: warn: [cd-plugin] cdspeedctl: device or media not ready Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 28 12:16:11 rivo volumio[3241]: info: [1787912171536] CoreMusicLibrary::Adding element Last_100 Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 12:16:11 rivo volumio[3241]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Aug 28 12:16:11 rivo volumio[3241]: info: QobuzConnect: Starting Qobuz Connect socket and service Aug 28 12:16:11 rivo volumio[3241]: info: Starting RAAT Plugin Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Aug 28 12:16:11 rivo volumio[3241]: info: Additional UI Settings Added for plugin music_service/raat Aug 28 12:16:11 rivo volumio[3241]: info: Registering DSP Elements listener and retrieving current ones Aug 28 12:16:11 rivo volumio[3241]: info: Additional DSP elements updated Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:11 rivo volumio[3241]: info: Updating RAAT Signal Path Aug 28 12:16:11 rivo volumio[3241]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Aug 28 12:16:11 rivo volumio[3241]: info: Streaming services startup Aug 28 12:16:11 rivo sudo[3783]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 28 12:16:11 rivo volumio[3241]: info: Starting Streaming Daemon Aug 28 12:16:11 rivo sudo[3783]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:11 rivo sudo[3783]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:11 rivo sudo[3788]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 28 12:16:11 rivo sudo[3788]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 28 12:16:11 rivo volumio[3241]: info: [1787912171650] CoreMusicLibrary::Adding element Webradio Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 12:16:11 rivo volumio[3241]: info: Initializing BBC Radios Aug 28 12:16:11 rivo sudo[3794]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 28 12:16:11 rivo sudo[3794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:11 rivo sudo[3796]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 28 12:16:11 rivo sudo[3796]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:11 rivo sudo[3788]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 12:16:11 rivo volumio[3241]: info: [now-playing] ConfigUpdater: config is up to date. Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Aug 28 12:16:11 rivo systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Aug 28 12:16:11 rivo sudo[3794]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:11 rivo volumio[3241]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:11 rivo sudo[3796]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:11 rivo volumio[3241]: info: Adding HIGHRESAUDIO REST API Endpoints Aug 28 12:16:11 rivo volumio[3241]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Aug 28 12:16:11 rivo volumio[3241]: info: Initializing Serial Communication on port /dev/ttyS3 Aug 28 12:16:11 rivo volumio[3241]: info: Touch Event Listener Process Starting Aug 28 12:16:11 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Aug 28 12:16:11 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Aug 28 12:16:11 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 28 12:16:11 rivo volumio[3241]: info: [1787912171907] CoreMusicLibrary::Adding element QOBUZ Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 12:16:11 rivo volumio[3241]: Cannot find translation for source QOBUZ Aug 28 12:16:11 rivo volumio[3241]: info: Refreshing QOBUZ token Aug 28 12:16:11 rivo sudo[3819]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Aug 28 12:16:11 rivo sudo[3819]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:11 rivo volumio[3241]: info: Adding inputs REST Endpoints Aug 28 12:16:11 rivo volumio[3241]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Aug 28 12:16:11 rivo volumio[3241]: info: Scanning Audio Inputs Aug 28 12:16:11 rivo volumio[3241]: info: Checking against Known Cards name Aug 28 12:16:11 rivo volumio[3241]: info: Checking against Known Cards name Aug 28 12:16:11 rivo volumio[3241]: info: Checking against Known Cards name Aug 28 12:16:11 rivo volumio[3241]: info: Checking against Known Cards name Aug 28 12:16:11 rivo volumio[3241]: info: Checking against Known Cards name Aug 28 12:16:11 rivo volumio[3241]: info: Adding Server instance for streaming Aug 28 12:16:11 rivo volumio[3241]: info: Adding TIDAL to Browse Sources Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 28 12:16:11 rivo volumio[3241]: info: [1787912171983] CoreMusicLibrary::Adding element TIDAL Aug 28 12:16:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 12:16:11 rivo volumio[3241]: Cannot find translation for source QOBUZ Aug 28 12:16:11 rivo volumio[3241]: Cannot find translation for source TIDAL Aug 28 12:16:11 rivo volumio[3241]: info: Refreshing TIDAL token Aug 28 12:16:12 rivo sudo[3830]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Aug 28 12:16:12 rivo sudo[3830]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:12 rivo sudo[3830]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:12 rivo sudo[3833]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Aug 28 12:16:12 rivo sudo[3833]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:12 rivo sudo[3833]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:12 rivo sudo[3836]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Aug 28 12:16:12 rivo sudo[3836]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:12 rivo sudo[3836]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:12 rivo sudo[3839]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Aug 28 12:16:12 rivo sudo[3839]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:12 rivo sudo[3839]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:12 rivo volumio[3241]: info: Apply VIM3L Onboard LEDs Settings Aug 28 12:16:12 rivo volumio[3241]: info: Turning On Onboard LEDs Aug 28 12:16:12 rivo volumio[3241]: info: Starting CEC Event listener Aug 28 12:16:12 rivo sudo[3843]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Aug 28 12:16:12 rivo sudo[3843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:12 rivo volumio[3241]: info: Loading i18n strings for locale en Aug 28 12:16:12 rivo sudo[3843]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:12 rivo volumio[3241]: info: Volumio Calling Home Aug 28 12:16:12 rivo sudo[3847]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Aug 28 12:16:12 rivo sudo[3847]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:12 rivo sudo[3847]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:12 rivo systemd[1]: Started mpd.service - Music Player Daemon. Aug 28 12:16:12 rivo sudo[3736]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:12 rivo sudo[3751]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:12 rivo volumio[3241]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Aug 28 12:16:12 rivo volumio[3241]: (node:3241) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Aug 28 12:16:12 rivo volumio[3241]: (Use `node --trace-deprecation ...` to show where the warning was created) Aug 28 12:16:12 rivo volumio[3241]: info: [now-playing] App is listening on port 4004. Aug 28 12:16:12 rivo volumio[3241]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Aug 28 12:16:12 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.16 UA: Mozilla/5.0 (iPad; CPU OS 9_3_5 like Mac OS X) AppleWebKit/601.1.46 (KHTML, like Gecko) Mobile/13G36 Engine version: 3 Transport: polling Total Clients: 12 Aug 28 12:16:12 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 00 f0 Aug 28 12:16:12 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.16 UA: Mozilla/5.0 (iPad; CPU OS 9_3_5 like Mac OS X) AppleWebKit/601.1.46 (KHTML, like Gecko) Mobile/13G36 Engine version: 3 Transport: polling Total Clients: 13 Aug 28 12:16:12 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.16 UA: Mozilla/5.0 (iPad; CPU OS 9_3_5 like Mac OS X) AppleWebKit/601.1.46 (KHTML, like Gecko) Mobile/13G36 Engine version: 3 Transport: polling Total Clients: 14 Aug 28 12:16:12 rivo volumio[3241]: info: Serial port opened successfully Aug 28 12:16:12 rivo volumio[3241]: info: Sending serial start messages Aug 28 12:16:12 rivo sudo[3862]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.0.14:/volume2/muzika2/MJUZA /mnt/NAS/MJUZA_2 Aug 28 12:16:12 rivo sudo[3862]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:12 rivo sudo[3864]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto '192.168.0.14:/volume1/muzika1/stari D/MJUZA' /mnt/NAS/MJUZA_1 Aug 28 12:16:12 rivo sudo[3864]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:12 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:12 rivo volumio[3241]: info: Reporting MCU Network Status: 0 Aug 28 12:16:12 rivo volumio[3241]: info: MP1 GPIO: Signalled system ready via GPIO Aug 28 12:16:12 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.16 UA: Mozilla/5.0 (iPad; CPU OS 9_3_5 like Mac OS X) AppleWebKit/601.1.46 (KHTML, like Gecko) Mobile/13G36 Engine version: 3 Transport: polling Total Clients: 15 Aug 28 12:16:12 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 16 Aug 28 12:16:12 rivo systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 28 12:16:12 rivo volumio[3241]: info: minidlna: Found miniDLNA version 1.3.0 Aug 28 12:16:12 rivo volumio[3241]: info: minidlna: Starting minidlna.service Aug 28 12:16:12 rivo systemd[1]: Starting rpc-statd.service - NFS status monitor for NFSv2/3 locking.... Aug 28 12:16:13 rivo volumio[3241]: error: Cannot start Volumio Streaming Daemon Aug 28 12:16:13 rivo volumio[3241]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 28 12:16:13 rivo volumio[3241]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 28 12:16:13 rivo rpc.statd[3878]: Version 2.6.2 starting Aug 28 12:16:13 rivo volumio[3241]: info: RAAT Albumart path created successfully Aug 28 12:16:13 rivo rpc.statd[3878]: Flags: TI-RPC Aug 28 12:16:13 rivo volumio[3241]: info: MPD Permissions set Aug 28 12:16:13 rivo sudo[3877]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Aug 28 12:16:13 rivo sudo[3877]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:13 rivo systemd[1]: Started rpc-statd.service - NFS status monitor for NFSv2/3 locking.. Aug 28 12:16:13 rivo volumio[3241]: info: MPD Permissions set Aug 28 12:16:13 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 17 Aug 28 12:16:13 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 18 Aug 28 12:16:13 rivo volumio[3241]: info: Volumio called home Aug 28 12:16:13 rivo systemd[1]: Reloading. Aug 28 12:16:13 rivo volumio[3241]: error: MPD error: The expression evaluated to a falsy value: Aug 28 12:16:13 rivo volumio[3241]: assert.ok(self.idling) Aug 28 12:16:13 rivo volumio[3241]: error: The expression evaluated to a falsy value: Aug 28 12:16:13 rivo volumio[3241]: assert.ok(self.idling) Aug 28 12:16:13 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 19 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Aug 28 12:16:13 rivo volumio[3241]: info: Setting Device Volume Override Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 28 12:16:13 rivo volumio[3241]: info: Updating Volume Controller Parameters: Device: 5 Name: X-SABRE Mixer: X-SABRE Output Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 28 12:16:13 rivo volumio[3241]: info: Disabling external Volume Control Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Aug 28 12:16:13 rivo volumio[3241]: info: Setting Additional System Software info: Hardware Revision: 2.0 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Aug 28 12:16:13 rivo volumio[3241]: info: Setting HW Firmware info: undefined Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Aug 28 12:16:13 rivo volumio[3241]: info: Setting HW Version info: 2.0 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Aug 28 12:16:13 rivo volumio[3241]: info: Setting Additional System Software info: Hardware Revision: 2.0, Firmware Version: 0.3.5 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Aug 28 12:16:13 rivo volumio[3241]: info: Setting HW Firmware info: 0.3.5 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Aug 28 12:16:13 rivo volumio[3241]: info: Setting HW Version info: 2.0 Aug 28 12:16:13 rivo volumio[3241]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 28 12:16:13 rivo volumio[3241]: info: MCU Signalled Headphone Mode Disabled Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Aug 28 12:16:13 rivo volumio[3241]: info: Reporting Headphone State: false Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:16:13 rivo volumio[3241]: info: Updating RAAT Signal Path Aug 28 12:16:13 rivo volumio[3241]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Aug 28 12:16:13 rivo volumio[3241]: info: MCU Signalled Sleep Mode Disabled Aug 28 12:16:13 rivo volumio[3241]: info: Enabling Advanced system settings configuration Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Aug 28 12:16:13 rivo volumio[3241]: info: Additional UI Settings Added for plugin music_service/inputs Aug 28 12:16:13 rivo volumio[3241]: info: MCU Signalled Auto Boot Mode On Power Disabled Aug 28 12:16:13 rivo volumio[3241]: error: updateQueue error: null Aug 28 12:16:13 rivo sudo[3914]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Aug 28 12:16:13 rivo sudo[3914]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:13 rivo sudo[3914]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:13 rivo kernel: fb: osd[0] enable: 1 (Xorg) Aug 28 12:16:13 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.16 UA: Mozilla/5.0 (iPad; CPU OS 9_3_5 like Mac OS X) AppleWebKit/601.1.46 (KHTML, like Gecko) Mobile/13G36 Engine version: 3 Transport: polling Total Clients: 20 Aug 28 12:16:13 rivo volumio[3241]: info: MPD running with PID3776 Aug 28 12:16:13 rivo volumio[3241]: ,establishing connection Aug 28 12:16:13 rivo volumio[3241]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Aug 28 12:16:13 rivo volumio[3241]: info: VolumeController:: alsactl monitor closed, code: 0 Aug 28 12:16:13 rivo volumio[3241]: info: VolumeController:: Starting alsactl monitor Aug 28 12:16:13 rivo sudo[3919]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Aug 28 12:16:13 rivo sudo[3919]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:13 rivo sudo[3919]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:13 rivo volumio[3241]: info: Starting Shairport Sync Aug 28 12:16:13 rivo volumio[3241]: info: Starting Shairport Sync Aug 28 12:16:13 rivo volumio[3241]: info: Starting Shairport Sync Aug 28 12:16:13 rivo sudo[3924]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 28 12:16:13 rivo sudo[3924]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:13 rivo volumio[3241]: error: updateQueue error: null Aug 28 12:16:13 rivo sudo[3926]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 28 12:16:13 rivo sudo[3926]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:13 rivo volumio[3241]: info: VolumeController:: Volume=100 Mute =false Aug 28 12:16:13 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: info: Adding Inputs via Serial API Aug 28 12:16:13 rivo sudo[3929]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 28 12:16:13 rivo sudo[3929]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:13 rivo volumio[3241]: 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: 21 Aug 28 12:16:13 rivo volumio[3241]: 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: 21 Aug 28 12:16:13 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 00 f0 Aug 28 12:16:13 rivo volumio[3241]: info: Executing endpoint qc_getconfig Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Aug 28 12:16:13 rivo qobuz-connect[3809]: 20260828 12:16:13.939 [3809.3809] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::servicePushState Aug 28 12:16:13 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: 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} Aug 28 12:16:13 rivo volumio[3241]: verbose: CURRENT POSITION 0 Aug 28 12:16:13 rivo volumio[3241]: info: CoreStateMachine::syncState stateService stop Aug 28 12:16:13 rivo volumio[3241]: info: CoreStateMachine::syncState currentStatus stop Aug 28 12:16:13 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: info: No code Aug 28 12:16:13 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumiosetSourceActiveno-source Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 12:16:13 rivo volumio[3241]: Cannot find translation for source QOBUZ Aug 28 12:16:13 rivo volumio[3241]: Cannot find translation for source TIDAL Aug 28 12:16:13 rivo volumio[3241]: info: Received Get System Info Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 12:16:13 rivo volumio[3241]: info: Discovery: Getting this device information Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:13 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:13 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 12:16:13 rivo volumio5-onboarding[3760]: time=2026-08-28T12:16:13.995+02:00 level=INFO msg="system info for f86ae99edda56fd241971db7ab04d4e5" deviceName=Rivo deviceVariant=rivo deviceModel="Volumio Rivo" softwareVersion=4.185 Aug 28 12:16:14 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.16 UA: Mozilla/5.0 (iPad; CPU OS 9_3_5 like Mac OS X) AppleWebKit/601.1.46 (KHTML, like Gecko) Mobile/13G36 Engine version: 3 Transport: polling Total Clients: 22 Aug 28 12:16:14 rivo volumio[3241]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Aug 28 12:16:14 rivo volumio[3241]: info: QobuzConnect: QOBUZ Connect daemon connected Aug 28 12:16:14 rivo volumio5-onboarding[3760]: time=2026-08-28T12:16:14.024+02:00 level=INFO msg="bootstrapping state" hasInternet=true Aug 28 12:16:14 rivo volumio[3241]: info: Received Get System Info Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 12:16:14 rivo volumio[3241]: info: Discovery: Getting this device information Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:14 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 12:16:14 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:14 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:14 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:14 rivo qobuz-connect[3809]: 20260828 12:16:14.058 [3809.3809] INFO VolumeManager: [0xac9e8f68]: Setting new playback volume: 75 Aug 28 12:16:14 rivo qobuz-connect[3809]: 20260828 12:16:14.058 [3809.3809] INFO VolumeManager: [0xac9e8f68]: Setting new mute state: 0 Aug 28 12:16:14 rivo qobuz-connect[3809]: 20260828 12:16:14.058 [3809.3809] INFO AudioStreamManager: [0xac9e8cc0]: Setting new audio download buffer size: 1048576 Aug 28 12:16:14 rivo qobuz-connect[3809]: 20260828 12:16:14.058 [3809.3809] INFO QobuzConnect: [0xac9e9830]: Client initialized! Aug 28 12:16:14 rivo qobuz-connect[3809]: 20260828 12:16:14.058 [3809.3809] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Aug 28 12:16:14 rivo qobuz-connect[3809]: 20260828 12:16:14.073 [3809.3809] INFO LocalConfigManager: [0xac9e89e8]: Starting Local Configuration server Aug 28 12:16:14 rivo qobuz-connect[3809]: 20260828 12:16:14.073 [3809.3809] INFO SampleApp: Starting Local configuration server Aug 28 12:16:14 rivo qobuz-connect[3809]: 20260828 12:16:14.074 [3809.3809] INFO SampleApp: Connected to UNIX socket client 0xac9d3908 Aug 28 12:16:14 rivo qobuz-connect[3809]: 20260828 12:16:14.089 [3809.3809] INFO SampleApp: Playback volume changed: 75 Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:14 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::volumioGetVisibleSources Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:14 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:14 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 28 12:16:14 rivo volumio[3241]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 28 12:16:14 rivo volumio[3241]: info: Received Get System Info Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 12:16:14 rivo volumio[3241]: info: Discovery: Getting this device information Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:14 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:14 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:14 rivo volumio[3241]: info: Listing playlists Aug 28 12:16:14 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 23 Aug 28 12:16:14 rivo volumio[3241]: info: TidalConnect service stoped! Aug 28 12:16:14 rivo volumio[3241]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 28 12:16:14 rivo volumio[3241]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 28 12:16:14 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 28 12:16:14 rivo sudo[3968]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 28 12:16:14 rivo sudo[3968]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:14 rivo systemd[1]: systemd-udevd.service: bpf-firewall: Preparation of BPF allow maps failed: Invalid argument Aug 28 12:16:15 rivo volumio[3241]: info: Turning Off Onboard LEDs Aug 28 12:16:15 rivo sudo[3972]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Aug 28 12:16:15 rivo sudo[3972]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:15 rivo sudo[3972]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetVisibleSources Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetQueue Aug 28 12:16:15 rivo volumio[3241]: info: CoreStateMachine::getQueue Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getQueue Aug 28 12:16:15 rivo sudo[3975]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Aug 28 12:16:15 rivo sudo[3975]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 12:16:15 rivo volumio[3241]: info: Listing playlists Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 28 12:16:15 rivo volumio[3241]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 28 12:16:15 rivo volumio[3241]: info: Received Get System Info Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 12:16:15 rivo volumio[3241]: info: Discovery: Getting this device information Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo sudo[3975]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:15 rivo volumio[3241]: info: Onboard LEDs initialized Aug 28 12:16:15 rivo sudo[3864]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:15 rivo sudo[3862]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:15 rivo nfsrahead[3982]: setting /mnt/NAS/MJUZA_1 readahead to 128 Aug 28 12:16:15 rivo nfsrahead[3983]: setting /mnt/NAS/MJUZA_2 readahead to 128 Aug 28 12:16:15 rivo systemd[1]: Started minidlna.service - MiniDLNA lightweight DLNA/UPnP-AV server. Aug 28 12:16:15 rivo sudo[3877]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:15 rivo systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 28 12:16:15 rivo volumio[3241]: info: minidlna: systemctl start minidlna.service succeeded. Aug 28 12:16:15 rivo systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Aug 28 12:16:15 rivo sudo[3968]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:15 rivo systemd[1]: shairport-sync.service: Deactivated successfully. Aug 28 12:16:15 rivo systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 28 12:16:15 rivo systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 28 12:16:15 rivo sudo[3929]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:15 rivo sudo[3924]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:15 rivo sudo[3926]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:15 rivo volumio[3241]: info: Shairport-Sync Started Aug 28 12:16:15 rivo volumio[3241]: Error adding Membership: Error: addMembership EINVAL Aug 28 12:16:15 rivo volumio[3241]: info: Shairport-Sync Started Aug 28 12:16:15 rivo volumio[3241]: info: Shairport-Sync Started Aug 28 12:16:15 rivo volumio[3241]: info: Reporting MCU Network Status: 1 Aug 28 12:16:15 rivo volumio[3241]: info: Volumio Network Manager: Network status updated: 1 Aug 28 12:16:15 rivo volumio[3241]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.37 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 24 Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo systemd[1]: minidlna.service: Deactivated successfully. Aug 28 12:16:15 rivo volumio[3241]: info: Executing endpoint tc_getconfig Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Aug 28 12:16:15 rivo vtcs[3990]: STARTING TidalConnect services, version: 1.6.1 Aug 28 12:16:15 rivo vtcs[3990]: STARTED TidalConnect services. Aug 28 12:16:15 rivo volumio[3241]: info: Executing endpoint tc_connect Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Aug 28 12:16:15 rivo volumio[3241]: info: Connecting to TidalConnect Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::servicePushState Aug 28 12:16:15 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Aug 28 12:16:15 rivo volumio[3241]: verbose: CURRENT POSITION 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreStateMachine::syncState stateService stop Aug 28 12:16:15 rivo volumio[3241]: info: CoreStateMachine::syncState currentStatus stop Aug 28 12:16:15 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: No code Aug 28 12:16:15 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::servicePushState Aug 28 12:16:15 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Aug 28 12:16:15 rivo volumio[3241]: verbose: CURRENT POSITION 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreStateMachine::syncState stateService stop Aug 28 12:16:15 rivo volumio[3241]: info: CoreStateMachine::syncState currentStatus stop Aug 28 12:16:15 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: No code Aug 28 12:16:15 rivo volumio[3241]: info: CoreStateMachine::pushState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioPushState Aug 28 12:16:15 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:15 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:16 rivo systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Aug 28 12:16:16 rivo systemd[1]: systemd-hostnamed.service: Deactivated successfully. Aug 28 12:16:16 rivo volumio[3241]: info: CoreCommandRouter::volumioGetQueue Aug 28 12:16:16 rivo volumio[3241]: info: CoreStateMachine::getQueue Aug 28 12:16:16 rivo volumio[3241]: info: CorePlayQueue::getQueue Aug 28 12:16:16 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Aug 28 12:16:16 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Aug 28 12:16:16 rivo volumio[3241]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Aug 28 12:16:16 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Aug 28 12:16:16 rivo volumio[3241]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Aug 28 12:16:16 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Aug 28 12:16:16 rivo volumio-remote-updater[2935]: [2026-08-28 12:16:16] [connect] Successful connection Aug 28 12:16:16 rivo volumio-remote-updater[2935]: [2026-08-28 12:16:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1787912176 101 Aug 28 12:16:16 rivo volumio[3241]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 25 Aug 28 12:16:16 rivo volumio[3241]: info: MRS: Getting audio outputs on start Aug 28 12:16:16 rivo volumio[3241]: info: MRS: Requesting all other devices output Aug 28 12:16:17 rivo systemd[1]: setdatetime-helper.service: Deactivated successfully. Aug 28 12:16:17 rivo systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Aug 28 12:16:18 rivo volumio[3241]: info: TidalConnect service started! Aug 28 12:16:18 rivo kernel: fb: mem_free_work, free memory: addr:800000 Aug 28 12:16:20 rivo systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Aug 28 12:16:20 rivo systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Aug 28 12:16:20 rivo systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Aug 28 12:16:20 rivo sudo[3731]: pam_unix(sudo:session): session closed for user root Aug 28 12:16:20 rivo volumio[3241]: info: Upmpdcli Daemon Started Aug 28 12:16:21 rivo volumio[3241]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Aug 28 12:16:23 rivo volumio[3241]: info: Checking for updated MCU Firmware Aug 28 12:16:23 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 12:16:23 rivo volumio[3241]: info: Firware on device is on latest version, no need to update Aug 28 12:16:35 rivo volumio[3241]: info: Discovery: adding 03ab7cbd-71ad-4a1f-bf87-b8c8b0e4a6d1 Aug 28 12:16:35 rivo volumio[3241]: info: Discovery: Found device Rivo Aug 28 12:16:35 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:35 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:35 rivo volumio[3241]: info: MRS: Pushing multiroomSync output for this device Aug 28 12:16:35 rivo volumio[3241]: info: MRS: Pushing multiroomSync output Aug 28 12:16:35 rivo volumio[3241]: info: Adding audio output: Aug 28 12:16:35 rivo volumio[3241]: info: Adding audio output: Aug 28 12:16:36 rivo volumio[3241]: info: Discovery: this is already registered, 03ab7cbd-71ad-4a1f-bf87-b8c8b0e4a6d1 Aug 28 12:16:36 rivo volumio[3241]: info: Discovery: Found device Rivo Aug 28 12:16:36 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:36 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:42 rivo volumio[3241]: error: Hi Res Audio Failed Login: [object Object] Aug 28 12:16:42 rivo volumio[3241]: info: Access Token successfully retrieved Aug 28 12:16:42 rivo volumio[3241]: info: Stopping AccessToken refresher cron for QOBUZ Aug 28 12:16:42 rivo volumio[3241]: info: AccessToken refresher cron started for QOBUZ Aug 28 12:16:42 rivo volumio[3241]: info: Adding QOBUZ REST API Endpoints Aug 28 12:16:42 rivo volumio[3241]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 26 Aug 28 12:16:42 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 12:16:42 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 12:16:42 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 28 12:16:42 rivo volumio[3241]: error: Plugin music_service tidal failed to complete 'onStart' in a timely fashion Aug 28 12:16:42 rivo volumio[3241]: info: ------------------------------------------- Aug 28 12:16:42 rivo volumio[3241]: info: ----- MyVolumio plugins startup ---- Aug 28 12:16:42 rivo volumio[3241]: info: ------------------------------------------- Aug 28 12:16:42 rivo volumio[3241]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 28 12:16:43 rivo volumio5-onboarding[3760]: failed to bootstrap state: failed to check for software update: could not check for updates: context deadline exceeded Aug 28 12:16:44 rivo systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Aug 28 12:16:44 rivo systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Aug 28 12:16:44 rivo systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Aug 28 12:16:44 rivo systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Aug 28 12:16:44 rivo systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Aug 28 12:16:44 rivo volumio5-onboarding[4473]: time=2026-08-28T12:16:44.444+02:00 level=INFO msg="running volumio4-device-gateway" version=2a6bbeeb+CHANGES buildDate=2026-07-03T07:51:28Z Aug 28 12:16:44 rivo volumio[3241]: info: Access Token successfully retrieved Aug 28 12:16:44 rivo volumio[3241]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 27 Aug 28 12:16:46 rivo upmpdcli[4509]: writing RSA key Aug 28 12:16:47 rivo volumio[3241]: 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: 27 Aug 28 12:16:49 rivo volumio[3241]: 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: 27 Aug 28 12:16:49 rivo volumio[3241]: info: Received Get System Info Aug 28 12:16:49 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 12:16:49 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 12:16:49 rivo volumio[3241]: info: Discovery: Getting this device information Aug 28 12:16:49 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:49 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:49 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 12:16:49 rivo volumio5-onboarding[4473]: time=2026-08-28T12:16:49.689+02:00 level=INFO msg="system info for f86ae99edda56fd241971db7ab04d4e5" deviceName=Rivo deviceVariant=rivo deviceModel="Volumio Rivo" softwareVersion=4.185 Aug 28 12:16:49 rivo volumio5-onboarding[4473]: time=2026-08-28T12:16:49.707+02:00 level=INFO msg="bootstrapping state" hasInternet=true Aug 28 12:16:53 rivo volumio[3241]: info: Received Get System Info Aug 28 12:16:53 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 12:16:53 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 12:16:53 rivo volumio[3241]: info: Discovery: Getting this device information Aug 28 12:16:53 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:16:53 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:16:53 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 12:16:55 rivo volumio-remote-updater[2935]: Test mode enabled Aug 28 12:16:55 rivo volumio-remote-updater[2935]: Alpha mode disabled Aug 28 12:16:55 rivo volumio-remote-updater[2935]: Alpha legacy test mode disabled Aug 28 12:17:00 rivo volumio[3241]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 28 12:17:00 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 28 12:17:02 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 12:17:04 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 12:17:04 rivo volumio[3241]: info: MRS: Found cast device: CHSTB02-88837a1d9d2011fd891ba3df03e82fab Aug 28 12:17:04 rivo volumio[3241]: info: Adding audio output: Aug 28 12:17:04 rivo volumio[3241]: info: MRS: Found cast device: CHSTB02-2c07cb952969f3ad2bbb27b23c87610d Aug 28 12:17:04 rivo volumio[3241]: info: Adding audio output: Aug 28 12:17:04 rivo volumio[3241]: error: MyVolumio Plugin failed to start in a timely fashion Aug 28 12:17:04 rivo volumio[3241]: [Metrics] CommandRouter: 83s 362.46ms Aug 28 12:17:04 rivo volumio[3241]: info: CoreCommandRouter::volumiosetStartupVolume Aug 28 12:17:04 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:17:04 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 12:17:04 rivo volumio[3241]: info: CoreCommandRouter::Close All Modals sent Aug 28 12:17:04 rivo volumio[3241]: info: CoreCommandRouter::Close All Modals sent Aug 28 12:17:07 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 12:17:07 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 28 12:17:07 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 28 12:17:07 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 28 12:17:09 rivo volumio[3241]: info: Received Get System Info Aug 28 12:17:09 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 12:17:09 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 12:17:09 rivo volumio[3241]: info: Discovery: Getting this device information Aug 28 12:17:09 rivo volumio[3241]: info: CoreCommandRouter::volumioGetState Aug 28 12:17:09 rivo volumio[3241]: info: CorePlayQueue::getTrack 0 Aug 28 12:17:09 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 12:17:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 28 12:17:11 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 28 12:17:11 rivo volumio5-onboarding[4473]: time=2026-08-28T12:17:11.873+02:00 level=INFO msg="enabling local network discovery" Aug 28 12:17:11 rivo volumio5-onboarding[4473]: time=2026-08-28T12:17:11.874+02:00 level=INFO msg="enabling BLE discovery" Aug 28 12:17:11 rivo volumio[3241]: info: Successfully retrieved User Session From TIDAL Aug 28 12:17:12 rivo volumio[3241]: info: BOOT COMPLETED Aug 28 12:17:12 rivo volumio5-onboarding[4473]: time=2026-08-28T12:17:12.888+02:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 28 12:17:20 rivo volumio[3241]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 28 12:17:21 rivo volumio[3241]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 28 12:17:21 rivo volumio[3241]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 28 12:17:21 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 12:17:21 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 12:17:21 rivo volumio[3241]: info: Starting MyVolumio Remote Streaming Endpoints Aug 28 12:17:21 rivo volumio[3241]: info: MyVolumio login type: Token Aug 28 12:17:21 rivo volumio[3241]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 28 12:17:21 rivo volumio[3241]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json' Aug 28 12:17:21 rivo volumio[3241]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 28 Aug 28 12:17:21 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:17:21 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:17:21 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:17:21 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:17:21 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:17:21 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:17:21 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:17:21 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 12:17:21 rivo volumio[3241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 12:17:21 rivo volumio[3241]: info: Not Reporting Auto name since its the default one Aug 28 12:17:21 rivo volumio[3241]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 12:17:21 rivo volumio[3241]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Aug 28 12:17:21 rivo volumio[3241]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Aug 28 12:17:21 rivo volumio[3241]: at new NodeError (node:internal/errors:405:5) Aug 28 12:17:21 rivo volumio[3241]: at assert (node:internal/assert:14:11) Aug 28 12:17:21 rivo volumio[3241]: at internalConnectMultiple (node:net:1118:3) Aug 28 12:17:21 rivo volumio[3241]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Aug 28 12:17:21 rivo volumio[3241]: at listOnTimeout (node:internal/timers:575:11) Aug 28 12:17:21 rivo volumio[3241]: at process.processTimers (node:internal/timers:514:7) { Aug 28 12:17:21 rivo volumio[3241]: code: 'ERR_INTERNAL_ASSERTION' Aug 28 12:17:21 rivo volumio[3241]: } Aug 28 12:17:21 rivo volumio[3241]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 12:17:22 rivo sudo[4640]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-28 12:16' Aug 28 12:17:22 rivo sudo[4640]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="ad2b65e62ee66106fc9799a5d56d019303babfad" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="9938d7179e3b7c4e41f3e2d60c255985cff08fee" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 29 10:41:31 UTC 2026" VOLUMIO_VERSION="4.185" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="8dbed02e26c8684a8f81563b979083f3"